builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1484931645.6 results: success (0) buildid: 20170120072124 builduid: 09cbbd6b74274dcda28083296fd80182 revision: dc33d7851ba557007fc49819d80320f9bf9f613e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.598923) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.599422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.599721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.615127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.615533) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-20 09:00:45-- 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% 223M=0s 2017-01-20 09:00:45 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.703815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.704127) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020077 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.753524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:45.753917) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dc33d7851ba557007fc49819d80320f9bf9f613e --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 dc33d7851ba557007fc49819d80320f9bf9f613e --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=97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-20 09:00:45,997 truncating revision to first 12 chars 2017-01-20 09:00:45,997 Setting DEBUG logging. 2017-01-20 09:00:45,997 attempt 1/10 2017-01-20 09:00:45,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dc33d7851ba5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 09:00:46,492 unpacking tar archive at: mozilla-aurora-dc33d7851ba5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:46.566897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:46.567266) ========= script_repo_revision: dc33d7851ba557007fc49819d80320f9bf9f613e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:46.567669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:46.567935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 09:00:46.576346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-20 09:00:46.576723) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:00:46 INFO - MultiFileLogger online at 20170120 09:00:46 in /builds/slave/test 09:00:46 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 09:00:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:46 INFO - {'append_to_log': False, 09:00:46 INFO - 'base_work_dir': '/builds/slave/test', 09:00:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:00:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:46 INFO - 'branch': 'Mozilla-Aurora', 09:00:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:46 INFO - 'config_files': ('talos/linux_config.py',), 09:00:46 INFO - 'default_actions': ('clobber', 09:00:46 INFO - 'read-buildbot-config', 09:00:46 INFO - 'download-and-extract', 09:00:46 INFO - 'populate-webroot', 09:00:46 INFO - 'create-virtualenv', 09:00:46 INFO - 'install', 09:00:46 INFO - 'run-tests'), 09:00:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:46 INFO - 'download_minidump_stackwalk': True, 09:00:46 INFO - 'download_symbols': 'ondemand', 09:00:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:46 INFO - 'installer_path': 'installer.exe', 09:00:46 INFO - 'log_level': 'info', 09:00:46 INFO - 'log_name': 'talos', 09:00:46 INFO - 'log_to_console': True, 09:00:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:00:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:00:46 INFO - 'opt_config_files': (), 09:00:46 INFO - 'pip_index': False, 09:00:46 INFO - 'sps_profile': False, 09:00:46 INFO - 'sps_profile_interval': 0, 09:00:46 INFO - 'suite': 'dromaeojs', 09:00:46 INFO - 'system_bits': '32', 09:00:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:46 INFO - 'title': 'talos-linux64-ix-068', 09:00:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:46 INFO - 'use_talos_json': True, 09:00:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:46 INFO - 'work_dir': 'build'} 09:00:46 INFO - [mozharness: 2017-01-20 17:00:46.909400Z] Running clobber step. 09:00:46 INFO - Running pre-action listener: _resource_record_pre_action 09:00:46 INFO - Running main action method: clobber 09:00:46 INFO - rmtree: /builds/slave/test/build 09:00:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:47 INFO - Running post-action listener: _resource_record_post_action 09:00:47 INFO - [mozharness: 2017-01-20 17:00:47.362373Z] Finished clobber step (success) 09:00:47 INFO - [mozharness: 2017-01-20 17:00:47.362473Z] Running read-buildbot-config step. 09:00:47 INFO - Running pre-action listener: _resource_record_pre_action 09:00:47 INFO - Running main action method: read_buildbot_config 09:00:47 INFO - Using buildbot properties: 09:00:47 INFO - { 09:00:47 INFO - "project": "", 09:00:47 INFO - "product": "firefox", 09:00:47 INFO - "script_repo_revision": "production", 09:00:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:00:47 INFO - "repository": "", 09:00:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:00:47 INFO - "buildid": "20170120072124", 09:00:47 INFO - "pgo_build": "True", 09:00:47 INFO - "basedir": "/builds/slave/test", 09:00:47 INFO - "buildnumber": 1020, 09:00:47 INFO - "slavename": "talos-linux64-ix-068", 09:00:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:00:47 INFO - "platform": "ubuntu64_hw", 09:00:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:00:47 INFO - "branch": "mozilla-aurora", 09:00:47 INFO - "repo_path": "releases/mozilla-aurora", 09:00:47 INFO - "revision": "dc33d7851ba557007fc49819d80320f9bf9f613e", 09:00:47 INFO - "stage_platform": "linux64-pgo", 09:00:47 INFO - "builduid": "09cbbd6b74274dcda28083296fd80182", 09:00:47 INFO - "slavebuilddir": "test" 09:00:47 INFO - } 09:00:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:00:47 INFO - Running post-action listener: _resource_record_post_action 09:00:47 INFO - [mozharness: 2017-01-20 17:00:47.364879Z] Finished read-buildbot-config step (success) 09:00:47 INFO - [mozharness: 2017-01-20 17:00:47.365136Z] Running download-and-extract step. 09:00:47 INFO - Running pre-action listener: _resource_record_pre_action 09:00:47 INFO - Running main action method: download_and_extract 09:00:47 INFO - mkdir: /builds/slave/test/build/tests 09:00:47 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')]} 09:00:47 INFO - trying https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:00:47 INFO - Downloading https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/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 09:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/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 09:00:47 INFO - Downloaded 1361 bytes. 09:00:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:00:47 INFO - Using the following test package requirements: 09:00:47 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:47 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:00:47 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:00:47 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'jsshell-linux-x86_64.zip'], 09:00:47 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:00:47 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:47 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:00:47 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:00:47 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:00:47 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:00:47 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:00:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:00:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:00:47 INFO - Fetch https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:00:48 INFO - Http code: 200 09:00:48 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 09:00:48 INFO - x-amz-cf-id: cBf2f1y83-HJ4fD-Y3SwsA5sjuux9HD4ht9ZltO1k8PCbQ5avs2TLg== 09:00:48 INFO - x-amz-version-id: NaltGCabIsFrAjoG4lQDfjxA5daYf3dY 09:00:48 INFO - Expected file size: 21948982 09:00:48 INFO - Obtained file size: 21948982 09:00:52 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 09:00:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:00:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:00:52 INFO - Fetch https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:00:53 INFO - Http code: 200 09:00:53 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 09:00:53 INFO - x-amz-cf-id: 0ejh8qkNQvfB_ZpNuY9McwTDudw_oZFxnLVLp2Zl2RRhKQhrmOus3Q== 09:00:53 INFO - x-amz-version-id: NaltGCabIsFrAjoG4lQDfjxA5daYf3dY 09:00:53 INFO - Expected file size: 21948982 09:00:53 INFO - Obtained file size: 21948982 09:00:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:00:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:00:57 INFO - Fetch https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:00:58 INFO - Http code: 200 09:00:58 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 09:00:58 INFO - x-amz-cf-id: n1t-5cW1mpkBi7Kp7o0xTz5bzc4X9wd1M-tPM1M9NlhOTkm2rt8PcA== 09:00:58 INFO - x-amz-version-id: _An9NQqaxzrkVlRVFe4OhvpkfZ19lFk. 09:00:58 INFO - Expected file size: 14409038 09:00:58 INFO - Obtained file size: 14409038 09:00:59 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')]} 09:00:59 INFO - trying https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:00:59 INFO - Downloading https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/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 09:00:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/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 09:01:00 INFO - Downloaded 64163601 bytes. 09:01:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:01:00 INFO - mkdir: /builds/slave/test/properties 09:01:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:00 INFO - Contents: 09:01:00 INFO - build_url:https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:01:01 INFO - Running post-action listener: _resource_record_post_action 09:01:01 INFO - Running post-action listener: set_extra_try_arguments 09:01:01 INFO - [mozharness: 2017-01-20 17:01:01.361563Z] Finished download-and-extract step (success) 09:01:01 INFO - [mozharness: 2017-01-20 17:01:01.361789Z] Running populate-webroot step. 09:01:01 INFO - Running pre-action listener: _resource_record_pre_action 09:01:01 INFO - Running main action method: populate_webroot 09:01:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:01 INFO - '--tppagecycles', 09:01:01 INFO - '7'], 09:01:01 INFO - 'tests': ['tsvgm']}}, 09:01:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['damp', 'tps']}, 09:01:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'tests': ['damp', 'tps']}, 09:01:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['dromaeo_dom']}, 09:01:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['basic_compositor_video']}, 09:01:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:01:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tsvgx', 09:01:01 INFO - 'tsvgr_opacity', 09:01:01 INFO - 'tart', 09:01:01 INFO - 'tscrollx', 09:01:01 INFO - 'cart']}, 09:01:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:01 INFO - 'tsvgr_opacity', 09:01:01 INFO - 'tart', 09:01:01 INFO - 'tscrollx', 09:01:01 INFO - 'cart']}, 09:01:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tp5o']}, 09:01:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'tests': ['tp5o']}, 09:01:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s', 09:01:01 INFO - '--xperf_path', 09:01:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:01 INFO - 'tests': ['tp5n']}, 09:01:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--xperf_path', 09:01:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:01 INFO - 'tests': ['tp5n']}}, 09:01:01 INFO - 'talos.zip': {'path': '', 09:01:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:01 INFO - Running post-action listener: _resource_record_post_action 09:01:01 INFO - [mozharness: 2017-01-20 17:01:01.377135Z] Finished populate-webroot step (success) 09:01:01 INFO - [mozharness: 2017-01-20 17:01:01.377223Z] Running create-virtualenv step. 09:01:01 INFO - Running pre-action listener: _resource_record_pre_action 09:01:01 INFO - Running main action method: create_virtualenv 09:01:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:01 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 09:01:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:01 INFO - Using real prefix '/usr' 09:01:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:03 INFO - Installing pip.................done. 09:01:03 INFO - Return code: 0 09:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:01:04 INFO - Reading from file tmpfile_stdout 09:01:04 INFO - Output received: 09:01:04 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) 09:01:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:04 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')]} 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 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')]} 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:04 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 09:01:04 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 09:01:04 INFO - Using env: {'DISPLAY': ':0', 09:01:04 INFO - 'HOME': '/home/cltbld', 09:01:04 INFO - 'LANG': 'en_US.UTF-8', 09:01:04 INFO - 'LANGUAGE': 'en_US:en', 09:01:04 INFO - 'LOGNAME': 'cltbld', 09:01:04 INFO - 'MAIL': '/var/mail/cltbld', 09:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:04 INFO - 'MOZ_NO_REMOTE': '1', 09:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:04 INFO - 'NO_EM_RESTART': '1', 09:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:04 INFO - 'PWD': '/builds/slave/test', 09:01:04 INFO - 'SHELL': '/bin/bash', 09:01:04 INFO - 'SHLVL': '1', 09:01:04 INFO - 'TERM': 'linux', 09:01:04 INFO - 'TMOUT': '86400', 09:01:04 INFO - 'USER': 'cltbld', 09:01:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:04 INFO - '_': '/tools/buildbot/bin/python'} 09:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:04 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 09:01:04 INFO - Cleaning up... 09:01:04 INFO - Return code: 0 09:01:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:01:04 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')]} 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 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')]} 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:04 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 09:01:04 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 09:01:04 INFO - Using env: {'DISPLAY': ':0', 09:01:04 INFO - 'HOME': '/home/cltbld', 09:01:04 INFO - 'LANG': 'en_US.UTF-8', 09:01:04 INFO - 'LANGUAGE': 'en_US:en', 09:01:04 INFO - 'LOGNAME': 'cltbld', 09:01:04 INFO - 'MAIL': '/var/mail/cltbld', 09:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:04 INFO - 'MOZ_NO_REMOTE': '1', 09:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:04 INFO - 'NO_EM_RESTART': '1', 09:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:04 INFO - 'PWD': '/builds/slave/test', 09:01:04 INFO - 'SHELL': '/bin/bash', 09:01:04 INFO - 'SHLVL': '1', 09:01:04 INFO - 'TERM': 'linux', 09:01:04 INFO - 'TMOUT': '86400', 09:01:04 INFO - 'USER': 'cltbld', 09:01:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:04 INFO - '_': '/tools/buildbot/bin/python'} 09:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:04 INFO - Downloading/unpacking psutil>=3.1.1 09:01:04 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 09:01:04 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 09:01:04 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 09:01:04 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 09:01:04 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 09:01:04 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 09:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:06 INFO - Installing collected packages: psutil 09:01:06 INFO - Running setup.py install for psutil 09:01:06 INFO - building 'psutil._psutil_linux' extension 09:01:06 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 09:01:06 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 09:01:06 INFO - building 'psutil._psutil_posix' extension 09:01:07 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 09:01:07 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 09:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:07 INFO - Successfully installed psutil 09:01:07 INFO - Cleaning up... 09:01:07 INFO - Return code: 0 09:01:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:01:07 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')]} 09:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:07 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')]} 09:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:07 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:07 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 09:01:07 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 09:01:07 INFO - Using env: {'DISPLAY': ':0', 09:01:07 INFO - 'HOME': '/home/cltbld', 09:01:07 INFO - 'LANG': 'en_US.UTF-8', 09:01:07 INFO - 'LANGUAGE': 'en_US:en', 09:01:07 INFO - 'LOGNAME': 'cltbld', 09:01:07 INFO - 'MAIL': '/var/mail/cltbld', 09:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:07 INFO - 'MOZ_NO_REMOTE': '1', 09:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:07 INFO - 'NO_EM_RESTART': '1', 09:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:07 INFO - 'PWD': '/builds/slave/test', 09:01:07 INFO - 'SHELL': '/bin/bash', 09:01:07 INFO - 'SHLVL': '1', 09:01:07 INFO - 'TERM': 'linux', 09:01:07 INFO - 'TMOUT': '86400', 09:01:07 INFO - 'USER': 'cltbld', 09:01:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:07 INFO - '_': '/tools/buildbot/bin/python'} 09:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:01:07 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 09:01:07 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 09:01:07 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 09:01:07 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 09:01:07 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 09:01:07 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 09:01:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:01:09 INFO - Installing collected packages: mozsystemmonitor 09:01:09 INFO - Running setup.py install for mozsystemmonitor 09:01:09 INFO - Successfully installed mozsystemmonitor 09:01:09 INFO - Cleaning up... 09:01:09 INFO - Return code: 0 09:01:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:09 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:09 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 09:01:09 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 09:01:09 INFO - Using env: {'DISPLAY': ':0', 09:01:09 INFO - 'HOME': '/home/cltbld', 09:01:09 INFO - 'LANG': 'en_US.UTF-8', 09:01:09 INFO - 'LANGUAGE': 'en_US:en', 09:01:09 INFO - 'LOGNAME': 'cltbld', 09:01:09 INFO - 'MAIL': '/var/mail/cltbld', 09:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:09 INFO - 'MOZ_NO_REMOTE': '1', 09:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:09 INFO - 'NO_EM_RESTART': '1', 09:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:09 INFO - 'PWD': '/builds/slave/test', 09:01:09 INFO - 'SHELL': '/bin/bash', 09:01:09 INFO - 'SHLVL': '1', 09:01:09 INFO - 'TERM': 'linux', 09:01:09 INFO - 'TMOUT': '86400', 09:01:09 INFO - 'USER': 'cltbld', 09:01:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:09 INFO - '_': '/tools/buildbot/bin/python'} 09:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:09 INFO - Downloading/unpacking jsonschema==2.5.1 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:01:11 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 09:01:11 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 09:01:11 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 09:01:11 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 09:01:11 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 09:01:11 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 09:01:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:12 INFO - warning: no files found matching '*.txt' 09:01:12 INFO - no previously-included directories found matching 'build' 09:01:12 INFO - no previously-included directories found matching 'dist' 09:01:12 INFO - no previously-included directories found matching '.git*' 09:01:12 INFO - Installing collected packages: jsonschema, functools32 09:01:12 INFO - Running setup.py install for functools32 09:01:12 INFO - warning: no files found matching '*.txt' 09:01:12 INFO - no previously-included directories found matching 'build' 09:01:12 INFO - no previously-included directories found matching 'dist' 09:01:12 INFO - no previously-included directories found matching '.git*' 09:01:12 INFO - Successfully installed jsonschema functools32 09:01:12 INFO - Cleaning up... 09:01:12 INFO - Return code: 0 09:01:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:01:12 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')]} 09:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:12 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')]} 09:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:12 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:12 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 09:01:12 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 09:01:12 INFO - Using env: {'DISPLAY': ':0', 09:01:12 INFO - 'HOME': '/home/cltbld', 09:01:12 INFO - 'LANG': 'en_US.UTF-8', 09:01:12 INFO - 'LANGUAGE': 'en_US:en', 09:01:12 INFO - 'LOGNAME': 'cltbld', 09:01:12 INFO - 'MAIL': '/var/mail/cltbld', 09:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:12 INFO - 'MOZ_NO_REMOTE': '1', 09:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:12 INFO - 'NO_EM_RESTART': '1', 09:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:12 INFO - 'PWD': '/builds/slave/test', 09:01:12 INFO - 'SHELL': '/bin/bash', 09:01:12 INFO - 'SHLVL': '1', 09:01:12 INFO - 'TERM': 'linux', 09:01:12 INFO - 'TMOUT': '86400', 09:01:12 INFO - 'USER': 'cltbld', 09:01:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:12 INFO - '_': '/tools/buildbot/bin/python'} 09:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:01:12 INFO - Cleaning up... 09:01:12 INFO - Return code: 0 09:01:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01:12 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')]} 09:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:12 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')]} 09:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:12 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:12 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 09:01:12 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 09:01:12 INFO - Using env: {'DISPLAY': ':0', 09:01:12 INFO - 'HOME': '/home/cltbld', 09:01:12 INFO - 'LANG': 'en_US.UTF-8', 09:01:12 INFO - 'LANGUAGE': 'en_US:en', 09:01:12 INFO - 'LOGNAME': 'cltbld', 09:01:12 INFO - 'MAIL': '/var/mail/cltbld', 09:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:12 INFO - 'MOZ_NO_REMOTE': '1', 09:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:12 INFO - 'NO_EM_RESTART': '1', 09:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:12 INFO - 'PWD': '/builds/slave/test', 09:01:12 INFO - 'SHELL': '/bin/bash', 09:01:12 INFO - 'SHLVL': '1', 09:01:12 INFO - 'TERM': 'linux', 09:01:12 INFO - 'TMOUT': '86400', 09:01:12 INFO - 'USER': 'cltbld', 09:01:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:12 INFO - '_': '/tools/buildbot/bin/python'} 09:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:01:12 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 09:01:12 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 09:01:12 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 09:01:12 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 09:01:12 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 09:01:12 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 09:01:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:14 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 09:01:14 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 09:01:14 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 09:01:14 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 09:01:14 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 09:01:14 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 09:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01:15 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 09:01:15 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 09:01:15 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 09:01:15 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 09:01:15 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 09:01:15 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 09:01:15 INFO - Downloading docopt-0.6.1.tar.gz 09:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:15 INFO - Running setup.py install for blobuploader 09:01:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:15 INFO - Running setup.py install for requests 09:01:16 INFO - Running setup.py install for docopt 09:01:16 INFO - Successfully installed blobuploader requests docopt 09:01:16 INFO - Cleaning up... 09:01:16 INFO - Return code: 0 09:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:16 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:16 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 09:01:16 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 09:01:16 INFO - Using env: {'DISPLAY': ':0', 09:01:16 INFO - 'HOME': '/home/cltbld', 09:01:16 INFO - 'LANG': 'en_US.UTF-8', 09:01:16 INFO - 'LANGUAGE': 'en_US:en', 09:01:16 INFO - 'LOGNAME': 'cltbld', 09:01:16 INFO - 'MAIL': '/var/mail/cltbld', 09:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:16 INFO - 'MOZ_NO_REMOTE': '1', 09:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:16 INFO - 'NO_EM_RESTART': '1', 09:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:16 INFO - 'PWD': '/builds/slave/test', 09:01:16 INFO - 'SHELL': '/bin/bash', 09:01:16 INFO - 'SHLVL': '1', 09:01:16 INFO - 'TERM': 'linux', 09:01:16 INFO - 'TMOUT': '86400', 09:01:16 INFO - 'USER': 'cltbld', 09:01:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:16 INFO - '_': '/tools/buildbot/bin/python'} 09:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:16 INFO - Running setup.py (path:/tmp/pip-oEWYI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:16 INFO - Running setup.py (path:/tmp/pip-ulGE8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:16 INFO - Running setup.py (path:/tmp/pip-AcVQL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:16 INFO - Running setup.py (path:/tmp/pip-uX_7dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:16 INFO - Running setup.py (path:/tmp/pip-3kmtMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:16 INFO - Running setup.py (path:/tmp/pip-SKPKNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:16 INFO - Running setup.py (path:/tmp/pip-vEqQDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:16 INFO - Running setup.py (path:/tmp/pip-UW3Mrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:17 INFO - Running setup.py (path:/tmp/pip-z6gwxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:17 INFO - Running setup.py (path:/tmp/pip-3Y7G1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:17 INFO - Running setup.py (path:/tmp/pip-NApAta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:17 INFO - Running setup.py (path:/tmp/pip-zbjRmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:17 INFO - Running setup.py (path:/tmp/pip-Of_TMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:17 INFO - Running setup.py (path:/tmp/pip-4gmyC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:17 INFO - Running setup.py (path:/tmp/pip-iIy5e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:17 INFO - Running setup.py (path:/tmp/pip-nWli2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:17 INFO - Running setup.py (path:/tmp/pip-uuUjIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:17 INFO - Running setup.py install for manifestparser 09:01:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:17 INFO - Running setup.py install for mozcrash 09:01:17 INFO - Running setup.py install for mozdebug 09:01:18 INFO - Running setup.py install for mozdevice 09:01:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Running setup.py install for mozfile 09:01:18 INFO - Running setup.py install for mozhttpd 09:01:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Running setup.py install for mozinfo 09:01:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Running setup.py install for mozInstall 09:01:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Running setup.py install for mozleak 09:01:18 INFO - Running setup.py install for mozlog 09:01:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Running setup.py install for moznetwork 09:01:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:18 INFO - Running setup.py install for mozprocess 09:01:18 INFO - Running setup.py install for mozprofile 09:01:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:19 INFO - Running setup.py install for mozrunner 09:01:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:19 INFO - Running setup.py install for mozscreenshot 09:01:19 INFO - Running setup.py install for moztest 09:01:19 INFO - Running setup.py install for mozversion 09:01:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:19 INFO - Cleaning up... 09:01:19 INFO - Return code: 0 09:01:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:19 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:19 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 09:01:19 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 09:01:19 INFO - Using env: {'DISPLAY': ':0', 09:01:19 INFO - 'HOME': '/home/cltbld', 09:01:19 INFO - 'LANG': 'en_US.UTF-8', 09:01:19 INFO - 'LANGUAGE': 'en_US:en', 09:01:19 INFO - 'LOGNAME': 'cltbld', 09:01:19 INFO - 'MAIL': '/var/mail/cltbld', 09:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:19 INFO - 'MOZ_NO_REMOTE': '1', 09:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:19 INFO - 'NO_EM_RESTART': '1', 09:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:19 INFO - 'PWD': '/builds/slave/test', 09:01:19 INFO - 'SHELL': '/bin/bash', 09:01:19 INFO - 'SHLVL': '1', 09:01:19 INFO - 'TERM': 'linux', 09:01:19 INFO - 'TMOUT': '86400', 09:01:19 INFO - 'USER': 'cltbld', 09:01:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:19 INFO - '_': '/tools/buildbot/bin/python'} 09:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:19 INFO - Running setup.py (path:/tmp/pip-ytHrWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:19 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)) 09:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:19 INFO - Running setup.py (path:/tmp/pip-8lUAiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:20 INFO - Running setup.py (path:/tmp/pip-xH4iMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:20 INFO - Running setup.py (path:/tmp/pip-s35RKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:20 INFO - Running setup.py (path:/tmp/pip-271Fii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:20 INFO - Running setup.py (path:/tmp/pip-trYUCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:20 INFO - Running setup.py (path:/tmp/pip-x2WNOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:20 INFO - Running setup.py (path:/tmp/pip-I02OUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:20 INFO - Running setup.py (path:/tmp/pip-OCoFX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:20 INFO - Running setup.py (path:/tmp/pip-zwoIw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:20 INFO - Running setup.py (path:/tmp/pip-rGBe9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:20 INFO - Running setup.py (path:/tmp/pip-71Bw6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:20 INFO - Running setup.py (path:/tmp/pip-eITaDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:20 INFO - Running setup.py (path:/tmp/pip-zGQytG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:20 INFO - Running setup.py (path:/tmp/pip-1TQvQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:20 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)) 09:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:20 INFO - Running setup.py (path:/tmp/pip-EMjcv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:21 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)) 09:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:21 INFO - Running setup.py (path:/tmp/pip-k1LtvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:21 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)) 09:01:21 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)) 09:01:21 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)) 09:01:21 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)) 09:01:21 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)) 09:01:21 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)) 09:01:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:21 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 09:01:21 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 09:01:21 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 09:01:21 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 09:01:21 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 09:01:21 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 09:01:23 INFO - Downloading blessings-1.6.tar.gz 09:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:23 INFO - Installing collected packages: blessings 09:01:23 INFO - Running setup.py install for blessings 09:01:23 INFO - Successfully installed blessings 09:01:23 INFO - Cleaning up... 09:01:23 INFO - Return code: 0 09:01:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:23 INFO - Reading from file tmpfile_stdout 09:01:23 INFO - Current package versions: 09:01:23 INFO - argparse == 1.2.1 09:01:23 INFO - blessings == 1.6 09:01:23 INFO - blobuploader == 1.2.4 09:01:23 INFO - docopt == 0.6.1 09:01:23 INFO - functools32 == 3.2.3-2 09:01:23 INFO - jsonschema == 2.5.1 09:01:23 INFO - manifestparser == 1.1 09:01:23 INFO - mozInstall == 1.12 09:01:23 INFO - mozcrash == 1.0 09:01:23 INFO - mozdebug == 0.1 09:01:23 INFO - mozdevice == 0.48 09:01:23 INFO - mozfile == 1.2 09:01:23 INFO - mozhttpd == 0.7 09:01:23 INFO - mozinfo == 0.9 09:01:23 INFO - mozleak == 0.1 09:01:23 INFO - mozlog == 3.4 09:01:23 INFO - moznetwork == 0.27 09:01:23 INFO - mozprocess == 0.23 09:01:23 INFO - mozprofile == 0.28 09:01:23 INFO - mozrunner == 6.13 09:01:23 INFO - mozscreenshot == 0.1 09:01:23 INFO - mozsystemmonitor == 0.3 09:01:23 INFO - moztest == 0.8 09:01:23 INFO - mozversion == 1.4 09:01:23 INFO - psutil == 3.1.1 09:01:23 INFO - requests == 1.2.3 09:01:23 INFO - wsgiref == 0.1.2 09:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:23 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 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:23 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 09:01:23 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 09:01:23 INFO - Using env: {'DISPLAY': ':0', 09:01:23 INFO - 'HOME': '/home/cltbld', 09:01:23 INFO - 'LANG': 'en_US.UTF-8', 09:01:23 INFO - 'LANGUAGE': 'en_US:en', 09:01:23 INFO - 'LOGNAME': 'cltbld', 09:01:23 INFO - 'MAIL': '/var/mail/cltbld', 09:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:23 INFO - 'MOZ_NO_REMOTE': '1', 09:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:23 INFO - 'NO_EM_RESTART': '1', 09:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:23 INFO - 'PWD': '/builds/slave/test', 09:01:23 INFO - 'SHELL': '/bin/bash', 09:01:23 INFO - 'SHLVL': '1', 09:01:23 INFO - 'TERM': 'linux', 09:01:23 INFO - 'TMOUT': '86400', 09:01:23 INFO - 'USER': 'cltbld', 09:01:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:23 INFO - '_': '/tools/buildbot/bin/python'} 09:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 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)) 09:01:23 INFO - Cleaning up... 09:01:23 INFO - Return code: 0 09:01:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feab5e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', '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 09:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:01:23 INFO - Using env: {'DISPLAY': ':0', 09:01:23 INFO - 'HOME': '/home/cltbld', 09:01:23 INFO - 'LANG': 'en_US.UTF-8', 09:01:23 INFO - 'LANGUAGE': 'en_US:en', 09:01:23 INFO - 'LOGNAME': 'cltbld', 09:01:23 INFO - 'MAIL': '/var/mail/cltbld', 09:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:23 INFO - 'MOZ_NO_REMOTE': '1', 09:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:23 INFO - 'NO_EM_RESTART': '1', 09:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:23 INFO - 'PWD': '/builds/slave/test', 09:01:23 INFO - 'SHELL': '/bin/bash', 09:01:23 INFO - 'SHLVL': '1', 09:01:23 INFO - 'TERM': 'linux', 09:01:23 INFO - 'TMOUT': '86400', 09:01:23 INFO - 'USER': 'cltbld', 09:01:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:23 INFO - '_': '/tools/buildbot/bin/python'} 09:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:01:24 INFO - Cleaning up... 09:01:24 INFO - Return code: 0 09:01:24 INFO - Running post-action listener: _resource_record_post_action 09:01:24 INFO - Running post-action listener: _start_resource_monitoring 09:01:24 INFO - Starting resource monitoring. 09:01:24 INFO - [mozharness: 2017-01-20 17:01:24.074135Z] Finished create-virtualenv step (success) 09:01:24 INFO - [mozharness: 2017-01-20 17:01:24.074591Z] Running install step. 09:01:24 INFO - Running pre-action listener: _resource_record_pre_action 09:01:24 INFO - Running main action method: install 09:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:24 INFO - Reading from file tmpfile_stdout 09:01:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:24 INFO - Reading from file tmpfile_stdout 09:01:24 INFO - Output received: 09:01:24 INFO - Usage: mozinstall [options] installer 09:01:24 INFO - Options: 09:01:24 INFO - -h, --help show this help message and exit 09:01:24 INFO - -d DEST, --destination=DEST 09:01:24 INFO - Directory to install application into. [default: 09:01:24 INFO - "/builds/slave/test"] 09:01:24 INFO - --app=APP Application being installed. [default: firefox] 09:01:24 INFO - mkdir: /builds/slave/test/build/application 09:01:24 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'] 09:01:24 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 09:01:40 INFO - Reading from file tmpfile_stdout 09:01:40 INFO - Output received: 09:01:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:40 INFO - Running post-action listener: _resource_record_post_action 09:01:40 INFO - [mozharness: 2017-01-20 17:01:40.346912Z] Finished install step (success) 09:01:40 INFO - [mozharness: 2017-01-20 17:01:40.347157Z] Running run-tests step. 09:01:40 INFO - Running pre-action listener: _resource_record_pre_action 09:01:40 INFO - Running main action method: run_tests 09:01:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:40 INFO - Python 2.7.3 09:01:40 INFO - Return code: 0 09:01:40 INFO - grabbing minidump binary from tooltool 09:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:40 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 0x1249f60>, '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 0x124ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:40 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 09:01:40 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 09:01:40 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 09:01:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:40 INFO - Return code: 0 09:01:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:40 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/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 09:01:40 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/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 09:01:40 INFO - Using env: {'DISPLAY': ':0', 09:01:40 INFO - 'HOME': '/home/cltbld', 09:01:40 INFO - 'LANG': 'en_US.UTF-8', 09:01:40 INFO - 'LANGUAGE': 'en_US:en', 09:01:40 INFO - 'LOGNAME': 'cltbld', 09:01:40 INFO - 'MAIL': '/var/mail/cltbld', 09:01:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:40 INFO - 'MOZ_NO_REMOTE': '1', 09:01:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:40 INFO - 'NO_EM_RESTART': '1', 09:01:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:40 INFO - 'PWD': '/builds/slave/test', 09:01:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:40 INFO - 'SHELL': '/bin/bash', 09:01:40 INFO - 'SHLVL': '1', 09:01:40 INFO - 'TERM': 'linux', 09:01:40 INFO - 'TMOUT': '86400', 09:01:40 INFO - 'USER': 'cltbld', 09:01:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927', 09:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:40 INFO - '_': '/tools/buildbot/bin/python'} 09:01:40 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/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 09:01:40 INFO - mozversion application_buildid: 20170120072124 09:01:40 INFO - mozversion application_changeset: dc33d7851ba557007fc49819d80320f9bf9f613e 09:01:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:01:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:40 INFO - mozversion application_name: Firefox 09:01:40 INFO - mozversion application_remotingname: firefox-dev 09:01:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:40 INFO - mozversion application_vendor: Mozilla 09:01:40 INFO - mozversion application_version: 52.0a2 09:01:40 INFO - mozversion platform_buildid: 20170120072124 09:01:40 INFO - mozversion platform_changeset: dc33d7851ba557007fc49819d80320f9bf9f613e 09:01:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:40 INFO - mozversion platform_version: 52.0a2 09:01:40 INFO - using testdate: 1484931700 09:01:40 INFO - actual date: 1484931700 09:01:40 INFO - starting webserver on 'localhost:34482' 09:01:40 INFO - SUITE-START | Running 2 tests 09:01:40 INFO - TEST-START | dromaeo_css 09:01:40 INFO - operating with platform_type : linux_ 09:01:40 INFO - Initialising browser for dromaeo_css test... 09:01:40 INFO - TEST-INFO | started process 26858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0cf2x/profile http://localhost:34482/getInfo.html) 09:01:44 INFO - PROCESS | 26858 | __metrics Screen width/height:1600/1200 09:01:44 INFO - PROCESS | 26858 | colorDepth:24 09:01:44 INFO - PROCESS | 26858 | Browser inner width/height: 1024/697 09:01:44 INFO - PROCESS | 26858 | __metrics 09:01:45 INFO - PROCESS | 26858 | 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" 09:01:45 INFO - PROCESS | 26858 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:46 INFO - PROCESS | 26858 | console.error: PushService: 09:01:46 INFO - PROCESS | 26858 | stateChangeProcessEnqueue: Error transitioning state 09:01:46 INFO - PROCESS | 26858 | UnknownError 09:01:46 INFO - TEST-INFO | 26858: exit 0 09:01:46 INFO - Browser initialized. 09:01:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:01:46 INFO - TEST-INFO | started process 26951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0cf2x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:58 INFO - PROCESS | 26951 | RSS: Main: 144244736 09:01:58 INFO - PROCESS | 26951 | 09:04:59 INFO - PROCESS | 26951 | Cycle 1(1): loaded http://localhost:34482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34482/tests/dromaeo/cssquery-ext.html) 09:05:01 INFO - PROCESS | 26951 | RSS: Main: 278016000 09:05:01 INFO - PROCESS | 26951 | 09:08:03 INFO - PROCESS | 26951 | Cycle 1(1): loaded http://localhost:34482/tests/dromaeo/cssquery-ext.html (next: http://localhost:34482/tests/dromaeo/cssquery-jquery.html) 09:08:04 INFO - PROCESS | 26951 | RSS: Main: 238108672 09:08:04 INFO - PROCESS | 26951 | 09:11:06 INFO - PROCESS | 26951 | Cycle 1(1): loaded http://localhost:34482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34482/tests/dromaeo/cssquery-mootools.html) 09:11:06 INFO - PROCESS | 26951 | RSS: Main: 211034112 09:11:06 INFO - PROCESS | 26951 | 09:14:08 INFO - PROCESS | 26951 | Cycle 1(1): loaded http://localhost:34482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34482/tests/dromaeo/cssquery-prototype.html) 09:14:09 INFO - PROCESS | 26951 | RSS: Main: 215867392 09:14:09 INFO - PROCESS | 26951 | 09:17:11 INFO - PROCESS | 26951 | Cycle 1(1): loaded http://localhost:34482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34482/tests/dromaeo/cssquery-yui.html) 09:17:12 INFO - PROCESS | 26951 | RSS: Main: 175611904 09:17:12 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | Cycle 1(1): loaded http://localhost:34482/tests/dromaeo/cssquery-yui.html (next: http://localhost:34482/tests/dromaeo/cssquery-dojo.html) 09:20:15 INFO - PROCESS | 26951 | RSS: Main: 262262784 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | __start_tp_report 09:20:15 INFO - PROCESS | 26951 | _x_x_mozilla_page_load 09:20:15 INFO - PROCESS | 26951 | _x_x_mozilla_page_load_details 09:20:15 INFO - PROCESS | 26951 | |i|pagename|runs| 09:20:15 INFO - PROCESS | 26951 | |0;dojo.html;3196.0571631368753;3221.8872339468116;3245.9999999999986;3266.183454136466;3282.3599398117362;5588.273524441822;5625.099984002561;5634.859128521789;5643.379228284891;5655.434456554342;5636.577256705743;5672.290963629546;5687.7156142192935;5691.117876729103;5737.827865164052;5131.692098474104;5135.127028405162;5153.56194723449;5176.792928282883;5220.190870415092;5017.52333528316;5212.452692467275;5228.816991405301;5230.790768369279;5234.92147617786;4967.552920237178;5060.924086138711;5104.591632669378;5109.642325037249;5129.0767661820855;5174.783925777439;5184.1186998210205;5269.104252277122;5270.894582108374;5292.52367286946;4936.827211047632;5086.618503612207;5178.0679477694;5224.947750522484;5229.163333866563;5469.671819690831;5485.067538518461;5492.752826122834;5534.695591742453;5556.277683901108;5963.4334738199805;5969.611975221596;6066.302375226861;6074.179985701918;6084.908726369108;5903.616264942808;6095.634261944298;6097.847553811146;6119.571629985903;6126.111713801519;5545.694986775726;5588.608797384185;5653.802116925888;5670.206171136044;5739.454751798572;6251.3123556408755;6253.6873156342;6257.43683068526;6258;6268.09112678659;5781.682007489629;6004.849878752979;6007.729652165663;6009.399060093956;6011.519078473799;5896.705164741746;5990.221271234799;6033.849153771103;6042.486388657014;6120.14317995481;6063.696815159225;6074.605150665193;6087.299960504599;6107.053406721965;6120.112583675342;6028.216331876828;6041.214642096587;6069.241344831896;6087.086936959403;6091.2081429414775;4543.45478542577;4581.656375771764;4678.461976872635;4694.882627934329;4718.150732868048;4232.153569286155;4232.449781528443;4251.298535741568;4251.80866860992;4277.529471758104;5894.852628684317;5899.321578018497;5899.793507227312;5905.261842269716;5913.201717768046;5923.111533270044;5953.732082056318;5958.314793798769;5973.074173503114;6219.222597175353;5727.284089488814;5739.483446489752;5743.54051675865;5745.13822926556;5752.827415177551;5246.816361427332;5262.868428289324;5298.6290959633225;5308.761105750251;5384.515393614593;6420.582662126947;6429.7428102875365;6435.839104022437;6450.935490645127;6457.5479716419395;6156.353582873734;6164.660943648142;6207.96896015517;6210.5652604317265;6217.658028808459;6109.694515274307;6117.279373342116;6238.189035425366;6258.968705156445;6346.048092785934;5922.3485416605;5930;6030.185924900083;6046.123312119806;6058.697065146813;6039.728212230548;6054.90917636227;6057;6115.021596544531;6152.753889844356;5753.712314384347;5789.623674461315;5840.328362238397;5983.162357270073;6000.279966404059;5850.5027072699295;5922.7927022554;5926.436988486087;5945.524358051259;5964.761409543743;5828.883422331614;5831.94168058314;5849.912251316318;5871.442212989759;5885.676287804212;5845.064789633639;5902.61632993854;5964.821055368346;5967.791127310524;5979.40205979416;5731.083026715705;5734.311882574118;5754.53963682896;5764.884702306014;5908.202392676933 09:20:15 INFO - PROCESS | 26951 | |1;ext.html;551.9475649813269;613.809718987114;631.4979591224974;664.528184988658;670.7954074007432;34128.65871341286;37235.441468378;37251.4412283816;37269.62730372696;37282;37431.4385284221;38149.23701525968;45878.31182532265;47065.29402058972;47079.76460117695;8801.823963520726;8936.821263574724;8937.865932011026;8946.373753837233;8947.32895032875;8825.205731484166;8913.732588022369;8915.73252802417;8924.687635932743;8932.64269429222;8529.957350213272;8739.4756314621;8939.106089391074;10618.840717389245;10865.728356791064;10578.52396642153;10643.680689579325;10657.626983055594;10715.30350527221;10728.088112510406;10331.380117192992;10400.583976640924;10446.843297350546;10451.477426128738;10457.424841633707;34419.82790086058;34970.65029349699;42855.57144428547;42879.57120428787;43681;3506.9824650876835;3507.2108775525558;3519.6128425873135;3589.353916295066;3926.5288165420047;33013.83493082519;33057.50413743796;33136;33258.6674133258;33450.49824252638;3809.257194847006;3877.2827027000094;3877.8836634900717;3955.9011024724323;3999.42008408782;351822;353261;353933;354899.99999999744;355236;60305;60771.392286076574;60786.696066519384;60838;60863.69568152219;64799.67600161969;64917.35082649113;65062;65181;65265.34734652593;17964.461066168034;18198;18242.54393640143;18498.352557660688;18502.074896255133;14437.927810360881;14504.782428263585;14526.346314415876;14704.852951470562;14724.26378681083;15169.696606067817;16581.83418165827;16950.91524542394;16988.915055424644;17018;5509.807156749494;6492.935070649328;6539.313372095861;6588.40704336612;6672.666366681647;986.4278718343344;1011.7774089700254;1069.2568664777905;1094.4637127807316;1105.618561596248;32032;32424.189395265308;32513.34973300568;32545.186370340456;33152.3369532608;1127.6053381316638;1142.2917790969652;1159.3913195572393;1188.8216767484946;1205.8854408831146;16347.427840025543;17284.481465556055;17365.7395139073;17405.659441987715;17406.738898916527;493191;495951;496840;498514;499514;58930;58995.70502147462;59046.704766475894;59082.40917590769;59219.40780592225;1353.2692346133174;1366.9658258543616;1374.5120482228865;1379.8689124533355;1392.5474220878255;30423.69576304297;31386.372272554876;31818.68181318157;32016.51975220327;32228.19429514281;51161;51641.48358516367;51660;51727.74136129295;51901;431489;434252;434541;435600;436042;36405.81797090998;36884.262314754094;38588.80705596454;41996.37005444982;42224.57775422207;45714.54285457103;45798.77100614476;46001.30998035099;46031.53968460273;48092.759536202095;38409;41592.792036039624;42399.40014996251;43145.35281970836;43552.56447435485;41986.1602767949;42237.78881105698;42490.36264456098;43783.562164377945;44058.33912491379;41161;41857.58142418659;41939.161216776105;42049.369259461746;42361.78819105885;36089.27821443609;37470.625293746714;37980.62019379771;38415.807920960215;38499.80750096231;28316;28558.857205713837;28578.428431431672;28651;28659.856700716362 09:20:15 INFO - PROCESS | 26951 | |2;jquery.html;411.7879292164538;429.8130313313709;431.35202202318646;434.17723414130216;437.49469362885856;18903.71644425333;20316;20414;20753.273635422727;21040.368788936317;19064.80935190651;19458.318958836444;19636;19911.900440497815;20413.183472661076;5119.411267704225;5330.866728331784;5336.466353364672;5342.599305052117;5343.812966546172;5152.819651312205;5184.1186998210205;5260.395054568736;5276.604254680895;5330.040592693314;5241.292425522543;5246.711430871301;5253.44838791927;5254.894902101955;5281.075811732951;5194.948050519484;5253.0544501989625;5261.053010458116;5823.737931793079;5856.590038697293;5275.736213189363;5278.762455689503;5285.339332583427;5290.65610735301;5290.788368465257;13180.604581862559;13244.536441224607;13245.536406225736;13256.602301930958;20198;2244.438890277431;2275.380384242497;2301.2635956493928;2562.987185064063;2749.766269867064;9768.609255629766;9903;9941.90058099417;10000.449975251358;10076.748081298027;1896.468988683171;1919.5472243248212;1958.8530860185401;1970.2611520679745;2035.4402539301661;81559.5922020386;84323;93094;93689.53155234248;96222.9999999993;10718.24972251935;11019.779604407868;11235.438228088562;11246.156538259664;11287.645482541984;15303.46437874669;15312.081275123528;15356.385744570316;15356.692866142615;15373.461928832661;8553.486790792447;8771.561421928878;8791.164839340381;8830.690925817566;8874.068222836639;8789.516576588348;8817.911820881838;8885.911140888638;9054.86417703735;9055;4273.273543497613;4460.553944605578;4502.302143167814;4585.243434833282;4630.3748993886065;1873.278787666758;1899.819517145869;1916.5017095555256;1926.5087402712218;1927.363969889933;977.237754551451;985.7880555680563;1007.4660429972126;1058.343826827372;1087.8694556653252;18674;20464.69302960457;20489.795102049087;20496.077676504592;20649.69025464589;977.9853302200472;978.3200675530438;990.5443495991924;1003.1623594298842;1004.864343313658;10652.62715804943;11461.598844040585;11554.306741595532;11633.6509904703;11667.241629294069;469538;473358;478759;479211;480947;92319.53840230756;93896;94428;94789.5260523693;95045.52477237569;1003.5132960514145;1034.4672493665769;1042.9582816687248;1116.2967330581682;1118.558169523034;17379.304827806747;17744.3789467368;17937.37219197322;18075.36736214226;18128.365507207185;42641.36037959495;43597.56402436062;45001.09997800091;45067.54932450765;46352;59308.40691593029;59681.40318596758;59850.70074649599;60508.69745651243;61059.694701526205;8439.620217090369;8697.652093916173;8706.91293087061;8719.34604904622;8740.825183496421;9835.409875407498;13365.131266467648;13484.528041518892;13711.108777929403;13912.51306204278;11832.82250766222;11851.585194518151;11956.521739130338;12145;12335.814962775745;10642.521086550969;11286.774264514828;11571;11600.129990250934;11743.706407339885;8322.958385208036;12094.315671634318;12588.748225035632;12701.110922235355;12753.936230318788;11930.22453540517;12794.104412691022;13046.34768261602;13281.136726112773;13350;12275.570355037888;12343.382830858242;12351.320677362832;12400.19398739079;12919.418626162033 09:20:15 INFO - PROCESS | 26951 | |3;mootools.html;1359.8096266522682;1485.8291296500906;1486.9033512821666;1636.6235765773872;1812.6465339258834;7695.3458955988735;8444.957775211124;8634.26608738258;8658.567071646416;8927.37508374414;8739.388242823004;8813.383063185564;8814.77963050924;8817.603207855645;8819.338549608789;2397.916072937443;2428.9271321860374;2434.5982912819363;2436.768506991833;2449.020391843259;2367.6922000139957;2427.8179136564827;2448.4980578981267;2449.326435230317;2463.1379017343966;2371.4664200554907;2383.6067048936907;2396.209250947192;2411.8794060296914;2414.408469924871;2210.602091623507;2270.4664403865077;2351.7648235176516;2391.1033362489065;2391.8564886106888;2334.3113781434517;2335.859848409101;2363.1138323128826;2364.6216605343234;2364.9408764780846;8616.65533378664;8788.8681669775;8807.867881981776;8810.86783698245;8817.16236957488;5220;5221.503957124067;5316.282301889234;5368.865778355534;5369.328833895763;3226.2579606690592;3306.5866766654167;3342.8495717692763;3377.783997760804;3402.6086999994823;957.9856302155473;963.2775418436173;992.9404235745878;1019.9592016319339;1032;11955.462004209832;11986.101042421766;12101.455434505468;12202;12208.633740987785;4442.777861106932;4617.053504031665;4672.883177920579;4750.121227572841;4757.9286310705365;9703.854442183232;9725.173360264456;9729.221662267002;9730.805383892282;9743.464109474047;5341.172118321666;5342.9465705342445;5343.465653434703;5345;5348.090824559834;4415.183191109655;4451.577100175478;4915.361003069578;5023.974880125649;5024.673396229234;3799.6200379962333;3860.6718428933855;3911.902202444962;3921.156951255494;3964.524257089168;1179.9528018879148;1185.6561597136906;1192.7912615292462;1204.1330242225583;1207.2032458577296;813.979650508742;918.4948278446961;933.1554942776797;943.6319835264252;969.9078587534173;5508.6970216637665;5653.689047102449;5690.971545142248;5821.825345239565;5856.033754430471;461.3932678527725;479.2547588499916;481.9783109760069;989.0752146742818;1039.7712503249272;3987.501562304712;4135.483064616923;4162.167566486714;4175.68682348825;4206.894827629334;10378.325408848552;10966.396848173426;10977.176711746652;10978.945105274423;11010.50452729613;10815.40515271652;10820.13438924884;10832.512536935857;10857.837132443019;10886.346819190874;8190.303824174893;8222.301104406073;8326.70856520019;8326.70856520019;8334.12491688376;5711.143328500758;5711.543076553949;5780.364159942319;5786.218860453785;5853.736581853742;9758.75603109928;9810.264230182622;9826.65606703762;9952.950235248778;9954.651587194414;9489.762755931157;9884.209263259067;9899;10106.292559520763;10133.03736145065;6988.126484189476;7172.892406613801;7173;7774.572398518136;7935.722249721232;8156.347492200491;8210.630521626661;8364.330853531581;8618.482891026559;8621.180987806149;7578.886316705143;7620.237976202336;7667.731629392944;7675.385969122345;7684.385249180164;7474.588897610466;7616.695332186872;7661.693532258647;7712.5758083305955;7764.883526747216;6874.6562671867205;7138.46461515378;7162.677679504331;7170.211276759656;7179.425645948416;5093.414257360303;5110.259012443249;5146.279520867007;5178.326817513699;5251.553617942518;5151.201563757623;5172.405173405106;5186.844394668166;5234.764435600331;5254.238135470259 09:20:15 INFO - PROCESS | 26951 | |4;prototype.html;342.3597871979399;347.1339009172116;351.6764576589537;354.92901419716065;356.62198070045736;5349.893002139955;5358.490943360384;5369.9463005369935;5377.919331210025;5415.9458405415935;5046.646734728571;5152.252923326116;5195.766190521426;5205.141151709973;5307;4184.95376155961;4187.51843537994;4203.47456567929;4206.537280899099;4218.641415479688;4199.874003779892;4232.682548808836;4233.407322974786;4242.257604919127;4245.80893859777;3939.5863434339412;3993.2612466693754;4162.916741665165;4163.355474587536;4215.346621273708;4165.166966606661;4172.5410204877435;4182.121754431573;4183.477065366829;4192.24539582875;3716.4053751399915;3728.3475391806596;3729.0118118698565;3735.9252814943547;3742.8315725792404;5081.606262887527;5149.459306772772;5168.511254902963;5214.165733482625;5214.634975551713;4793.832215872462;4801.135795556798;4804.5916097131785;4809.86968062505;4812.1578723723205;5566.387697353288;5576.581756368248;5582.665040097567;5585.2459917910965;5602.243697100921;3904.2777086239134;4085.468889044435;4127.215828992482;4128.4632997710405;4129.380592911058;5776.422357764232;5790.594658373915;5791.420857914217;5794.536437085023;5807.332156801979;4198.160367926427;4202.2646036943415;4202.621764041251;4206.158768246363;4222.113356195234;4163.417121602978;4235.682323825726;4257.829686812554;4267.591694740728;4276.337167739005;4796.304535842353;4799.232122860395;4802.807887684454;4805.447373552086;4811.158047341772;5600.271964644651;5607;5616.803411880564;5617.775288988395;5639.182318563785;1397.2035939514378;1408.9080962254334;1415.1933397963062;1424.6082327359852;1431.4039845572113;951.6098399656108;965.9903400966041;984.3552473130111;1013.2501948558014;1014.5434554450527;5253.605979551472;5260.868478288074;5265.473452654781;5290.047791397508;5302.867428314245;5553.83369492403;5559.63862348946;5563.193336966198;5564.944350556442;5583.748731307101;5123.436421993578;5169.767360468788;5200.193969934666;5222.817201397933;5275.683458992396;2903.301568582403;2907.680155182928;2921.401112771877;2921.780866435026;2933.9413211735646;5506.889862202814;5667.716614169358;5690.601657883991;5696.743646535916;5709.200711900337;5521.834344969658;5603.355614104348;5604.747786349624;5609.80365687199;5629.324481062217;5695.319880635223;5697.9430205698245;5705.315362156568;5708.600397972185;5732.34078081026;5247.685138891678;5483.983808905006;5491.341039075336;5531.419200983839;5553.916691249715;5498.560115190855;5503.422140675171;5507.862303442446;5518.641288316247;5538.556915446835;5467.9453205467435;5734.770609175753;5747.827565173052;5751.769929202952;5757.481826635623;4032.314506533955;4041.515018197835;4049.5545489996666;4054.412110244057;4130.318497448007;5448.482394172547;5449.536789372948;5451.781928722807;5501.074623881609;5524.889502209853;5293.311869456946;5401.244595506398;5406.21609866575;5417.593680473901;5433.673979561239;5645.68948707825;5650.513773939453;5662.433756624305;5665.065264231355;5684.403137670485;5395.81114660985;5438.178210299594;5613.596600849787;5628.802991895264;5644.181593668813;5465.289512363367;5623.606347555632;5625.409332020079;5632.633878797865;5657.179708942263;5500.50495455411;5517.503424691797;5543.8891222174525;5549.501634558727;5577.637453565505 09:20:15 INFO - PROCESS | 26951 | |5;yui.html;778.2528772378513;792.7502836606468;796.1282395776623;806.1293802693092;887.6227603268609;14838.40646374145;15638.061716297016;16123.75814362784;16156;16338.918305408486;13757.931210343959;13878.028538002343;14153.504627338045;14308.856911430883;14336.784948225784;716.4912911832605;843.995780021099;844.9831003379928;847.559269180026;849.817289282804;743.9702411903518;829.17911267845;854.0136142755127;857.6097875466647;860.0582362313257;888.4536010353619;894.8791913091746;895.2882458445519;895.6686026170294;896.3770179725094;764.8432071425344;893.249670276964;894.4677916639622;894.6242578117174;895.8029233568604;573.6013470637909;640.1358166475268;650.4211251985737;654.8853950558681;656.4485831901178;15063.322150503254;15103.32035058414;15106.169160696158;15120.319585618674;15132.773008404884;13914.30428478572;14142.292885355793;14317.284135793168;14348.28258587077;14357.56927292183;12307.384630768514;12316.5073397064;12551.686207844878;12572.30852303123;12574.371281435891;4407.140607581523;4418.867433976986;4437.090396468716;4490.50604433512;4520.751358675271;61720.69139654318;62251;63827.68086159586;65216.347836521505;65439.67280163617;11072.612458563912;11077.50151243196;11178.44107794607;11425.828612570818;11555.942220288845;20396.694049589267;20435.897820510803;20449;20506.58986820255;20817.791822081886;8361.917029891749;8392.874106888401;8403.453775504573;8430;8446.57767111642;4672.299155126758;4694.436667599842;4710.3405523226775;4821.662483626183;4907.214845624683;3484.181217413906;3620.31214069326;3622.728295377857;3754.2679177560112;3883;702.9156501219886;702.9437644988388;711.416638356553;724.0261847814786;725.2855936902147;656.2748163279603;729.8321386081232;737.2406421385981;738.5384134915678;752.1913942511821;8816.603252853636;8853;9363.485008324471;9389.671361502315;9664.661736839176;690.9861802763917;706.6360824175554;717.0320067908386;723.8009547374514;741.7774667599698;4724.43306803179;4850.733209673432;4955.4796746341835;5137.152369859006;5223.085959956992;72925.6353718228;87522.56238718893;89485.55257223803;89691.10308896958;92016.53991729999;76491.23508764952;78555;80082.59958700169;80792.19207807847;81208.59395702984;58450;59859.700701496215;60070.69964650149;62086.068708969404;70034;9195.494247816434;9418.905810942077;9485.098915603006;9532.90467095348;9605.567749451151;41906.37140442835;42821.92945176396;43673.34489982589;45055;45824;35854;57193.714031429576;57370;58307.10073318477;58768.412315876296;12640;12651.430685618985;12771.169873958162;12952.158109722837;13010;13849.861501384858;13900.998731769198;14104.294785260901;14200;14345.139291642536;10770;12900.29048402347;12947.676308092374;13007.089503734647;13073.019523535582;12541.247525148521;12680.9855211581;12816.743665126458;13041.424942458665;13685.589432317047;11858.40707964581;12296.077794165294;12681.80977285323;12709.428075736429;13088.214707117222;10162.949185254027;10466.68599942003;10628.787424251317;10718.624848130277;10833.404162771123;10570.682879513626;10761.30051546647;10775.407352595683;10963.232573719763;10986.92221639211 09:20:15 INFO - PROCESS | 26951 | __end_tp_report 09:20:15 INFO - PROCESS | 26951 | __start_cc_report 09:20:15 INFO - PROCESS | 26951 | _x_x_mozilla_cycle_collect,1291 09:20:15 INFO - PROCESS | 26951 | __end_cc_report 09:20:15 INFO - PROCESS | 26951 | __startTimestamp1484932815315__endTimestamp 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | ------- Summary: start ------- 09:20:15 INFO - PROCESS | 26951 | Number of tests: 6 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | [#0] dojo.html Cycles:165 Average:5639.87 Median:5850.50 stddev:642.43 (11.0%) stddev-sans-first:615.13 09:20:15 INFO - PROCESS | 26951 | Values: 3196.1 3221.9 3246.0 3266.2 3282.4 5588.3 5625.1 5634.9 5643.4 5655.4 5636.6 5672.3 5687.7 5691.1 5737.8 5131.7 5135.1 5153.6 5176.8 5220.2 5017.5 5212.5 5228.8 5230.8 5234.9 4967.6 5060.9 5104.6 5109.6 5129.1 5174.8 5184.1 5269.1 5270.9 5292.5 4936.8 5086.6 5178.1 5224.9 5229.2 5469.7 5485.1 5492.8 5534.7 5556.3 5963.4 5969.6 6066.3 6074.2 6084.9 5903.6 6095.6 6097.8 6119.6 6126.1 5545.7 5588.6 5653.8 5670.2 5739.5 6251.3 6253.7 6257.4 6258.0 6268.1 5781.7 6004.8 6007.7 6009.4 6011.5 5896.7 5990.2 6033.8 6042.5 6120.1 6063.7 6074.6 6087.3 6107.1 6120.1 6028.2 6041.2 6069.2 6087.1 6091.2 4543.5 4581.7 4678.5 4694.9 4718.2 4232.2 4232.4 4251.3 4251.8 4277.5 5894.9 5899.3 5899.8 5905.3 5913.2 5923.1 5953.7 5958.3 5973.1 6219.2 5727.3 5739.5 5743.5 5745.1 5752.8 5246.8 5262.9 5298.6 5308.8 5384.5 6420.6 6429.7 6435.8 6450.9 6457.5 6156.4 6164.7 6208.0 6210.6 6217.7 6109.7 6117.3 6238.2 6259.0 6346.0 5922.3 5930.0 6030.2 6046.1 6058.7 6039.7 6054.9 6057.0 6115.0 6152.8 5753.7 5789.6 5840.3 5983.2 6000.3 5850.5 5922.8 5926.4 5945.5 5964.8 5828.9 5831.9 5849.9 5871.4 5885.7 5845.1 5902.6 5964.8 5967.8 5979.4 5731.1 5734.3 5754.5 5764.9 5908.2 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | [#1] ext.html Cycles:180 Average:59715.18 Median:38412.40 stddev:114252.41 (297.4%) stddev-sans-first:114486.56 09:20:15 INFO - PROCESS | 26951 | Values: 551.9 613.8 631.5 664.5 670.8 34128.7 37235.4 37251.4 37269.6 37282.0 37431.4 38149.2 45878.3 47065.3 47079.8 8801.8 8936.8 8937.9 8946.4 8947.3 8825.2 8913.7 8915.7 8924.7 8932.6 8530.0 8739.5 8939.1 10618.8 10865.7 10578.5 10643.7 10657.6 10715.3 10728.1 10331.4 10400.6 10446.8 10451.5 10457.4 34419.8 34970.7 42855.6 42879.6 43681.0 3507.0 3507.2 3519.6 3589.4 3926.5 33013.8 33057.5 33136.0 33258.7 33450.5 3809.3 3877.3 3877.9 3955.9 3999.4 351822.0 353261.0 353933.0 354900.0 355236.0 60305.0 60771.4 60786.7 60838.0 60863.7 64799.7 64917.4 65062.0 65181.0 65265.3 17964.5 18198.0 18242.5 18498.4 18502.1 14437.9 14504.8 14526.3 14704.9 14724.3 15169.7 16581.8 16950.9 16988.9 17018.0 5509.8 6492.9 6539.3 6588.4 6672.7 986.4 1011.8 1069.3 1094.5 1105.6 32032.0 32424.2 32513.3 32545.2 33152.3 1127.6 1142.3 1159.4 1188.8 1205.9 16347.4 17284.5 17365.7 17405.7 17406.7 493191.0 495951.0 496840.0 498514.0 499514.0 58930.0 58995.7 59046.7 59082.4 59219.4 1353.3 1367.0 1374.5 1379.9 1392.5 30423.7 31386.4 31818.7 32016.5 32228.2 51161.0 51641.5 51660.0 51727.7 51901.0 431489.0 434252.0 434541.0 435600.0 436042.0 36405.8 36884.3 38588.8 41996.4 42224.6 45714.5 45798.8 46001.3 46031.5 48092.8 38409.0 41592.8 42399.4 43145.4 43552.6 41986.2 42237.8 42490.4 43783.6 44058.3 41161.0 41857.6 41939.2 42049.4 42361.8 36089.3 37470.6 37980.6 38415.8 38499.8 28316.0 28558.9 28578.4 28651.0 28659.9 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | [#2] jquery.html Cycles:180 Average:29047.54 Median:2259.91 stddev:78880.82 (3490.4%) stddev-sans-first:79072.80 09:20:15 INFO - PROCESS | 26951 | Values: 411.8 429.8 431.4 434.2 437.5 18903.7 20316.0 20414.0 20753.3 21040.4 19064.8 19458.3 19636.0 19911.9 20413.2 5119.4 5330.9 5336.5 5342.6 5343.8 5152.8 5184.1 5260.4 5276.6 5330.0 5241.3 5246.7 5253.4 5254.9 5281.1 5194.9 5253.1 5261.1 5823.7 5856.6 5275.7 5278.8 5285.3 5290.7 5290.8 13180.6 13244.5 13245.5 13256.6 20198.0 2244.4 2275.4 2301.3 2563.0 2749.8 9768.6 9903.0 9941.9 10000.4 10076.7 1896.5 1919.5 1958.9 1970.3 2035.4 81559.6 84323.0 93094.0 93689.5 96223.0 10718.2 11019.8 11235.4 11246.2 11287.6 15303.5 15312.1 15356.4 15356.7 15373.5 8553.5 8771.6 8791.2 8830.7 8874.1 8789.5 8817.9 8885.9 9054.9 9055.0 4273.3 4460.6 4502.3 4585.2 4630.4 1873.3 1899.8 1916.5 1926.5 1927.4 977.2 985.8 1007.5 1058.3 1087.9 18674.0 20464.7 20489.8 20496.1 20649.7 978.0 978.3 990.5 1003.2 1004.9 10652.6 11461.6 11554.3 11633.7 11667.2 469538.0 473358.0 478759.0 479211.0 480947.0 92319.5 93896.0 94428.0 94789.5 95045.5 1003.5 1034.5 1043.0 1116.3 1118.6 17379.3 17744.4 17937.4 18075.4 18128.4 42641.4 43597.6 45001.1 45067.5 46352.0 59308.4 59681.4 59850.7 60508.7 61059.7 8439.6 8697.7 8706.9 8719.3 8740.8 9835.4 13365.1 13484.5 13711.1 13912.5 11832.8 11851.6 11956.5 12145.0 12335.8 10642.5 11286.8 11571.0 11600.1 11743.7 8323.0 12094.3 12588.7 12701.1 12753.9 11930.2 12794.1 13046.3 13281.1 13350.0 12275.6 12343.4 12351.3 12400.2 12919.4 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | [#3] mootools.html Cycles:180 Average:5731.45 Median:5220.75 stddev:3239.11 (62.0%) stddev-sans-first:3231.53 09:20:15 INFO - PROCESS | 26951 | Values: 1359.8 1485.8 1486.9 1636.6 1812.6 7695.3 8445.0 8634.3 8658.6 8927.4 8739.4 8813.4 8814.8 8817.6 8819.3 2397.9 2428.9 2434.6 2436.8 2449.0 2367.7 2427.8 2448.5 2449.3 2463.1 2371.5 2383.6 2396.2 2411.9 2414.4 2210.6 2270.5 2351.8 2391.1 2391.9 2334.3 2335.9 2363.1 2364.6 2364.9 8616.7 8788.9 8807.9 8810.9 8817.2 5220.0 5221.5 5316.3 5368.9 5369.3 3226.3 3306.6 3342.8 3377.8 3402.6 958.0 963.3 992.9 1020.0 1032.0 11955.5 11986.1 12101.5 12202.0 12208.6 4442.8 4617.1 4672.9 4750.1 4757.9 9703.9 9725.2 9729.2 9730.8 9743.5 5341.2 5342.9 5343.5 5345.0 5348.1 4415.2 4451.6 4915.4 5024.0 5024.7 3799.6 3860.7 3911.9 3921.2 3964.5 1180.0 1185.7 1192.8 1204.1 1207.2 814.0 918.5 933.2 943.6 969.9 5508.7 5653.7 5691.0 5821.8 5856.0 461.4 479.3 482.0 989.1 1039.8 3987.5 4135.5 4162.2 4175.7 4206.9 10378.3 10966.4 10977.2 10978.9 11010.5 10815.4 10820.1 10832.5 10857.8 10886.3 8190.3 8222.3 8326.7 8326.7 8334.1 5711.1 5711.5 5780.4 5786.2 5853.7 9758.8 9810.3 9826.7 9953.0 9954.7 9489.8 9884.2 9899.0 10106.3 10133.0 6988.1 7172.9 7173.0 7774.6 7935.7 8156.3 8210.6 8364.3 8618.5 8621.2 7578.9 7620.2 7667.7 7675.4 7684.4 7474.6 7616.7 7661.7 7712.6 7764.9 6874.7 7138.5 7162.7 7170.2 7179.4 5093.4 5110.3 5146.3 5178.3 5251.6 5151.2 5172.4 5186.8 5234.8 5254.2 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | [#4] prototype.html Cycles:180 Average:4663.30 Median:5291.68 stddev:1339.77 (25.3%) stddev-sans-first:1303.69 09:20:15 INFO - PROCESS | 26951 | Values: 342.4 347.1 351.7 354.9 356.6 5349.9 5358.5 5369.9 5377.9 5415.9 5046.6 5152.3 5195.8 5205.1 5307.0 4185.0 4187.5 4203.5 4206.5 4218.6 4199.9 4232.7 4233.4 4242.3 4245.8 3939.6 3993.3 4162.9 4163.4 4215.3 4165.2 4172.5 4182.1 4183.5 4192.2 3716.4 3728.3 3729.0 3735.9 3742.8 5081.6 5149.5 5168.5 5214.2 5214.6 4793.8 4801.1 4804.6 4809.9 4812.2 5566.4 5576.6 5582.7 5585.2 5602.2 3904.3 4085.5 4127.2 4128.5 4129.4 5776.4 5790.6 5791.4 5794.5 5807.3 4198.2 4202.3 4202.6 4206.2 4222.1 4163.4 4235.7 4257.8 4267.6 4276.3 4796.3 4799.2 4802.8 4805.4 4811.2 5600.3 5607.0 5616.8 5617.8 5639.2 1397.2 1408.9 1415.2 1424.6 1431.4 951.6 966.0 984.4 1013.3 1014.5 5253.6 5260.9 5265.5 5290.0 5302.9 5553.8 5559.6 5563.2 5564.9 5583.7 5123.4 5169.8 5200.2 5222.8 5275.7 2903.3 2907.7 2921.4 2921.8 2933.9 5506.9 5667.7 5690.6 5696.7 5709.2 5521.8 5603.4 5604.7 5609.8 5629.3 5695.3 5697.9 5705.3 5708.6 5732.3 5247.7 5484.0 5491.3 5531.4 5553.9 5498.6 5503.4 5507.9 5518.6 5538.6 5467.9 5734.8 5747.8 5751.8 5757.5 4032.3 4041.5 4049.6 4054.4 4130.3 5448.5 5449.5 5451.8 5501.1 5524.9 5293.3 5401.2 5406.2 5417.6 5433.7 5645.7 5650.5 5662.4 5665.1 5684.4 5395.8 5438.2 5613.6 5628.8 5644.2 5465.3 5623.6 5625.4 5632.6 5657.2 5500.5 5517.5 5543.9 5549.5 5577.6 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - PROCESS | 26951 | [#5] yui.html Cycles:180 Average:17516.78 Median:4836.20 stddev:22763.54 (470.7%) stddev-sans-first:22792.70 09:20:15 INFO - PROCESS | 26951 | Values: 778.3 792.8 796.1 806.1 887.6 14838.4 15638.1 16123.8 16156.0 16338.9 13757.9 13878.0 14153.5 14308.9 14336.8 716.5 844.0 845.0 847.6 849.8 744.0 829.2 854.0 857.6 860.1 888.5 894.9 895.3 895.7 896.4 764.8 893.2 894.5 894.6 895.8 573.6 640.1 650.4 654.9 656.4 15063.3 15103.3 15106.2 15120.3 15132.8 13914.3 14142.3 14317.3 14348.3 14357.6 12307.4 12316.5 12551.7 12572.3 12574.4 4407.1 4418.9 4437.1 4490.5 4520.8 61720.7 62251.0 63827.7 65216.3 65439.7 11072.6 11077.5 11178.4 11425.8 11555.9 20396.7 20435.9 20449.0 20506.6 20817.8 8361.9 8392.9 8403.5 8430.0 8446.6 4672.3 4694.4 4710.3 4821.7 4907.2 3484.2 3620.3 3622.7 3754.3 3883.0 702.9 702.9 711.4 724.0 725.3 656.3 729.8 737.2 738.5 752.2 8816.6 8853.0 9363.5 9389.7 9664.7 691.0 706.6 717.0 723.8 741.8 4724.4 4850.7 4955.5 5137.2 5223.1 72925.6 87522.6 89485.6 89691.1 92016.5 76491.2 78555.0 80082.6 80792.2 81208.6 58450.0 59859.7 60070.7 62086.1 70034.0 9195.5 9418.9 9485.1 9532.9 9605.6 41906.4 42821.9 43673.3 45055.0 45824.0 35854.0 57193.7 57370.0 58307.1 58768.4 12640.0 12651.4 12771.2 12952.2 13010.0 13849.9 13901.0 14104.3 14200.0 14345.1 10770.0 12900.3 12947.7 13007.1 13073.0 12541.2 12681.0 12816.7 13041.4 13685.6 11858.4 12296.1 12681.8 12709.4 13088.2 10162.9 10466.7 10628.8 10718.6 10833.4 10570.7 10761.3 10775.4 10963.2 10986.9 09:20:15 INFO - PROCESS | 26951 | -------- Summary: end -------- 09:20:15 INFO - PROCESS | 26951 | 09:20:15 INFO - TEST-INFO | 26951: exit 0 09:20:16 INFO - TEST-OK | dromaeo_css | took 1115388ms 09:20:16 INFO - TEST-START | kraken 09:20:16 INFO - operating with platform_type : linux_ 09:20:16 INFO - Initialising browser for kraken test... 09:20:16 INFO - TEST-INFO | started process 27270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6PNTy/profile http://localhost:34482/getInfo.html) 09:20:20 INFO - PROCESS | 27270 | __metrics Screen width/height:1600/1200 09:20:20 INFO - PROCESS | 27270 | colorDepth:24 09:20:20 INFO - PROCESS | 27270 | Browser inner width/height: 1024/697 09:20:20 INFO - PROCESS | 27270 | __metrics 09:20:20 INFO - PROCESS | 27270 | 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" 09:20:20 INFO - PROCESS | 27270 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:21 INFO - PROCESS | 27270 | console.error: PushService: 09:20:21 INFO - PROCESS | 27270 | stateChangeProcessEnqueue: Error transitioning state 09:20:21 INFO - PROCESS | 27270 | UnknownError 09:20:21 INFO - TEST-INFO | 27270: exit 0 09:20:21 INFO - Browser initialized. 09:20:21 INFO - Running cycle 1/1 for kraken test... 09:20:21 INFO - TEST-INFO | started process 27364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6PNTy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:33 INFO - PROCESS | 27364 | RSS: Main: 144392192 09:20:33 INFO - PROCESS | 27364 | 09:20:36 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34482/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:37 INFO - PROCESS | 27364 | RSS: Main: 185114624 09:20:37 INFO - PROCESS | 27364 | 09:20:39 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34482/tests/kraken/driver.html?testName=audio-dft) 09:20:40 INFO - PROCESS | 27364 | RSS: Main: 175722496 09:20:40 INFO - PROCESS | 27364 | 09:20:43 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34482/tests/kraken/driver.html?testName=audio-fft) 09:20:43 INFO - PROCESS | 27364 | RSS: Main: 266612736 09:20:43 INFO - PROCESS | 27364 | 09:20:45 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34482/tests/kraken/driver.html?testName=audio-oscillator) 09:20:46 INFO - PROCESS | 27364 | RSS: Main: 172331008 09:20:46 INFO - PROCESS | 27364 | 09:20:48 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:20:49 INFO - PROCESS | 27364 | RSS: Main: 174624768 09:20:49 INFO - PROCESS | 27364 | 09:20:52 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34482/tests/kraken/driver.html?testName=imaging-darkroom) 09:20:52 INFO - PROCESS | 27364 | RSS: Main: 214323200 09:20:52 INFO - PROCESS | 27364 | 09:20:55 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34482/tests/kraken/driver.html?testName=imaging-desaturate) 09:20:56 INFO - PROCESS | 27364 | RSS: Main: 212594688 09:20:56 INFO - PROCESS | 27364 | 09:20:59 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34482/tests/kraken/driver.html?testName=json-parse-financial) 09:20:59 INFO - PROCESS | 27364 | RSS: Main: 211750912 09:20:59 INFO - PROCESS | 27364 | 09:21:01 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:01 INFO - PROCESS | 27364 | RSS: Main: 173887488 09:21:01 INFO - PROCESS | 27364 | 09:21:03 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:04 INFO - PROCESS | 27364 | RSS: Main: 181043200 09:21:04 INFO - PROCESS | 27364 | 09:21:06 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:06 INFO - PROCESS | 27364 | RSS: Main: 189980672 09:21:06 INFO - PROCESS | 27364 | 09:21:09 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:09 INFO - PROCESS | 27364 | RSS: Main: 198844416 09:21:09 INFO - PROCESS | 27364 | 09:21:12 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:13 INFO - PROCESS | 27364 | RSS: Main: 194428928 09:21:13 INFO - PROCESS | 27364 | 09:21:14 INFO - PROCESS | 27364 | Cycle 1(1): loaded http://localhost:34482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34482/tests/kraken/driver.html?testName=ai-astar) 09:21:15 INFO - PROCESS | 27364 | RSS: Main: 247173120 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | __start_tp_report 09:21:15 INFO - PROCESS | 27364 | _x_x_mozilla_page_load 09:21:15 INFO - PROCESS | 27364 | _x_x_mozilla_page_load_details 09:21:15 INFO - PROCESS | 27364 | |i|pagename|runs| 09:21:15 INFO - PROCESS | 27364 | |0;ai-astar;101;111;111;110;112;111;109;110;110;111 09:21:15 INFO - PROCESS | 27364 | |1;audio-beat-detection;149;117;117;160;125;119;118;118;156;121 09:21:15 INFO - PROCESS | 27364 | |2;audio-dft;161;162;161;162;160;163;161;160;160;160 09:21:15 INFO - PROCESS | 27364 | |3;audio-fft;76;75;76;111;76;75;76;76;101;75 09:21:15 INFO - PROCESS | 27364 | |4;audio-oscillator;83;82;115;84;84;83;98;83;81;116 09:21:15 INFO - PROCESS | 27364 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;117 09:21:15 INFO - PROCESS | 27364 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;146 09:21:15 INFO - PROCESS | 27364 | |7;imaging-desaturate;86;85;85;85;85;85;85;85;85;85 09:21:15 INFO - PROCESS | 27364 | |8;json-parse-financial;51;51;51;52;50;51;49;50;51;52 09:21:15 INFO - PROCESS | 27364 | |9;json-stringify-tinderbox;58;59;59;59;63;59;58;59;60;60 09:21:15 INFO - PROCESS | 27364 | |10;stanford-crypto-aes;78;76;74;76;76;75;78;81;75;76 09:21:15 INFO - PROCESS | 27364 | |11;stanford-crypto-ccm;129;121;130;120;127;120;119;118;162;130 09:21:15 INFO - PROCESS | 27364 | |12;stanford-crypto-pbkdf2;158;165;156;152;153;152;152;152;155;154 09:21:15 INFO - PROCESS | 27364 | |13;stanford-crypto-sha256-iterative;62;64;63;64;70;62;62;61;61;61 09:21:15 INFO - PROCESS | 27364 | __end_tp_report 09:21:15 INFO - PROCESS | 27364 | __start_cc_report 09:21:15 INFO - PROCESS | 27364 | _x_x_mozilla_cycle_collect,1581 09:21:15 INFO - PROCESS | 27364 | __end_cc_report 09:21:15 INFO - PROCESS | 27364 | __startTimestamp1484932875110__endTimestamp 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | ------- Summary: start ------- 09:21:15 INFO - PROCESS | 27364 | Number of tests: 14 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:0.88 09:21:15 INFO - PROCESS | 27364 | Values: 101.0 111.0 111.0 110.0 112.0 111.0 109.0 110.0 110.0 111.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:123.00 stddev:17.61 (14.3%) stddev-sans-first:17.28 09:21:15 INFO - PROCESS | 27364 | Values: 149.0 117.0 117.0 160.0 125.0 119.0 118.0 118.0 156.0 121.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 09:21:15 INFO - PROCESS | 27364 | Values: 161.0 162.0 161.0 162.0 160.0 163.0 161.0 160.0 160.0 160.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:13.03 (17.1%) stddev-sans-first:13.66 09:21:15 INFO - PROCESS | 27364 | Values: 76.0 75.0 76.0 111.0 76.0 75.0 76.0 76.0 101.0 75.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:13.83 (16.7%) stddev-sans-first:14.37 09:21:15 INFO - PROCESS | 27364 | Values: 83.0 82.0 115.0 84.0 84.0 83.0 98.0 83.0 81.0 116.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:21:15 INFO - PROCESS | 27364 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:21:15 INFO - PROCESS | 27364 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 09:21:15 INFO - PROCESS | 27364 | Values: 86.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.92 (1.8%) stddev-sans-first:0.97 09:21:15 INFO - PROCESS | 27364 | Values: 51.0 51.0 51.0 52.0 50.0 51.0 49.0 50.0 51.0 52.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.43 (2.4%) stddev-sans-first:1.42 09:21:15 INFO - PROCESS | 27364 | Values: 58.0 59.0 59.0 59.0 63.0 59.0 58.0 59.0 60.0 60.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:2.01 (2.6%) stddev-sans-first:2.06 09:21:15 INFO - PROCESS | 27364 | Values: 78.0 76.0 74.0 76.0 76.0 75.0 78.0 81.0 75.0 76.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:128.00 stddev:13.01 (10.2%) stddev-sans-first:13.79 09:21:15 INFO - PROCESS | 27364 | Values: 129.0 121.0 130.0 120.0 127.0 120.0 119.0 118.0 162.0 130.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:154.50 stddev:4.09 (2.7%) stddev-sans-first:4.19 09:21:15 INFO - PROCESS | 27364 | Values: 158.0 165.0 156.0 152.0 153.0 152.0 152.0 152.0 155.0 154.0 09:21:15 INFO - PROCESS | 27364 | 09:21:15 INFO - PROCESS | 27364 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.50 stddev:2.71 (4.3%) stddev-sans-first:2.85 09:21:15 INFO - PROCESS | 27364 | Values: 62.0 64.0 63.0 64.0 70.0 62.0 62.0 61.0 61.0 61.0 09:21:15 INFO - PROCESS | 27364 | -------- Summary: end -------- 09:21:15 INFO - PROCESS | 27364 | 09:21:16 INFO - TEST-INFO | 27364: exit 0 09:21:16 INFO - TEST-OK | kraken | took 60214ms 09:21:16 INFO - SUITE-END | took 1175s 09:21:16 INFO - Completed test suite (00:19:35) 09:21:16 INFO - javascript benchmark 09:21:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3196.0571631368753, 3221.8872339468116, 3245.9999999999986, 3266.183454136466, 3282.3599398117362, 5588.273524441822, 5625.099984002561, 5634.859128521789, 5643.379228284891, 5655.434456554342, 5636.577256705743, 5672.290963629546, 5687.7156142192935, 5691.117876729103, 5737.827865164052, 5131.692098474104, 5135.127028405162, 5153.56194723449, 5176.792928282883, 5220.190870415092, 5017.52333528316, 5212.452692467275, 5228.816991405301, 5230.790768369279, 5234.92147617786, 4967.552920237178, 5060.924086138711, 5104.591632669378, 5109.642325037249, 5129.0767661820855, 5174.783925777439, 5184.1186998210205, 5269.104252277122, 5270.894582108374, 5292.52367286946, 4936.827211047632, 5086.618503612207, 5178.0679477694, 5224.947750522484, 5229.163333866563, 5469.671819690831, 5485.067538518461, 5492.752826122834, 5534.695591742453, 5556.277683901108, 5963.4334738199805, 5969.611975221596, 6066.302375226861, 6074.179985701918, 6084.908726369108, 5903.616264942808, 6095.634261944298, 6097.847553811146, 6119.571629985903, 6126.111713801519, 5545.694986775726, 5588.608797384185, 5653.802116925888, 5670.206171136044, 5739.454751798572, 6251.3123556408755, 6253.6873156342, 6257.43683068526, 6258.0, 6268.09112678659, 5781.682007489629, 6004.849878752979, 6007.729652165663, 6009.399060093956, 6011.519078473799, 5896.705164741746, 5990.221271234799, 6033.849153771103, 6042.486388657014, 6120.14317995481, 6063.696815159225, 6074.605150665193, 6087.299960504599, 6107.053406721965, 6120.112583675342, 6028.216331876828, 6041.214642096587, 6069.241344831896, 6087.086936959403, 6091.2081429414775, 4543.45478542577, 4581.656375771764, 4678.461976872635, 4694.882627934329, 4718.150732868048, 4232.153569286155, 4232.449781528443, 4251.298535741568, 4251.80866860992, 4277.529471758104, 5894.852628684317, 5899.321578018497, 5899.793507227312, 5905.261842269716, 5913.201717768046, 5923.111533270044, 5953.732082056318, 5958.314793798769, 5973.074173503114, 6219.222597175353, 5727.284089488814, 5739.483446489752, 5743.54051675865, 5745.13822926556, 5752.827415177551, 5246.816361427332, 5262.868428289324, 5298.6290959633225, 5308.761105750251, 5384.515393614593, 6420.582662126947, 6429.7428102875365, 6435.839104022437, 6450.935490645127, 6457.5479716419395, 6156.353582873734, 6164.660943648142, 6207.96896015517, 6210.5652604317265, 6217.658028808459, 6109.694515274307, 6117.279373342116, 6238.189035425366, 6258.968705156445, 6346.048092785934, 5922.3485416605, 5930.0, 6030.185924900083, 6046.123312119806, 6058.697065146813, 6039.728212230548, 6054.90917636227, 6057.0, 6115.021596544531, 6152.753889844356, 5753.712314384347, 5789.623674461315, 5840.328362238397, 5983.162357270073, 6000.279966404059, 5850.5027072699295, 5922.7927022554, 5926.436988486087, 5945.524358051259, 5964.761409543743, 5828.883422331614, 5831.94168058314, 5849.912251316318, 5871.442212989759, 5885.676287804212, 5845.064789633639, 5902.61632993854, 5964.821055368346, 5967.791127310524, 5979.40205979416, 5731.083026715705, 5734.311882574118, 5754.53963682896, 5764.884702306014, 5908.202392676933], "value": 5596.362645627681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.9475649813269, 613.809718987114, 631.4979591224974, 664.528184988658, 670.7954074007432, 34128.65871341286, 37235.441468378, 37251.4412283816, 37269.62730372696, 37282.0, 37431.4385284221, 38149.23701525968, 45878.31182532265, 47065.29402058972, 47079.76460117695, 8801.823963520726, 8936.821263574724, 8937.865932011026, 8946.373753837233, 8947.32895032875, 8825.205731484166, 8913.732588022369, 8915.73252802417, 8924.687635932743, 8932.64269429222, 8529.957350213272, 8739.4756314621, 8939.106089391074, 10618.840717389245, 10865.728356791064, 10578.52396642153, 10643.680689579325, 10657.626983055594, 10715.30350527221, 10728.088112510406, 10331.380117192992, 10400.583976640924, 10446.843297350546, 10451.477426128738, 10457.424841633707, 34419.82790086058, 34970.65029349699, 42855.57144428547, 42879.57120428787, 43681.0, 3506.9824650876835, 3507.2108775525558, 3519.6128425873135, 3589.353916295066, 3926.5288165420047, 33013.83493082519, 33057.50413743796, 33136.0, 33258.6674133258, 33450.49824252638, 3809.257194847006, 3877.2827027000094, 3877.8836634900717, 3955.9011024724323, 3999.42008408782, 351822.0, 353261.0, 353933.0, 354899.99999999744, 355236.0, 60305.0, 60771.392286076574, 60786.696066519384, 60838.0, 60863.69568152219, 64799.67600161969, 64917.35082649113, 65062.0, 65181.0, 65265.34734652593, 17964.461066168034, 18198.0, 18242.54393640143, 18498.352557660688, 18502.074896255133, 14437.927810360881, 14504.782428263585, 14526.346314415876, 14704.852951470562, 14724.26378681083, 15169.696606067817, 16581.83418165827, 16950.91524542394, 16988.915055424644, 17018.0, 5509.807156749494, 6492.935070649328, 6539.313372095861, 6588.40704336612, 6672.666366681647, 986.4278718343344, 1011.7774089700254, 1069.2568664777905, 1094.4637127807316, 1105.618561596248, 32032.0, 32424.189395265308, 32513.34973300568, 32545.186370340456, 33152.3369532608, 1127.6053381316638, 1142.2917790969652, 1159.3913195572393, 1188.8216767484946, 1205.8854408831146, 16347.427840025543, 17284.481465556055, 17365.7395139073, 17405.659441987715, 17406.738898916527, 493191.0, 495951.0, 496840.0, 498514.0, 499514.0, 58930.0, 58995.70502147462, 59046.704766475894, 59082.40917590769, 59219.40780592225, 1353.2692346133174, 1366.9658258543616, 1374.5120482228865, 1379.8689124533355, 1392.5474220878255, 30423.69576304297, 31386.372272554876, 31818.68181318157, 32016.51975220327, 32228.19429514281, 51161.0, 51641.48358516367, 51660.0, 51727.74136129295, 51901.0, 431489.0, 434252.0, 434541.0, 435600.0, 436042.0, 36405.81797090998, 36884.262314754094, 38588.80705596454, 41996.37005444982, 42224.57775422207, 45714.54285457103, 45798.77100614476, 46001.30998035099, 46031.53968460273, 48092.759536202095, 38409.0, 41592.792036039624, 42399.40014996251, 43145.35281970836, 43552.56447435485, 41986.1602767949, 42237.78881105698, 42490.36264456098, 43783.562164377945, 44058.33912491379, 41161.0, 41857.58142418659, 41939.161216776105, 42049.369259461746, 42361.78819105885, 36089.27821443609, 37470.625293746714, 37980.62019379771, 38415.807920960215, 38499.80750096231, 28316.0, 28558.857205713837, 28578.428431431672, 28651.0, 28659.856700716362], "value": 20525.813657304727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7879292164538, 429.8130313313709, 431.35202202318646, 434.17723414130216, 437.49469362885856, 18903.71644425333, 20316.0, 20414.0, 20753.273635422727, 21040.368788936317, 19064.80935190651, 19458.318958836444, 19636.0, 19911.900440497815, 20413.183472661076, 5119.411267704225, 5330.866728331784, 5336.466353364672, 5342.599305052117, 5343.812966546172, 5152.819651312205, 5184.1186998210205, 5260.395054568736, 5276.604254680895, 5330.040592693314, 5241.292425522543, 5246.711430871301, 5253.44838791927, 5254.894902101955, 5281.075811732951, 5194.948050519484, 5253.0544501989625, 5261.053010458116, 5823.737931793079, 5856.590038697293, 5275.736213189363, 5278.762455689503, 5285.339332583427, 5290.65610735301, 5290.788368465257, 13180.604581862559, 13244.536441224607, 13245.536406225736, 13256.602301930958, 20198.0, 2244.438890277431, 2275.380384242497, 2301.2635956493928, 2562.987185064063, 2749.766269867064, 9768.609255629766, 9903.0, 9941.90058099417, 10000.449975251358, 10076.748081298027, 1896.468988683171, 1919.5472243248212, 1958.8530860185401, 1970.2611520679745, 2035.4402539301661, 81559.5922020386, 84323.0, 93094.0, 93689.53155234248, 96222.9999999993, 10718.24972251935, 11019.779604407868, 11235.438228088562, 11246.156538259664, 11287.645482541984, 15303.46437874669, 15312.081275123528, 15356.385744570316, 15356.692866142615, 15373.461928832661, 8553.486790792447, 8771.561421928878, 8791.164839340381, 8830.690925817566, 8874.068222836639, 8789.516576588348, 8817.911820881838, 8885.911140888638, 9054.86417703735, 9055.0, 4273.273543497613, 4460.553944605578, 4502.302143167814, 4585.243434833282, 4630.3748993886065, 1873.278787666758, 1899.819517145869, 1916.5017095555256, 1926.5087402712218, 1927.363969889933, 977.237754551451, 985.7880555680563, 1007.4660429972126, 1058.343826827372, 1087.8694556653252, 18674.0, 20464.69302960457, 20489.795102049087, 20496.077676504592, 20649.69025464589, 977.9853302200472, 978.3200675530438, 990.5443495991924, 1003.1623594298842, 1004.864343313658, 10652.62715804943, 11461.598844040585, 11554.306741595532, 11633.6509904703, 11667.241629294069, 469538.0, 473358.0, 478759.0, 479211.0, 480947.0, 92319.53840230756, 93896.0, 94428.0, 94789.5260523693, 95045.52477237569, 1003.5132960514145, 1034.4672493665769, 1042.9582816687248, 1116.2967330581682, 1118.558169523034, 17379.304827806747, 17744.3789467368, 17937.37219197322, 18075.36736214226, 18128.365507207185, 42641.36037959495, 43597.56402436062, 45001.09997800091, 45067.54932450765, 46352.0, 59308.40691593029, 59681.40318596758, 59850.70074649599, 60508.69745651243, 61059.694701526205, 8439.620217090369, 8697.652093916173, 8706.91293087061, 8719.34604904622, 8740.825183496421, 9835.409875407498, 13365.131266467648, 13484.528041518892, 13711.108777929403, 13912.51306204278, 11832.82250766222, 11851.585194518151, 11956.521739130338, 12145.0, 12335.814962775745, 10642.521086550969, 11286.774264514828, 11571.0, 11600.129990250934, 11743.706407339885, 8322.958385208036, 12094.315671634318, 12588.748225035632, 12701.110922235355, 12753.936230318788, 11930.22453540517, 12794.104412691022, 13046.34768261602, 13281.136726112773, 13350.0, 12275.570355037888, 12343.382830858242, 12351.320677362832, 12400.19398739079, 12919.418626162033], "value": 9315.493708260103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.8096266522682, 1485.8291296500906, 1486.9033512821666, 1636.6235765773872, 1812.6465339258834, 7695.3458955988735, 8444.957775211124, 8634.26608738258, 8658.567071646416, 8927.37508374414, 8739.388242823004, 8813.383063185564, 8814.77963050924, 8817.603207855645, 8819.338549608789, 2397.916072937443, 2428.9271321860374, 2434.5982912819363, 2436.768506991833, 2449.020391843259, 2367.6922000139957, 2427.8179136564827, 2448.4980578981267, 2449.326435230317, 2463.1379017343966, 2371.4664200554907, 2383.6067048936907, 2396.209250947192, 2411.8794060296914, 2414.408469924871, 2210.602091623507, 2270.4664403865077, 2351.7648235176516, 2391.1033362489065, 2391.8564886106888, 2334.3113781434517, 2335.859848409101, 2363.1138323128826, 2364.6216605343234, 2364.9408764780846, 8616.65533378664, 8788.8681669775, 8807.867881981776, 8810.86783698245, 8817.16236957488, 5220.0, 5221.503957124067, 5316.282301889234, 5368.865778355534, 5369.328833895763, 3226.2579606690592, 3306.5866766654167, 3342.8495717692763, 3377.783997760804, 3402.6086999994823, 957.9856302155473, 963.2775418436173, 992.9404235745878, 1019.9592016319339, 1032.0, 11955.462004209832, 11986.101042421766, 12101.455434505468, 12202.0, 12208.633740987785, 4442.777861106932, 4617.053504031665, 4672.883177920579, 4750.121227572841, 4757.9286310705365, 9703.854442183232, 9725.173360264456, 9729.221662267002, 9730.805383892282, 9743.464109474047, 5341.172118321666, 5342.9465705342445, 5343.465653434703, 5345.0, 5348.090824559834, 4415.183191109655, 4451.577100175478, 4915.361003069578, 5023.974880125649, 5024.673396229234, 3799.6200379962333, 3860.6718428933855, 3911.902202444962, 3921.156951255494, 3964.524257089168, 1179.9528018879148, 1185.6561597136906, 1192.7912615292462, 1204.1330242225583, 1207.2032458577296, 813.979650508742, 918.4948278446961, 933.1554942776797, 943.6319835264252, 969.9078587534173, 5508.6970216637665, 5653.689047102449, 5690.971545142248, 5821.825345239565, 5856.033754430471, 461.3932678527725, 479.2547588499916, 481.9783109760069, 989.0752146742818, 1039.7712503249272, 3987.501562304712, 4135.483064616923, 4162.167566486714, 4175.68682348825, 4206.894827629334, 10378.325408848552, 10966.396848173426, 10977.176711746652, 10978.945105274423, 11010.50452729613, 10815.40515271652, 10820.13438924884, 10832.512536935857, 10857.837132443019, 10886.346819190874, 8190.303824174893, 8222.301104406073, 8326.70856520019, 8326.70856520019, 8334.12491688376, 5711.143328500758, 5711.543076553949, 5780.364159942319, 5786.218860453785, 5853.736581853742, 9758.75603109928, 9810.264230182622, 9826.65606703762, 9952.950235248778, 9954.651587194414, 9489.762755931157, 9884.209263259067, 9899.0, 10106.292559520763, 10133.03736145065, 6988.126484189476, 7172.892406613801, 7173.0, 7774.572398518136, 7935.722249721232, 8156.347492200491, 8210.630521626661, 8364.330853531581, 8618.482891026559, 8621.180987806149, 7578.886316705143, 7620.237976202336, 7667.731629392944, 7675.385969122345, 7684.385249180164, 7474.588897610466, 7616.695332186872, 7661.693532258647, 7712.5758083305955, 7764.883526747216, 6874.6562671867205, 7138.46461515378, 7162.677679504331, 7170.211276759656, 7179.425645948416, 5093.414257360303, 5110.259012443249, 5146.279520867007, 5178.326817513699, 5251.553617942518, 5151.201563757623, 5172.405173405106, 5186.844394668166, 5234.764435600331, 5254.238135470259], "value": 4555.061109232745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3597871979399, 347.1339009172116, 351.6764576589537, 354.92901419716065, 356.62198070045736, 5349.893002139955, 5358.490943360384, 5369.9463005369935, 5377.919331210025, 5415.9458405415935, 5046.646734728571, 5152.252923326116, 5195.766190521426, 5205.141151709973, 5307.0, 4184.95376155961, 4187.51843537994, 4203.47456567929, 4206.537280899099, 4218.641415479688, 4199.874003779892, 4232.682548808836, 4233.407322974786, 4242.257604919127, 4245.80893859777, 3939.5863434339412, 3993.2612466693754, 4162.916741665165, 4163.355474587536, 4215.346621273708, 4165.166966606661, 4172.5410204877435, 4182.121754431573, 4183.477065366829, 4192.24539582875, 3716.4053751399915, 3728.3475391806596, 3729.0118118698565, 3735.9252814943547, 3742.8315725792404, 5081.606262887527, 5149.459306772772, 5168.511254902963, 5214.165733482625, 5214.634975551713, 4793.832215872462, 4801.135795556798, 4804.5916097131785, 4809.86968062505, 4812.1578723723205, 5566.387697353288, 5576.581756368248, 5582.665040097567, 5585.2459917910965, 5602.243697100921, 3904.2777086239134, 4085.468889044435, 4127.215828992482, 4128.4632997710405, 4129.380592911058, 5776.422357764232, 5790.594658373915, 5791.420857914217, 5794.536437085023, 5807.332156801979, 4198.160367926427, 4202.2646036943415, 4202.621764041251, 4206.158768246363, 4222.113356195234, 4163.417121602978, 4235.682323825726, 4257.829686812554, 4267.591694740728, 4276.337167739005, 4796.304535842353, 4799.232122860395, 4802.807887684454, 4805.447373552086, 4811.158047341772, 5600.271964644651, 5607.0, 5616.803411880564, 5617.775288988395, 5639.182318563785, 1397.2035939514378, 1408.9080962254334, 1415.1933397963062, 1424.6082327359852, 1431.4039845572113, 951.6098399656108, 965.9903400966041, 984.3552473130111, 1013.2501948558014, 1014.5434554450527, 5253.605979551472, 5260.868478288074, 5265.473452654781, 5290.047791397508, 5302.867428314245, 5553.83369492403, 5559.63862348946, 5563.193336966198, 5564.944350556442, 5583.748731307101, 5123.436421993578, 5169.767360468788, 5200.193969934666, 5222.817201397933, 5275.683458992396, 2903.301568582403, 2907.680155182928, 2921.401112771877, 2921.780866435026, 2933.9413211735646, 5506.889862202814, 5667.716614169358, 5690.601657883991, 5696.743646535916, 5709.200711900337, 5521.834344969658, 5603.355614104348, 5604.747786349624, 5609.80365687199, 5629.324481062217, 5695.319880635223, 5697.9430205698245, 5705.315362156568, 5708.600397972185, 5732.34078081026, 5247.685138891678, 5483.983808905006, 5491.341039075336, 5531.419200983839, 5553.916691249715, 5498.560115190855, 5503.422140675171, 5507.862303442446, 5518.641288316247, 5538.556915446835, 5467.9453205467435, 5734.770609175753, 5747.827565173052, 5751.769929202952, 5757.481826635623, 4032.314506533955, 4041.515018197835, 4049.5545489996666, 4054.412110244057, 4130.318497448007, 5448.482394172547, 5449.536789372948, 5451.781928722807, 5501.074623881609, 5524.889502209853, 5293.311869456946, 5401.244595506398, 5406.21609866575, 5417.593680473901, 5433.673979561239, 5645.68948707825, 5650.513773939453, 5662.433756624305, 5665.065264231355, 5684.403137670485, 5395.81114660985, 5438.178210299594, 5613.596600849787, 5628.802991895264, 5644.181593668813, 5465.289512363367, 5623.606347555632, 5625.409332020079, 5632.633878797865, 5657.179708942263, 5500.50495455411, 5517.503424691797, 5543.8891222174525, 5549.501634558727, 5577.637453565505], "value": 4242.202692042101, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.2528772378513, 792.7502836606468, 796.1282395776623, 806.1293802693092, 887.6227603268609, 14838.40646374145, 15638.061716297016, 16123.75814362784, 16156.0, 16338.918305408486, 13757.931210343959, 13878.028538002343, 14153.504627338045, 14308.856911430883, 14336.784948225784, 716.4912911832605, 843.995780021099, 844.9831003379928, 847.559269180026, 849.817289282804, 743.9702411903518, 829.17911267845, 854.0136142755127, 857.6097875466647, 860.0582362313257, 888.4536010353619, 894.8791913091746, 895.2882458445519, 895.6686026170294, 896.3770179725094, 764.8432071425344, 893.249670276964, 894.4677916639622, 894.6242578117174, 895.8029233568604, 573.6013470637909, 640.1358166475268, 650.4211251985737, 654.8853950558681, 656.4485831901178, 15063.322150503254, 15103.32035058414, 15106.169160696158, 15120.319585618674, 15132.773008404884, 13914.30428478572, 14142.292885355793, 14317.284135793168, 14348.28258587077, 14357.56927292183, 12307.384630768514, 12316.5073397064, 12551.686207844878, 12572.30852303123, 12574.371281435891, 4407.140607581523, 4418.867433976986, 4437.090396468716, 4490.50604433512, 4520.751358675271, 61720.69139654318, 62251.0, 63827.68086159586, 65216.347836521505, 65439.67280163617, 11072.612458563912, 11077.50151243196, 11178.44107794607, 11425.828612570818, 11555.942220288845, 20396.694049589267, 20435.897820510803, 20449.0, 20506.58986820255, 20817.791822081886, 8361.917029891749, 8392.874106888401, 8403.453775504573, 8430.0, 8446.57767111642, 4672.299155126758, 4694.436667599842, 4710.3405523226775, 4821.662483626183, 4907.214845624683, 3484.181217413906, 3620.31214069326, 3622.728295377857, 3754.2679177560112, 3883.0, 702.9156501219886, 702.9437644988388, 711.416638356553, 724.0261847814786, 725.2855936902147, 656.2748163279603, 729.8321386081232, 737.2406421385981, 738.5384134915678, 752.1913942511821, 8816.603252853636, 8853.0, 9363.485008324471, 9389.671361502315, 9664.661736839176, 690.9861802763917, 706.6360824175554, 717.0320067908386, 723.8009547374514, 741.7774667599698, 4724.43306803179, 4850.733209673432, 4955.4796746341835, 5137.152369859006, 5223.085959956992, 72925.6353718228, 87522.56238718893, 89485.55257223803, 89691.10308896958, 92016.53991729999, 76491.23508764952, 78555.0, 80082.59958700169, 80792.19207807847, 81208.59395702984, 58450.0, 59859.700701496215, 60070.69964650149, 62086.068708969404, 70034.0, 9195.494247816434, 9418.905810942077, 9485.098915603006, 9532.90467095348, 9605.567749451151, 41906.37140442835, 42821.92945176396, 43673.34489982589, 45055.0, 45824.0, 35854.0, 57193.714031429576, 57370.0, 58307.10073318477, 58768.412315876296, 12640.0, 12651.430685618985, 12771.169873958162, 12952.158109722837, 13010.0, 13849.861501384858, 13900.998731769198, 14104.294785260901, 14200.0, 14345.139291642536, 10770.0, 12900.29048402347, 12947.676308092374, 13007.089503734647, 13073.019523535582, 12541.247525148521, 12680.9855211581, 12816.743665126458, 13041.424942458665, 13685.589432317047, 11858.40707964581, 12296.077794165294, 12681.80977285323, 12709.428075736429, 13088.214707117222, 10162.949185254027, 10466.68599942003, 10628.787424251317, 10718.624848130277, 10833.404162771123, 10570.682879513626, 10761.30051546647, 10775.407352595683, 10963.232573719763, 10986.92221639211], "value": 7274.519754948808, "unit": "score"}], "name": "dromaeo_css", "value": 7292.748831013433, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 112.0, 111.0, 109.0, 110.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 117.0, 160.0, 125.0, 119.0, 118.0, 118.0, 156.0, 121.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 160.0, 163.0, 161.0, 160.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 111.0, 76.0, 75.0, 76.0, 76.0, 101.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 84.0, 84.0, 83.0, 98.0, 83.0, 81.0, 116.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 50.0, 51.0, 49.0, 50.0, 51.0, 52.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 63.0, 59.0, 58.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 76.0, 76.0, 75.0, 78.0, 81.0, 75.0, 76.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 130.0, 120.0, 127.0, 120.0, 119.0, 118.0, 162.0, 130.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 165.0, 156.0, 152.0, 153.0, 152.0, 152.0, 152.0, 155.0, 154.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 64.0, 70.0, 62.0, 62.0, 61.0, 61.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1453.6, "alertThreshold": 2.0}]} 09:21:16 INFO - Return code: 0 09:21:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:21:16 INFO - # TBPL SUCCESS # 09:21:16 INFO - Running post-action listener: _resource_record_post_action 09:21:16 INFO - [mozharness: 2017-01-20 17:21:16.396501Z] Finished run-tests step (success) 09:21:16 INFO - Running post-run listener: _resource_record_post_run 09:21:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 355921920; Read time: 0; Write time: 297048 09:21:16 INFO - TinderboxPrint: CPU usage
13.0% 09:21:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:21:16 INFO - TinderboxPrint: I/O write bytes / time
355,921,920 / 297,048 09:21:16 INFO - TinderboxPrint: CPU idle
8,275.7 (87.0%) 09:21:16 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 09:21:16 INFO - TinderboxPrint: Swap in / out
0 / 0 09:21:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108351488; Read time: 0; Write time: 121376 09:21:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247570432; Read time: 0; Write time: 175672 09:21:17 INFO - Running post-run listener: _upload_blobber_files 09:21:17 INFO - Blob upload gear active. 09:21:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:17 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 09:21:17 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'] 09:21:17 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 09:21:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:21 INFO - (blobuploader) - INFO - Done attempting. 09:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:21 INFO - (blobuploader) - INFO - Done attempting. 09:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:21:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:22 INFO - (blobuploader) - INFO - Done attempting. 09:21:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:22 INFO - Return code: 0 09:21:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/104c47cb4d292bf2cce7c7531de3d6a21a98b6400fd288d6259eda0563201d8a2d418d0cae9d5d47904050fdf09641503edc71a8d37fc7122d0c099f633274de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3706555a21de690531ef357d21daed76bab28ab36539ebf4ef0c86e3603d096f4c0a34753a74163b2269de6be95852f582ed0253f2c6a8695cede847b4ba51dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff9ce577712cf08c75e1bb115f0cd6460b21c51f76771d9a52a12d0cb9400252bdae40297d5b720caab5d60e40b595781b2c390febbd3945d5a7d04b746a79d"} 09:21:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:22 INFO - Contents: 09:21:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/104c47cb4d292bf2cce7c7531de3d6a21a98b6400fd288d6259eda0563201d8a2d418d0cae9d5d47904050fdf09641503edc71a8d37fc7122d0c099f633274de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3706555a21de690531ef357d21daed76bab28ab36539ebf4ef0c86e3603d096f4c0a34753a74163b2269de6be95852f582ed0253f2c6a8695cede847b4ba51dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff9ce577712cf08c75e1bb115f0cd6460b21c51f76771d9a52a12d0cb9400252bdae40297d5b720caab5d60e40b595781b2c390febbd3945d5a7d04b746a79d"} 09:21:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:22 INFO - Copying logs to upload dir... 09:21:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.111621 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-20 09:21:22.685215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 09:21:22.689332) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927 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/104c47cb4d292bf2cce7c7531de3d6a21a98b6400fd288d6259eda0563201d8a2d418d0cae9d5d47904050fdf09641503edc71a8d37fc7122d0c099f633274de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3706555a21de690531ef357d21daed76bab28ab36539ebf4ef0c86e3603d096f4c0a34753a74163b2269de6be95852f582ed0253f2c6a8695cede847b4ba51dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff9ce577712cf08c75e1bb115f0cd6460b21c51f76771d9a52a12d0cb9400252bdae40297d5b720caab5d60e40b595781b2c390febbd3945d5a7d04b746a79d"} build_url:https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/C5kDXpa4Q9S7BjNY4BMQoQ/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/104c47cb4d292bf2cce7c7531de3d6a21a98b6400fd288d6259eda0563201d8a2d418d0cae9d5d47904050fdf09641503edc71a8d37fc7122d0c099f633274de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3706555a21de690531ef357d21daed76bab28ab36539ebf4ef0c86e3603d096f4c0a34753a74163b2269de6be95852f582ed0253f2c6a8695cede847b4ba51dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ff9ce577712cf08c75e1bb115f0cd6460b21c51f76771d9a52a12d0cb9400252bdae40297d5b720caab5d60e40b595781b2c390febbd3945d5a7d04b746a79d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 09:21:22.714982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:21:22.715313) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1484931645.164936-1209401927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 09:21:22.798296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 09:21:22.798606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 09:21:22.798872) ========= ========= Total master_lag: 0.15 =========