builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1484545449.66 results: success (0) buildid: 20170115200222 builduid: bd38cc1ebc244222b393c0f3b121115c revision: 02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.659500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.659960) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.660262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.678070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.678352) ========= 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=923d835db2ba3686ebe126b700000192-1484543735.160317-176674690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-15 21:44:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.9M=0s 2017-01-15 21:44:10 (49.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.810176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.810471) ========= 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=923d835db2ba3686ebe126b700000192-1484543735.160317-176674690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016114 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:09.863523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 21:44:09.863835) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0 --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 02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0 --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=923d835db2ba3686ebe126b700000192-1484543735.160317-176674690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-15 21:44:10,510 truncating revision to first 12 chars 2017-01-15 21:44:10,510 Setting DEBUG logging. 2017-01-15 21:44:10,510 attempt 1/10 2017-01-15 21:44:10,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/02d0ba8567f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 21:44:11,404 unpacking tar archive at: mozilla-aurora-02d0ba8567f3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 21:44:11.110641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:11.110917) ========= script_repo_revision: 02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:11.111311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:11.111611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 21:44:11.119134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-15 21:44:11.119437) ========= /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=923d835db2ba3686ebe126b700000192-1484543735.160317-176674690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:44:11 INFO - MultiFileLogger online at 20170115 21:44:11 in /builds/slave/test 21:44:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:44:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:44:11 INFO - {'append_to_log': False, 21:44:11 INFO - 'base_work_dir': '/builds/slave/test', 21:44:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:44:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:44:11 INFO - 'branch': 'Mozilla-Aurora', 21:44:11 INFO - 'buildbot_json_path': 'buildprops.json', 21:44:11 INFO - 'config_files': ('talos/linux_config.py',), 21:44:11 INFO - 'default_actions': ('clobber', 21:44:11 INFO - 'read-buildbot-config', 21:44:11 INFO - 'download-and-extract', 21:44:11 INFO - 'populate-webroot', 21:44:11 INFO - 'create-virtualenv', 21:44:11 INFO - 'install', 21:44:11 INFO - 'run-tests'), 21:44:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:44:11 INFO - 'download_minidump_stackwalk': True, 21:44:11 INFO - 'download_symbols': 'ondemand', 21:44:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:44:11 INFO - 'tooltool.py': '/tools/tooltool.py', 21:44:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:44:11 INFO - '/tools/misc-python/virtualenv.py')}, 21:44:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:44:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:44:11 INFO - 'installer_path': 'installer.exe', 21:44:11 INFO - 'log_level': 'info', 21:44:11 INFO - 'log_name': 'talos', 21:44:11 INFO - 'log_to_console': True, 21:44:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:44:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:44:11 INFO - 'opt_config_files': (), 21:44:11 INFO - 'pip_index': False, 21:44:11 INFO - 'sps_profile': False, 21:44:11 INFO - 'sps_profile_interval': 0, 21:44:11 INFO - 'suite': 'dromaeojs', 21:44:11 INFO - 'system_bits': '32', 21:44:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:44:11 INFO - 'title': 'talos-linux64-ix-007', 21:44:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:44:11 INFO - 'use_talos_json': True, 21:44:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:44:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:44:11 INFO - 'work_dir': 'build'} 21:44:11 INFO - [mozharness: 2017-01-16 05:44:11.859929Z] Running clobber step. 21:44:11 INFO - Running pre-action listener: _resource_record_pre_action 21:44:11 INFO - Running main action method: clobber 21:44:11 INFO - rmtree: /builds/slave/test/build 21:44:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:44:12 INFO - Running post-action listener: _resource_record_post_action 21:44:12 INFO - [mozharness: 2017-01-16 05:44:12.329339Z] Finished clobber step (success) 21:44:12 INFO - [mozharness: 2017-01-16 05:44:12.329438Z] Running read-buildbot-config step. 21:44:12 INFO - Running pre-action listener: _resource_record_pre_action 21:44:12 INFO - Running main action method: read_buildbot_config 21:44:12 INFO - Using buildbot properties: 21:44:12 INFO - { 21:44:12 INFO - "project": "", 21:44:12 INFO - "product": "firefox", 21:44:12 INFO - "script_repo_revision": "production", 21:44:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:44:12 INFO - "repository": "", 21:44:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:44:12 INFO - "buildid": "20170115200222", 21:44:12 INFO - "pgo_build": "True", 21:44:12 INFO - "basedir": "/builds/slave/test", 21:44:12 INFO - "buildnumber": 709, 21:44:12 INFO - "slavename": "talos-linux64-ix-007", 21:44:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:44:12 INFO - "platform": "ubuntu64_hw", 21:44:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:44:12 INFO - "branch": "mozilla-aurora", 21:44:12 INFO - "repo_path": "releases/mozilla-aurora", 21:44:12 INFO - "revision": "02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0", 21:44:12 INFO - "stage_platform": "linux64-pgo", 21:44:12 INFO - "builduid": "bd38cc1ebc244222b393c0f3b121115c", 21:44:12 INFO - "slavebuilddir": "test" 21:44:12 INFO - } 21:44:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 21:44:12 INFO - Running post-action listener: _resource_record_post_action 21:44:12 INFO - [mozharness: 2017-01-16 05:44:12.331846Z] Finished read-buildbot-config step (success) 21:44:12 INFO - [mozharness: 2017-01-16 05:44:12.331934Z] Running download-and-extract step. 21:44:12 INFO - Running pre-action listener: _resource_record_pre_action 21:44:12 INFO - Running main action method: download_and_extract 21:44:12 INFO - mkdir: /builds/slave/test/build/tests 21:44: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')]} 21:44:12 INFO - trying https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:44:12 INFO - Downloading https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:44:12 INFO - Downloaded 1361 bytes. 21:44:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:44:12 INFO - Using the following test package requirements: 21:44:12 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:44:12 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:44:12 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:44:12 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'jsshell-linux-x86_64.zip'], 21:44:12 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:44:12 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:44:12 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:44:12 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:44:12 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:44:12 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:44:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:44:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:44:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:44:12 INFO - Fetch https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:44:13 INFO - Http code: 200 21:44:13 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 21:44:13 INFO - x-amz-cf-id: iTZ3I7Zb0GQn9kMXHZ2GlYZ-6xnuwkNgqUsvYu0F0PT4BmrKfqKlig== 21:44:13 INFO - x-amz-version-id: K9z2IjMwNFXBBpSbPL5dUb_08ehF11nl 21:44:13 INFO - Expected file size: 21949134 21:44:13 INFO - Obtained file size: 21949134 21:44:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:44:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:44:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:44:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:44:18 INFO - Http code: 200 21:44:18 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 21:44:18 INFO - x-amz-cf-id: LT7Nug8aHldFKrv3G-MVlMSCeiJvgu3HK_tDAmcz6hmCe2NyCMlTmg== 21:44:18 INFO - x-amz-version-id: K9z2IjMwNFXBBpSbPL5dUb_08ehF11nl 21:44:18 INFO - Expected file size: 21949134 21:44:18 INFO - Obtained file size: 21949134 21:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 21:44:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:44:23 INFO - Fetch https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:44:23 INFO - Http code: 200 21:44:23 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 21:44:23 INFO - x-amz-cf-id: Te0Y5NUGpCuoKaCBgNHiXh4TnhRtBIyq0WHoVfIEGVT6fbjDexm4NQ== 21:44:23 INFO - x-amz-version-id: RM6a6SmAWwRyqhkBwk.Mr4cvQMvE1dWN 21:44:23 INFO - Expected file size: 14409038 21:44:23 INFO - Obtained file size: 14409038 21:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:24 INFO - trying https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:44:24 INFO - Downloading https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:44:26 INFO - Downloaded 64163343 bytes. 21:44:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:44:26 INFO - mkdir: /builds/slave/test/properties 21:44:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:44:26 INFO - Writing to file /builds/slave/test/properties/build_url 21:44:26 INFO - Contents: 21:44:26 INFO - build_url:https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:44:26 INFO - Running post-action listener: _resource_record_post_action 21:44:26 INFO - Running post-action listener: set_extra_try_arguments 21:44:26 INFO - [mozharness: 2017-01-16 05:44:26.738335Z] Finished download-and-extract step (success) 21:44:26 INFO - [mozharness: 2017-01-16 05:44:26.738562Z] Running populate-webroot step. 21:44:26 INFO - Running pre-action listener: _resource_record_pre_action 21:44:26 INFO - Running main action method: populate_webroot 21:44:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:44:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:44:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:44:26 INFO - '--tppagecycles', 21:44:26 INFO - '7'], 21:44:26 INFO - 'tests': ['tsvgm']}}, 21:44:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:44:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:44:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:44:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:44:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:44:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:44:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['damp', 'tps']}, 21:44:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'tests': ['damp', 'tps']}, 21:44:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['dromaeo_dom']}, 21:44:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:44:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['basic_compositor_video']}, 21:44:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:44:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['a11yr', 21:44:26 INFO - 'ts_paint', 21:44:26 INFO - 'tpaint', 21:44:26 INFO - 'sessionrestore', 21:44:26 INFO - 'sessionrestore_no_auto_restore', 21:44:26 INFO - 'tabpaint']}, 21:44:26 INFO - 'other-e10s': {'tests': ['a11yr', 21:44:26 INFO - 'ts_paint', 21:44:26 INFO - 'tpaint', 21:44:26 INFO - 'sessionrestore', 21:44:26 INFO - 'sessionrestore_no_auto_restore', 21:44:26 INFO - 'tabpaint']}, 21:44:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:44:26 INFO - 'ts_paint', 21:44:26 INFO - 'tpaint', 21:44:26 INFO - 'sessionrestore', 21:44:26 INFO - 'sessionrestore_no_auto_restore', 21:44:26 INFO - 'tabpaint']}, 21:44:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:44:26 INFO - 'ts_paint', 21:44:26 INFO - 'tpaint', 21:44:26 INFO - 'sessionrestore', 21:44:26 INFO - 'sessionrestore_no_auto_restore', 21:44:26 INFO - 'tabpaint']}, 21:44:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['a11yr', 21:44:26 INFO - 'ts_paint', 21:44:26 INFO - 'tpaint', 21:44:26 INFO - 'sessionrestore', 21:44:26 INFO - 'sessionrestore_no_auto_restore', 21:44:26 INFO - 'tabpaint']}, 21:44:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['a11yr', 21:44:26 INFO - 'ts_paint', 21:44:26 INFO - 'tpaint', 21:44:26 INFO - 'sessionrestore', 21:44:26 INFO - 'sessionrestore_no_auto_restore', 21:44:26 INFO - 'tabpaint']}, 21:44:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['tsvgx', 21:44:26 INFO - 'tsvgr_opacity', 21:44:26 INFO - 'tart', 21:44:26 INFO - 'tscrollx', 21:44:26 INFO - 'cart']}, 21:44:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:44:26 INFO - 'tsvgr_opacity', 21:44:26 INFO - 'tart', 21:44:26 INFO - 'tscrollx', 21:44:26 INFO - 'cart']}, 21:44:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'talos_options': ['--disable-e10s'], 21:44:26 INFO - 'tests': ['tp5o']}, 21:44:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'tests': ['tp5o']}, 21:44:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'talos_options': ['--disable-e10s', 21:44:26 INFO - '--xperf_path', 21:44:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:44:26 INFO - 'tests': ['tp5n']}, 21:44:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:26 INFO - 'talos_options': ['--xperf_path', 21:44:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:44:26 INFO - 'tests': ['tp5n']}}, 21:44:26 INFO - 'talos.zip': {'path': '', 21:44:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:44:26 INFO - Running post-action listener: _resource_record_post_action 21:44:26 INFO - [mozharness: 2017-01-16 05:44:26.757572Z] Finished populate-webroot step (success) 21:44:26 INFO - [mozharness: 2017-01-16 05:44:26.757660Z] Running create-virtualenv step. 21:44:26 INFO - Running pre-action listener: _resource_record_pre_action 21:44:26 INFO - Running main action method: create_virtualenv 21:44:26 INFO - Creating virtualenv /builds/slave/test/build/venv 21:44:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:44:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:44:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:44:26 INFO - Using real prefix '/usr' 21:44:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:44:27 INFO - Installing distribute.............................................................................................................................................................................................done. 21:44:29 INFO - Installing pip.................done. 21:44:29 INFO - Return code: 0 21:44:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:44:29 INFO - Reading from file tmpfile_stdout 21:44:29 INFO - Output received: 21:44:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:44:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:29 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:44:29 INFO - Using env: {'DISPLAY': ':0', 21:44:29 INFO - 'HOME': '/home/cltbld', 21:44:29 INFO - 'LANG': 'en_US.UTF-8', 21:44:29 INFO - 'LANGUAGE': 'en_US:en', 21:44:29 INFO - 'LOGNAME': 'cltbld', 21:44:29 INFO - 'MAIL': '/var/mail/cltbld', 21:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:29 INFO - 'MOZ_NO_REMOTE': '1', 21:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:29 INFO - 'NO_EM_RESTART': '1', 21:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:29 INFO - 'PWD': '/builds/slave/test', 21:44:29 INFO - 'SHELL': '/bin/bash', 21:44:29 INFO - 'SHLVL': '1', 21:44:29 INFO - 'TERM': 'linux', 21:44:29 INFO - 'TMOUT': '86400', 21:44:29 INFO - 'USER': 'cltbld', 21:44:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:29 INFO - '_': '/tools/buildbot/bin/python'} 21:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:44:29 INFO - Cleaning up... 21:44:29 INFO - Return code: 0 21:44:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:29 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:44:29 INFO - Using env: {'DISPLAY': ':0', 21:44:29 INFO - 'HOME': '/home/cltbld', 21:44:29 INFO - 'LANG': 'en_US.UTF-8', 21:44:29 INFO - 'LANGUAGE': 'en_US:en', 21:44:29 INFO - 'LOGNAME': 'cltbld', 21:44:29 INFO - 'MAIL': '/var/mail/cltbld', 21:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:29 INFO - 'MOZ_NO_REMOTE': '1', 21:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:29 INFO - 'NO_EM_RESTART': '1', 21:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:29 INFO - 'PWD': '/builds/slave/test', 21:44:29 INFO - 'SHELL': '/bin/bash', 21:44:29 INFO - 'SHLVL': '1', 21:44:29 INFO - 'TERM': 'linux', 21:44:29 INFO - 'TMOUT': '86400', 21:44:29 INFO - 'USER': 'cltbld', 21:44:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:29 INFO - '_': '/tools/buildbot/bin/python'} 21:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:29 INFO - Downloading/unpacking psutil>=3.1.1 21:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:44:32 INFO - Installing collected packages: psutil 21:44:32 INFO - Running setup.py install for psutil 21:44:32 INFO - building 'psutil._psutil_linux' extension 21:44:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:44:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:44:32 INFO - building 'psutil._psutil_posix' extension 21:44:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:44:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:44:32 INFO - Successfully installed psutil 21:44:32 INFO - Cleaning up... 21:44:32 INFO - Return code: 0 21:44:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:32 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:44:32 INFO - Using env: {'DISPLAY': ':0', 21:44:32 INFO - 'HOME': '/home/cltbld', 21:44:32 INFO - 'LANG': 'en_US.UTF-8', 21:44:32 INFO - 'LANGUAGE': 'en_US:en', 21:44:32 INFO - 'LOGNAME': 'cltbld', 21:44:32 INFO - 'MAIL': '/var/mail/cltbld', 21:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:32 INFO - 'MOZ_NO_REMOTE': '1', 21:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:32 INFO - 'NO_EM_RESTART': '1', 21:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:32 INFO - 'PWD': '/builds/slave/test', 21:44:32 INFO - 'SHELL': '/bin/bash', 21:44:32 INFO - 'SHLVL': '1', 21:44:32 INFO - 'TERM': 'linux', 21:44:32 INFO - 'TMOUT': '86400', 21:44:32 INFO - 'USER': 'cltbld', 21:44:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:32 INFO - '_': '/tools/buildbot/bin/python'} 21:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:44:34 INFO - Installing collected packages: mozsystemmonitor 21:44:34 INFO - Running setup.py install for mozsystemmonitor 21:44:35 INFO - Successfully installed mozsystemmonitor 21:44:35 INFO - Cleaning up... 21:44:35 INFO - Return code: 0 21:44:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:35 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:44:35 INFO - Using env: {'DISPLAY': ':0', 21:44:35 INFO - 'HOME': '/home/cltbld', 21:44:35 INFO - 'LANG': 'en_US.UTF-8', 21:44:35 INFO - 'LANGUAGE': 'en_US:en', 21:44:35 INFO - 'LOGNAME': 'cltbld', 21:44:35 INFO - 'MAIL': '/var/mail/cltbld', 21:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:35 INFO - 'MOZ_NO_REMOTE': '1', 21:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:35 INFO - 'NO_EM_RESTART': '1', 21:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:35 INFO - 'PWD': '/builds/slave/test', 21:44:35 INFO - 'SHELL': '/bin/bash', 21:44:35 INFO - 'SHLVL': '1', 21:44:35 INFO - 'TERM': 'linux', 21:44:35 INFO - 'TMOUT': '86400', 21:44:35 INFO - 'USER': 'cltbld', 21:44:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:35 INFO - '_': '/tools/buildbot/bin/python'} 21:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:35 INFO - Downloading/unpacking jsonschema==2.5.1 21:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:44:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:37 INFO - Downloading functools32-3.2.3-2.tar.gz 21:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:44:37 INFO - warning: no files found matching '*.txt' 21:44:37 INFO - no previously-included directories found matching 'build' 21:44:37 INFO - no previously-included directories found matching 'dist' 21:44:37 INFO - no previously-included directories found matching '.git*' 21:44:37 INFO - Installing collected packages: jsonschema, functools32 21:44:37 INFO - Running setup.py install for functools32 21:44:37 INFO - warning: no files found matching '*.txt' 21:44:37 INFO - no previously-included directories found matching 'build' 21:44:37 INFO - no previously-included directories found matching 'dist' 21:44:37 INFO - no previously-included directories found matching '.git*' 21:44:37 INFO - Successfully installed jsonschema functools32 21:44:37 INFO - Cleaning up... 21:44:37 INFO - Return code: 0 21:44:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:37 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:44:37 INFO - Using env: {'DISPLAY': ':0', 21:44:37 INFO - 'HOME': '/home/cltbld', 21:44:37 INFO - 'LANG': 'en_US.UTF-8', 21:44:37 INFO - 'LANGUAGE': 'en_US:en', 21:44:37 INFO - 'LOGNAME': 'cltbld', 21:44:37 INFO - 'MAIL': '/var/mail/cltbld', 21:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:37 INFO - 'MOZ_NO_REMOTE': '1', 21:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:37 INFO - 'NO_EM_RESTART': '1', 21:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:37 INFO - 'PWD': '/builds/slave/test', 21:44:37 INFO - 'SHELL': '/bin/bash', 21:44:37 INFO - 'SHLVL': '1', 21:44:37 INFO - 'TERM': 'linux', 21:44:37 INFO - 'TMOUT': '86400', 21:44:37 INFO - 'USER': 'cltbld', 21:44:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:37 INFO - '_': '/tools/buildbot/bin/python'} 21:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:44:37 INFO - Cleaning up... 21:44:37 INFO - Return code: 0 21:44:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:44:38 INFO - Using env: {'DISPLAY': ':0', 21:44:38 INFO - 'HOME': '/home/cltbld', 21:44:38 INFO - 'LANG': 'en_US.UTF-8', 21:44:38 INFO - 'LANGUAGE': 'en_US:en', 21:44:38 INFO - 'LOGNAME': 'cltbld', 21:44:38 INFO - 'MAIL': '/var/mail/cltbld', 21:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:38 INFO - 'MOZ_NO_REMOTE': '1', 21:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:38 INFO - 'NO_EM_RESTART': '1', 21:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:38 INFO - 'PWD': '/builds/slave/test', 21:44:38 INFO - 'SHELL': '/bin/bash', 21:44:38 INFO - 'SHLVL': '1', 21:44:38 INFO - 'TERM': 'linux', 21:44:38 INFO - 'TMOUT': '86400', 21:44:38 INFO - 'USER': 'cltbld', 21:44:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:38 INFO - '_': '/tools/buildbot/bin/python'} 21:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:38 INFO - Downloading/unpacking blobuploader==1.2.4 21:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:40 INFO - Downloading blobuploader-1.2.4.tar.gz 21:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:44:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:44:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:40 INFO - Downloading docopt-0.6.1.tar.gz 21:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:44:41 INFO - Installing collected packages: blobuploader, requests, docopt 21:44:41 INFO - Running setup.py install for blobuploader 21:44:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:44:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:44:41 INFO - Running setup.py install for requests 21:44:41 INFO - Running setup.py install for docopt 21:44:41 INFO - Successfully installed blobuploader requests docopt 21:44:41 INFO - Cleaning up... 21:44:41 INFO - Return code: 0 21:44:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:41 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:44:41 INFO - Using env: {'DISPLAY': ':0', 21:44:41 INFO - 'HOME': '/home/cltbld', 21:44:41 INFO - 'LANG': 'en_US.UTF-8', 21:44:41 INFO - 'LANGUAGE': 'en_US:en', 21:44:41 INFO - 'LOGNAME': 'cltbld', 21:44:41 INFO - 'MAIL': '/var/mail/cltbld', 21:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:41 INFO - 'MOZ_NO_REMOTE': '1', 21:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:41 INFO - 'NO_EM_RESTART': '1', 21:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:41 INFO - 'PWD': '/builds/slave/test', 21:44:41 INFO - 'SHELL': '/bin/bash', 21:44:41 INFO - 'SHLVL': '1', 21:44:41 INFO - 'TERM': 'linux', 21:44:41 INFO - 'TMOUT': '86400', 21:44:41 INFO - 'USER': 'cltbld', 21:44:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:41 INFO - '_': '/tools/buildbot/bin/python'} 21:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:44:41 INFO - Running setup.py (path:/tmp/pip-mO3w3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:44:41 INFO - Running setup.py (path:/tmp/pip-HcSmpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:44:41 INFO - Running setup.py (path:/tmp/pip-dNgcEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:44:42 INFO - Running setup.py (path:/tmp/pip-35T50u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:44:42 INFO - Running setup.py (path:/tmp/pip-0_WSK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:44:42 INFO - Running setup.py (path:/tmp/pip-4lhRAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:44:42 INFO - Running setup.py (path:/tmp/pip-Kxd0Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:44:42 INFO - Running setup.py (path:/tmp/pip-Ax82cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:44:42 INFO - Running setup.py (path:/tmp/pip-nUNxtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:44:42 INFO - Running setup.py (path:/tmp/pip-zIf5As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:44:42 INFO - Running setup.py (path:/tmp/pip-8yzrgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:44:42 INFO - Running setup.py (path:/tmp/pip-GfqVXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:44:42 INFO - Running setup.py (path:/tmp/pip-EjKVE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:44:42 INFO - Running setup.py (path:/tmp/pip-eO8n4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:42 INFO - Running setup.py (path:/tmp/pip-BHjcYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:44:42 INFO - Running setup.py (path:/tmp/pip-wp06hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:44:42 INFO - Running setup.py (path:/tmp/pip-Nv1Z6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:44:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:44:43 INFO - Running setup.py install for manifestparser 21:44:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Running setup.py install for mozcrash 21:44:43 INFO - Running setup.py install for mozdebug 21:44:43 INFO - Running setup.py install for mozdevice 21:44:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Running setup.py install for mozfile 21:44:43 INFO - Running setup.py install for mozhttpd 21:44:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Running setup.py install for mozinfo 21:44:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Running setup.py install for mozInstall 21:44:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:44:43 INFO - Running setup.py install for mozleak 21:44:43 INFO - Running setup.py install for mozlog 21:44:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Running setup.py install for moznetwork 21:44:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Running setup.py install for mozprocess 21:44:44 INFO - Running setup.py install for mozprofile 21:44:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Running setup.py install for mozrunner 21:44:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Running setup.py install for mozscreenshot 21:44:44 INFO - Running setup.py install for moztest 21:44:44 INFO - Running setup.py install for mozversion 21:44:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:44:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:44:44 INFO - Cleaning up... 21:44:44 INFO - Return code: 0 21:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:44 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:44:44 INFO - Using env: {'DISPLAY': ':0', 21:44:44 INFO - 'HOME': '/home/cltbld', 21:44:44 INFO - 'LANG': 'en_US.UTF-8', 21:44:44 INFO - 'LANGUAGE': 'en_US:en', 21:44:44 INFO - 'LOGNAME': 'cltbld', 21:44:44 INFO - 'MAIL': '/var/mail/cltbld', 21:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:44 INFO - 'MOZ_NO_REMOTE': '1', 21:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:44 INFO - 'NO_EM_RESTART': '1', 21:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:44 INFO - 'PWD': '/builds/slave/test', 21:44:44 INFO - 'SHELL': '/bin/bash', 21:44:44 INFO - 'SHLVL': '1', 21:44:44 INFO - 'TERM': 'linux', 21:44:44 INFO - 'TMOUT': '86400', 21:44:44 INFO - 'USER': 'cltbld', 21:44:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:44 INFO - '_': '/tools/buildbot/bin/python'} 21:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:44:45 INFO - Running setup.py (path:/tmp/pip-GVTZMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:44:45 INFO - Running setup.py (path:/tmp/pip-HfArEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:44:45 INFO - Running setup.py (path:/tmp/pip-iTegIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:44:45 INFO - Running setup.py (path:/tmp/pip-Tz5Any-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:44:45 INFO - Running setup.py (path:/tmp/pip-rJmCoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:44:45 INFO - Running setup.py (path:/tmp/pip-z1jR6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:44:45 INFO - Running setup.py (path:/tmp/pip-LvF7DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:44:45 INFO - Running setup.py (path:/tmp/pip-oT43q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:44:45 INFO - Running setup.py (path:/tmp/pip-iSW3de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:44:45 INFO - Running setup.py (path:/tmp/pip-3GYWIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:44:45 INFO - Running setup.py (path:/tmp/pip-GVDrI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:44:45 INFO - Running setup.py (path:/tmp/pip-XPzggi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:44:45 INFO - Running setup.py (path:/tmp/pip-ZuFVLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:44:46 INFO - Running setup.py (path:/tmp/pip-1HCw8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:46 INFO - Running setup.py (path:/tmp/pip-k9xkoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:44:46 INFO - Running setup.py (path:/tmp/pip-QTj818-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:44:46 INFO - Running setup.py (path:/tmp/pip-p3z8X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:44:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:48 INFO - Downloading blessings-1.6.tar.gz 21:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:44:48 INFO - Installing collected packages: blessings 21:44:48 INFO - Running setup.py install for blessings 21:44:48 INFO - Successfully installed blessings 21:44:48 INFO - Cleaning up... 21:44:48 INFO - Return code: 0 21:44:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:44:48 INFO - Reading from file tmpfile_stdout 21:44:48 INFO - Current package versions: 21:44:48 INFO - argparse == 1.2.1 21:44:48 INFO - blessings == 1.6 21:44:48 INFO - blobuploader == 1.2.4 21:44:48 INFO - docopt == 0.6.1 21:44:48 INFO - functools32 == 3.2.3-2 21:44:48 INFO - jsonschema == 2.5.1 21:44:48 INFO - manifestparser == 1.1 21:44:48 INFO - mozInstall == 1.12 21:44:48 INFO - mozcrash == 1.0 21:44:48 INFO - mozdebug == 0.1 21:44:48 INFO - mozdevice == 0.48 21:44:48 INFO - mozfile == 1.2 21:44:48 INFO - mozhttpd == 0.7 21:44:48 INFO - mozinfo == 0.9 21:44:48 INFO - mozleak == 0.1 21:44:48 INFO - mozlog == 3.4 21:44:48 INFO - moznetwork == 0.27 21:44:48 INFO - mozprocess == 0.23 21:44:48 INFO - mozprofile == 0.28 21:44:48 INFO - mozrunner == 6.13 21:44:48 INFO - mozscreenshot == 0.1 21:44:48 INFO - mozsystemmonitor == 0.3 21:44:48 INFO - moztest == 0.8 21:44:48 INFO - mozversion == 1.4 21:44:48 INFO - psutil == 3.1.1 21:44:48 INFO - requests == 1.2.3 21:44:48 INFO - wsgiref == 0.1.2 21:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:48 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:44:48 INFO - Using env: {'DISPLAY': ':0', 21:44:48 INFO - 'HOME': '/home/cltbld', 21:44:48 INFO - 'LANG': 'en_US.UTF-8', 21:44:48 INFO - 'LANGUAGE': 'en_US:en', 21:44:48 INFO - 'LOGNAME': 'cltbld', 21:44:48 INFO - 'MAIL': '/var/mail/cltbld', 21:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:48 INFO - 'MOZ_NO_REMOTE': '1', 21:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:48 INFO - 'NO_EM_RESTART': '1', 21:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:48 INFO - 'PWD': '/builds/slave/test', 21:44:48 INFO - 'SHELL': '/bin/bash', 21:44:48 INFO - 'SHLVL': '1', 21:44:48 INFO - 'TERM': 'linux', 21:44:48 INFO - 'TMOUT': '86400', 21:44:48 INFO - 'USER': 'cltbld', 21:44:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:48 INFO - '_': '/tools/buildbot/bin/python'} 21:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:44:49 INFO - Cleaning up... 21:44:49 INFO - Return code: 0 21:44:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:49 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 0x7f717745bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, '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': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:44:49 INFO - Using env: {'DISPLAY': ':0', 21:44:49 INFO - 'HOME': '/home/cltbld', 21:44:49 INFO - 'LANG': 'en_US.UTF-8', 21:44:49 INFO - 'LANGUAGE': 'en_US:en', 21:44:49 INFO - 'LOGNAME': 'cltbld', 21:44:49 INFO - 'MAIL': '/var/mail/cltbld', 21:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:49 INFO - 'MOZ_NO_REMOTE': '1', 21:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:49 INFO - 'NO_EM_RESTART': '1', 21:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:49 INFO - 'PWD': '/builds/slave/test', 21:44:49 INFO - 'SHELL': '/bin/bash', 21:44:49 INFO - 'SHLVL': '1', 21:44:49 INFO - 'TERM': 'linux', 21:44:49 INFO - 'TMOUT': '86400', 21:44:49 INFO - 'USER': 'cltbld', 21:44:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:49 INFO - '_': '/tools/buildbot/bin/python'} 21:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:44:49 INFO - Cleaning up... 21:44:49 INFO - Return code: 0 21:44:49 INFO - Running post-action listener: _resource_record_post_action 21:44:49 INFO - Running post-action listener: _start_resource_monitoring 21:44:49 INFO - Starting resource monitoring. 21:44:49 INFO - [mozharness: 2017-01-16 05:44:49.286260Z] Finished create-virtualenv step (success) 21:44:49 INFO - [mozharness: 2017-01-16 05:44:49.286717Z] Running install step. 21:44:49 INFO - Running pre-action listener: _resource_record_pre_action 21:44:49 INFO - Running main action method: install 21:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:44:49 INFO - Reading from file tmpfile_stdout 21:44:49 INFO - Detecting whether we're running mozinstall >=1.0... 21:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:44:49 INFO - Reading from file tmpfile_stdout 21:44:49 INFO - Output received: 21:44:49 INFO - Usage: mozinstall [options] installer 21:44:49 INFO - Options: 21:44:49 INFO - -h, --help show this help message and exit 21:44:49 INFO - -d DEST, --destination=DEST 21:44:49 INFO - Directory to install application into. [default: 21:44:49 INFO - "/builds/slave/test"] 21:44:49 INFO - --app=APP Application being installed. [default: firefox] 21:44:49 INFO - mkdir: /builds/slave/test/build/application 21:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:45:05 INFO - Reading from file tmpfile_stdout 21:45:05 INFO - Output received: 21:45:05 INFO - /builds/slave/test/build/application/firefox/firefox 21:45:05 INFO - Running post-action listener: _resource_record_post_action 21:45:05 INFO - [mozharness: 2017-01-16 05:45:05.709465Z] Finished install step (success) 21:45:05 INFO - [mozharness: 2017-01-16 05:45:05.709706Z] Running run-tests step. 21:45:05 INFO - Running pre-action listener: _resource_record_pre_action 21:45:05 INFO - Running main action method: run_tests 21:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:45:05 INFO - Python 2.7.3 21:45:05 INFO - Return code: 0 21:45:05 INFO - grabbing minidump binary from tooltool 21:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:05 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 0x2607f60>, '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 0x2608d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26091d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:45:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:45:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:45:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:45:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:45:05 INFO - Return code: 0 21:45:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:45:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:45:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:45:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:45:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:45:05 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/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:45:05 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/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:45:05 INFO - Using env: {'DISPLAY': ':0', 21:45:05 INFO - 'HOME': '/home/cltbld', 21:45:05 INFO - 'LANG': 'en_US.UTF-8', 21:45:05 INFO - 'LANGUAGE': 'en_US:en', 21:45:05 INFO - 'LOGNAME': 'cltbld', 21:45:05 INFO - 'MAIL': '/var/mail/cltbld', 21:45:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:45:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:05 INFO - 'MOZ_NO_REMOTE': '1', 21:45:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:05 INFO - 'NO_EM_RESTART': '1', 21:45:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:05 INFO - 'PWD': '/builds/slave/test', 21:45:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:45:05 INFO - 'SHELL': '/bin/bash', 21:45:05 INFO - 'SHLVL': '1', 21:45:05 INFO - 'TERM': 'linux', 21:45:05 INFO - 'TMOUT': '86400', 21:45:05 INFO - 'USER': 'cltbld', 21:45:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484543735.160317-176674690', 21:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:05 INFO - '_': '/tools/buildbot/bin/python'} 21:45:05 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/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:45:05 INFO - mozversion application_buildid: 20170115200222 21:45:05 INFO - mozversion application_changeset: 02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0 21:45:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:45:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:45:05 INFO - mozversion application_name: Firefox 21:45:05 INFO - mozversion application_remotingname: firefox-dev 21:45:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:45:05 INFO - mozversion application_vendor: Mozilla 21:45:05 INFO - mozversion application_version: 52.0a2 21:45:05 INFO - mozversion platform_buildid: 20170115200222 21:45:05 INFO - mozversion platform_changeset: 02d0ba8567f3de09c9df0a95138d0c4e7b5a57a0 21:45:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:45:05 INFO - mozversion platform_version: 52.0a2 21:45:05 INFO - using testdate: 1484545505 21:45:05 INFO - actual date: 1484545505 21:45:05 INFO - starting webserver on 'localhost:40988' 21:45:05 INFO - SUITE-START | Running 2 tests 21:45:05 INFO - TEST-START | dromaeo_css 21:45:05 INFO - operating with platform_type : linux_ 21:45:05 INFO - Initialising browser for dromaeo_css test... 21:45:05 INFO - TEST-INFO | started process 24613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNX9QcZ/profile http://localhost:40988/getInfo.html) 21:45:09 INFO - PROCESS | 24613 | __metrics Screen width/height:1600/1200 21:45:09 INFO - PROCESS | 24613 | colorDepth:24 21:45:09 INFO - PROCESS | 24613 | Browser inner width/height: 1024/697 21:45:09 INFO - PROCESS | 24613 | __metrics 21:45:09 INFO - PROCESS | 24613 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:45:09 INFO - PROCESS | 24613 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:45:10 INFO - PROCESS | 24613 | console.error: PushService: 21:45:10 INFO - PROCESS | 24613 | stateChangeProcessEnqueue: Error transitioning state 21:45:10 INFO - PROCESS | 24613 | UnknownError 21:45:10 INFO - TEST-INFO | 24613: exit 0 21:45:10 INFO - Browser initialized. 21:45:10 INFO - Running cycle 1/1 for dromaeo_css test... 21:45:10 INFO - TEST-INFO | started process 24704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNX9QcZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:45:22 INFO - PROCESS | 24704 | RSS: Main: 143843328 21:45:22 INFO - PROCESS | 24704 | 21:48:23 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40988/tests/dromaeo/cssquery-ext.html) 21:48:25 INFO - PROCESS | 24704 | RSS: Main: 281468928 21:48:25 INFO - PROCESS | 24704 | 21:51:27 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-ext.html (next: http://localhost:40988/tests/dromaeo/cssquery-jquery.html) 21:51:28 INFO - PROCESS | 24704 | RSS: Main: 224673792 21:51:28 INFO - PROCESS | 24704 | 21:54:30 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40988/tests/dromaeo/cssquery-mootools.html) 21:54:30 INFO - PROCESS | 24704 | RSS: Main: 233390080 21:54:30 INFO - PROCESS | 24704 | 21:57:32 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40988/tests/dromaeo/cssquery-prototype.html) 21:57:33 INFO - PROCESS | 24704 | RSS: Main: 217092096 21:57:33 INFO - PROCESS | 24704 | 22:00:35 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40988/tests/dromaeo/cssquery-yui.html) 22:00:36 INFO - PROCESS | 24704 | RSS: Main: 176160768 22:00:36 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-yui.html (next: http://localhost:40988/tests/dromaeo/cssquery-dojo.html) 22:03:38 INFO - PROCESS | 24704 | RSS: Main: 264323072 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | __start_tp_report 22:03:38 INFO - PROCESS | 24704 | _x_x_mozilla_page_load 22:03:38 INFO - PROCESS | 24704 | _x_x_mozilla_page_load_details 22:03:38 INFO - PROCESS | 24704 | |i|pagename|runs| 22:03:38 INFO - PROCESS | 24704 | |0;dojo.html;3187.1713354527824;3210.357928414316;3212.919677008074;3237.2392487765355;3265.281638039632;5467.179923011546;5577.9163312550245;5578.972105139479;5594.944050559493;5607.046802043657;5486.286782718251;5534.335879694432;5548.77804887805;5549.972250138754;5583.5254003409755;5009.073321435528;5031.798728050873;5065.949340506603;5099.15863882459;5100.515451032146;4870.512948705119;5069.518395752416;5113.411957624883;5118.6416950813455;5125.923111153335;4844.055409195208;4980.900381992358;4996.050750357439;5023.799048038074;5033.924491132636;5040.924386134211;5144.948550514484;5156.175011998081;5159.019786240602;5165.690058596496;4992.126377883892;5062.2406639004075;5102.795888164469;5123.8206662767;5124.4106927703415;5355.410904800468;5382.6232163748555;5402;5426.294581704393;5436.537894278991;5809.070548712186;5828.97085514574;5838.64968101911;5945.405459454063;5950.940490595082;6000.519958403317;6022.277326720778;6026.819195424145;6032.788852390189;6038.637681739066;5394.487523685244;5427.972860135674;5461.563074954034;5487.862803429946;5505.559555235572;6020.157177995085;6034.39656034393;6051.334353221142;6056.394360563996;6057.878842423127;5800.6809625471005;5807.186993820868;5808.3901190375245;5816.5928385013485;5830.3586605473365;5769.221155144086;5785.450382213683;5810.82567522975;5831.795887144014;5837;5871.178035075093;5882.55880808941;5886.793962211388;5910.172575839386;5936;5867.061270196748;5881.617694849821;5916.497097746654;5921.437463440966;5921.61509501881;4471.754053527087;4513.526079761644;4523.841665541756;4555.2256116460285;4610.561996610317;4110.0752330725345;4138.110306284163;4139.937900931428;4157.417961485395;4161.146964872194;5670.06443936754;5672.97163514188;5685.60200785941;5686.914696279559;5726.513246374022;5717.685527296038;5745.8563535911935;5751.252337196222;5827.737751801179;5952.702364881825;5512.145617429305;5531.917021244684;5547;5567.832965010975;5570.387257401682;5114.872128196825;5131.666441681279;5147.1507201312115;5176.948230517722;5201.661891977009;6203.906941395882;6211.782587609502;6214.223222097328;6215.658138802319;6230.844228894314;5781.942180578309;5912.615679980788;5965.582409231486;5969.313528944227;5972.104184372379;6048.455638992512;6077.270727512727;6093.75624974996;6119.969400152971;6216.595921265103;5833.620814647034;5852.239208902815;5853.268341457318;5855.180274761622;5895.263092113486;5959.91060134107;5970.9701451492465;5972.432618901197;5972.970135149297;5975.223220981245;5618.550515958796;5648.971755141198;5681.517071049007;5698.430156984268;5721.456461636138;5783.987802134694;5790.884182316246;5799.797007104731;5805.10020946754;5808.651480911159;5723.112917497794;5726.055200891973;5731.168980497888;5733.31200255972;5740.282464691913;5650.858728531655;5661.094224923992;5760.8271751847515;5780.132980053026;5794.304683438015;5721.370649228498;5753.424657534213;5773.595848290579;5783.624064435967;5795.8551036224435 22:03:38 INFO - PROCESS | 24704 | |1;ext.html;570.6547538739063;602.0667964654785;623.6102435977514;649.6556824882814;659.5778701630957;35192.2961540769;36030.09924751876;36037.2792544149;36049;36051.27897442053;35980.640193598054;44856.55143448564;45839.31241031379;45854.77072614641;49184.262236066395;8726.52004139772;8840.513771742551;8845.425047371933;8845.469271843678;8847.292216622654;8256.711015114472;8465.111163327854;8821.073787252342;8921.107889211093;8927.508987005713;10366.326188797742;10670.573177072907;10676.519556619933;10910.23628346016;10932.180086493505;10601.946990265038;10673.306235094733;10675.83986240207;10678.946605267001;10680.732981675443;10569.577216911315;10601.73495662607;10646.25476216665;10650.520726567323;10651.78696426075;42526;43056.569434305886;43148.35277470841;43202.56797432048;43258;3381.695647391722;3395.371856206585;3444.1389652586854;3454.3436747017986;3567;31408.685913140805;31778;33799.217473131495;34191.48712769311;34856.82571587151;4391.8462853799965;4458.554144585548;4466.1067786442845;4553.840615578472;4592.380028696117;390852;404093;404280;404852.99999999703;405523;39755.60244397519;40784.79607602002;67373;68464.6576767113;68525;42671.786641066596;42846.57153428488;42933.35599966003;42991.35512967308;43014;17119.828801712072;17132.743008854875;17353.7396939046;17380;17388.0436575987;14400.351984160738;14598.051126676732;14620.561383158521;14622.195779232032;14630.122192668474;9067.591958361889;9222.584983675752;9343.439393636403;9673.419594824332;9835.164011058998;3768.5477742670505;3775.715127838798;3788.791616461121;3796.3925771876366;3850.9229815404096;965.5896244096231;1042.713253855196;1059.9682009539727;1142.154805443982;1148.1388958281289;32680;32800.50799238013;32970.67029329676;33257.66742332594;33457.49813752795;1111.7331840358256;1137.2039572299423;1166.125405945541;1216.3370962825104;1231.926084434919;14968.47610333633;17491.38780142689;18067.72898406525;18459.723104153447;19439;594179;595098;595122;598855;599480;61624.69187654123;61934.69032654898;62002.37997619966;62133;62134.689326553074;1312.0880987713447;1358.9864101359058;1379.8068270442145;1401.2363262022222;1411.5412490940485;28179.859100704365;29294.70705293005;29791.851040745525;29821.254468638457;30432.543511847784;52092;52573;52601.473985259654;52611.47388526066;52793;430571;436235.6376436195;440072;441137;515473;41865.79067104645;45573.54426455693;45803.77098114488;46123.3081503771;46624;49752.50247497479;50290.24564631606;50556.24165637445;50628.24057639065;50957.490425095275;42273;42611.14777704367;42850.57149428466;42945.570544294154;43921.34117988297;41630.16739665129;41870.37194442025;42110.36834447424;43239.56760432355;43427;42979;43646.781766090964;43767.12465750731;44025.11949760923;44273.55726442694;36379.636203638685;37998.62001379951;38201.61798381981;38220;38555.42166867443;28731.425371492034;29285;29354.559681604365;29413.558796618498;29432 22:03:38 INFO - PROCESS | 24704 | |2;jquery.html;389.7427697719506;414.47775802488854;424.3147317082911;428.5371798457666;443.0562901020825;14741.926290368547;18989;19010.61978760424;19011.239550417966;20042.799572004275;12813.743725125492;13007.479700811957;13041.21752694839;13083.869161308385;13116.93441532791;4007.9799601001955;4242.469691288589;5136.974315128428;5279.366476022883;5294.126469132589;5475.835724928259;5703.429657034305;5746.655200687972;5815.912761308584;5840.094785308284;5795;5800.361960184377;5903;6422.967885160568;6451.903221451682;6443.25902521209;6467.385598368194;6480.8055758326855;6483.254425741029;6486.902696459557;5090.77091530882;5400.972995134999;5421.051316019681;5477.04151773442;5490.231367608538;13582.25297608631;13671.043026988114;13690.178589284675;13729.931350343284;13835.930820345935;2296.9655455168186;2399.6280576510667;2409.614461686122;2758.5518102372034;2840.1053668094482;9461.716148515556;9886.653967111188;10192.980701929822;10347.586096556128;10468.42423666698;1969.5470041890303;2013.1645367172605;2026.98986505068;2097.182098981383;2115.2596591193114;79851.20148798496;87485.562572188;88242;89524;92502.5374873128;11300.265482743594;11571.42142892852;11585.536578536765;11635.709107272216;11820.468078936468;16679.416220432468;16686.33254669824;16697.165141742866;16703.16484175786;16713.164341782864;8407.537585432738;8616.569171541398;8679.522626255617;8689.869651955225;8822.426542274732;8546.401751877309;8570.357223208159;8574.914250857411;8736.91263087361;8767.605457754416;4804.711717296974;4852.733099679481;4852.757362131879;4856.465788763233;4913.385826771653;1989.502624343914;2030.4213299209655;2050.3438899552;2072.357569153567;2107.694384314266;967.0320896974623;989.7575094101991;1030.6289735695143;1049.2393015064017;1088.733260351219;18784.436466906016;20423.183072677224;20983.16067357319;21893.014814333073;21963.560728785655;1057.2176589323844;1065.7921705267554;1080.287010573018;1083.1930211992117;1084.6258040975852;11355.54577816878;11663.125265605113;11813.936745692929;11849.644510664693;11997.880021199851;513855;515588;517802;539920;541912;97157.51421242849;97749;98176.50911745538;99756;102730.48634756778;1033.3489901362093;1064.510325250378;1075.1398880895408;1088.4612117002134;1095.4741723972538;13805.861941380457;17636.34468691226;18210.635787283914;18239.361622343153;18242.72635910436;44605.77697111494;45261.54738452705;45677.54322456733;45699.771501142284;45877;58166.7091664539;58546.4145358558;58647;59334.98987116946;60271.69864150651;7855.175206603224;8248.257656810916;8539.573021349031;8720.258778003941;8879.200871921557;12855.871441285468;12877.034222433167;12900.161489503153;13060.869391305965;13065;11719.355435451133;11785.587504437304;11849.466773995364;12023.879761202275;12149.81775273354;11329.320240785579;11362.602308919148;11493.82759258595;11527.481263343338;12025.759484810429;11608.6517404478;11729.648110556696;11773.941130294294;11864.347460889734;12232.877671223174;7826;7933.286004259644;7959.761207163794;8121.675132994614;8193.303569196685;9893.455859927773;11569.305841649528;11741.530338786353;11745.941270293593;12024.519019239133 22:03:38 INFO - PROCESS | 24704 | |3;mootools.html;1475.7269905067562;1512.6672132130932;1607.6222087809363;1733.8786284960058;1771.4508502364267;8431.536265505394;8957.19385255326;8970.3272254581;8982.865257021142;8993.820123597525;7913.841723165548;8190.344772418192;8392.91607083929;8558.229759321659;8668.046514883374;2444.9511009779794;2496.3634273260295;2498.812589055819;2509.397744541306;2511.3470497670646;2477.54165479386;2564.0897481394118;2565.115035312814;2568.858712770797;2571.151519998396;2495.0394098272113;2498.4253621667026;2524.4572416930355;2530.0891678995545;2531.50635626053;2356.9764302357016;2357.198552492161;2375.3111597636666;2388.283514945527;2390.940226494334;2431.732509423962;2441.9865755711357;2455.815813813971;2463.81521385895;2467.6545283660303;8769.561521923943;8816.955915220447;8858.822823543558;8863.290936725047;8866.113388661146;5427.267318911936;5580.804671836507;5586.608937374385;5588.636738611977;5605.747741351608;3422.503736958152;3483.1292176955762;3536.752427330088;3547.5210846535647;3592.425211966099;1171.1626187276054;1172.5192671004932;1200.5257923120319;1208.570957310151;1243.5212443209339;12140.878591214063;12412.75174496505;12419.31693756843;12424.56514022005;12513.43689533964;4767.070421267819;4877.951220487821;4906.779194936236;4939.530744579331;5014.348134742533;10438.895611043945;10448.947755261328;10462.47687615616;10469.057784799405;10478.161747060218;5583.553315734813;5586.692731899703;5588.189712491747;5590.2453168821685;5595.63628364155;4510.120526497367;4651;4896.2655601660035;4937;5081.771320290596;4151.12826306479;4162.375643653476;4196.097838964637;4240.978795106004;4247.299195632748;1348.9932550337185;1408.2747385096684;1417.922014289224;1425.9144451332954;1428.357239242345;688.9276625954303;772.1814876231213;851.7827953871847;856.7429771068779;858.038996324121;5729.169270455844;5873.412658734178;5886.087656413263;5902.085176797603;6097.146399504073;955.2071780422233;972.2367941166151;982.7346616413529;984.7882705218412;1018.6129270877168;3860.478835357247;3926.3521518949055;3929.214157168578;3966.702497312713;3998.5601583825755;10491.475426228812;11080.778384432266;11084.501197446134;11103.389313587668;11117.666470005914;10730.570777168827;10830.945845270724;11002.724931876766;11005.17461190414;11011.889881101246;8376.288015518749;8474;8479.618417171243;8498.53258070812;8502.2773064289;5464.1257398816;5602.915956260741;5656.462636049569;5685.914711279417;5698.715064246854;9956.352837065568;10039;10040.64857729976;10056.899431005597;10065.748356291151;10155.441450720282;10156.695299141038;10162.745931351776;10269.229807764297;10339;7539.849203016019;7677.30904218623;7702.730404435818;7703.38372930153;7703.730369437043;7969.6015199240965;8093.231143041402;8162.632681529227;8207;8214;7259.2377800330205;7319.34125928669;7340.522866013692;7419.369353605004;7429.368503677248;7206.783796486114;7256.129264488295;7301.196868344584;7385.335319821242;7460.738874139379;6339.080833279057;6440.259370172303;6440.452561532322;6451.032345148265;6508.772192973223;4806.927896081632;4893.926591101207;4943.431505376928;4990.850274491771;5153.768080436314;4855.611551075976;4889.168841297059;4928.901421971469;4957.702537847741;5010.323606313101 22:03:38 INFO - PROCESS | 24704 | |4;prototype.html;343.1866476450812;344.39902370363717;349.85306171408007;355.2327172317719;359.9651003365325;5178.974105129479;5260.894782104356;5321.494458026486;5322.152648333143;5325.707086110262;5117.846464606058;5179.394387739803;5222.791088356461;5225.824189557347;5258.737063146837;4197.622214000739;4202.285611446062;4215.178040282146;4216.072464057902;4217.219814334358;4033.5159780826343;4151.605597468236;4204.432401625787;4209.663226941837;4213.389058586518;4107.650849677781;4113.56807535209;4115.176964607075;4118.97940510297;4156.771377574232;4103.722434049101;4112.300908845474;4115.218108559379;4134.193832202722;4139.937900931488;3657.414813629833;3661.7802931824176;3676.7242456815848;3681.44778283257;3686.0232038509816;5032.496750324938;5119.641625086246;5130.410002849682;5149.201873709543;5162.92255616166;4697.224957881946;4707.917179048838;4714.339992401066;4714.38712967312;4741.881452963669;5409.161579955114;5552.944470555283;5552.972700050504;5559.527440167591;5561.9420814298965;4051.5745846686264;4054.5945405459515;4057.6348128668265;4065.9390109148385;4069.5930406959365;5691.9715401423555;5705.942940570624;5723.484886360247;5725.599208055438;5730.169125476783;4030.9596904030586;4032.4556184915245;4033.2941735196223;4038.2327357801923;4042.717009809344;4010.3382941814857;4065.288574499451;4114.917701645951;4121.649659778953;4126.968257935516;4662.160811054043;4672.813087476463;4675.929861052087;4681.344611754357;4691.81232750693;5550.694711790809;5551.3631025262675;5559.416261292587;5574.721263936787;5578.804741834017;1291.8449786025737;1322.233104799214;1363.9522616708368;1376.7384197002536;1395.9860401396058;923.2198792020732;941.8634298026748;946.2619157057507;947.6398968392105;958.6836344006462;5117.8996515749295;5142.534377702337;5157.819476318311;5176.8964620707375;5182.352205974254;5405.621606487587;5412.864678383072;5436.374816896028;5439.3200849893765;5439.673619582838;4918.926216106761;5119.385673719177;5121.692698438031;5138.665986710852;5184.222366644958;2887.815995441859;2892.7975041747295;2898.217710997466;2898.4927637663322;2900.7244311790346;5629.155626656035;5631.227077857845;5642.548596112301;5644;5665.348484924204;5286.731184515688;5497.780088796403;5528.640638358494;5548.361938377057;5572.359178694421;5552.333719953632;5573.916391254053;5581.190727344512;5632.211490391349;5638.97180514103;5275.314209152785;5378.655336165959;5403.243545903655;5419.783208671766;5443.292371991616;5366.356037275552;5397.517142114514;5402.135658294654;5405.675659460445;5406.351237851483;5556.49974506889;5559.969816449963;5565.220869078251;5575.442455754554;5591.217229587943;3865.458835763052;3952.26883026641;3955.3869150281753;3965.167314863911;3977.920441591094;5383.434739352469;5383.946160538345;5400.405955344988;5446.945530544803;5449.3460784706085;5385.892282154413;5470.863228419322;5537.086380747131;5542.806001790079;5551.639143455663;5524.613277070566;5531.170324451365;5540.141278101901;5548.611597188319;5576.219329293983;5248.448912864094;5468.644538105011;5489.615726899079;5489.862753431196;5491.670499770026;5553.305836770403;5556.305461817273;5556.749946252509;5557.722113894209;5564.693941833238;5447.855950250333;5456.690394305258;5470.753816078366;5476.616636835383;5485.286912701324 22:03:38 INFO - PROCESS | 24704 | |5;yui.html;806.6652339279195;807.5235610989512;823.8599438095523;862.706679728892;892.535881341702;11977.4011299435;12918.677033074166;12989.480420783157;13000.674983125404;13099.148555343896;11255.66233013011;11734.882651173486;12139.514419423213;12278.263304201753;12297.262164270127;810.6797814863125;833.3083540661266;834.157500924068;834.486790623765;834.5034704350901;830.5639539241886;830.779843341515;832.8750687396908;835.3108685334623;836.1847198981005;883.1168831168832;884.1335491218609;887.7203680840514;889.9599518021672;890.2255038116847;873.7902903303225;878.1745159550003;880.6873559886276;881.9559022048904;882.8190221004679;644.391050457318;646.1503123392723;646.4472875691263;647.7117682631231;647.7150053976235;11134.888651113466;11144.33134011962;11154.442277886154;11339;11757.58848440309;11504.940726234387;11927.463264153133;11930.224535405257;11942.46258918342;12209.816852747215;9630.02584470189;9683.757906052335;9891.554880030415;9967.700968970943;9991.150752186073;3642.5811031731423;3680.650338217865;3728.608496107897;3762.7930463824478;3784.2431513697097;63510.68244658793;65190;65393;65752;66858.66570667115;8886.688965886293;9116.45301281912;9188.770280742901;9203.125703058198;9398.624055037722;18893.244270229035;19070.523236919187;19141;19154.425367239004;19164.329248476235;7560.130584982688;7783.104942931635;7853.253940875607;7999.600019998977;8122.228388303101;4461.665375096881;4626.699264547794;4685.718856868599;4704.576588107018;4756.7145971241835;3156.463401221798;3268.444364458048;3268.5587445695;3276.737860971117;3279.1474216703828;544.5317027356471;551.4485514485515;567.2625586737225;570.7916610437161;588.7203578300273;650.1125963060483;653.7221680785647;679.7586856665911;688.7141836138047;690.0580707334552;8147.79630509242;8195.877061844078;8206.261436470626;8325.292350150185;8609.268212201907;607.2288193993692;628.3151365012159;629.2103410220236;646.0374042676473;671.080619551218;3850.9229815403537;3880.5149356330458;3970.940435893464;4030.234255491447;4120.1553681495225;85027.5748621253;85605.57197213975;90034;90273.54863225773;91900;49364.50635493671;51840.74079629653;65719.34280657228;75738.62130689422;80909;67356;68623;68811.31188688149;68934;72152;8764.339102282438;9212;9236.630534778533;9290;9298.302627303116;45364;45769.31346029745;46256.768716156206;47684.5231547694;48676;37611.05972350713;37646.2470750578;40012.799936000134;62572.687136564025;62750;11552.537898483966;11751.706207344885;11773.52905883755;11819.172657914207;12188.817167742314;12455.875441245471;12749.93625031869;12948.611541653765;12949.54676586315;13262.336883155996;11266.493007814832;11548.653540393801;11690.76618467643;12209.633710988684;12957.093003489665;11901.76196476083;12020.398980051137;12282.692932676755;12534.310612916013;12913.225206487641;12060.095492837896;12129.21160124589;12187.573434929735;12201.938990304992;12360.938195308965;10136.594536218468;10204.540795664065;10417.166626669698;10425.687229383131;10541;10057.597696092367;10610.098141658045;10669.57321707123;10673.57305707763;10780.676579702622 22:03:38 INFO - PROCESS | 24704 | __end_tp_report 22:03:38 INFO - PROCESS | 24704 | __start_cc_report 22:03:38 INFO - PROCESS | 24704 | _x_x_mozilla_cycle_collect,1348 22:03:38 INFO - PROCESS | 24704 | __end_cc_report 22:03:38 INFO - PROCESS | 24704 | __startTimestamp1484546618937__endTimestamp 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | ------- Summary: start ------- 22:03:38 INFO - PROCESS | 24704 | Number of tests: 6 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | [#0] dojo.html Cycles:165 Average:5499.80 Median:5721.46 stddev:609.55 (10.7%) stddev-sans-first:583.80 22:03:38 INFO - PROCESS | 24704 | Values: 3187.2 3210.4 3212.9 3237.2 3265.3 5467.2 5577.9 5579.0 5594.9 5607.0 5486.3 5534.3 5548.8 5550.0 5583.5 5009.1 5031.8 5065.9 5099.2 5100.5 4870.5 5069.5 5113.4 5118.6 5125.9 4844.1 4980.9 4996.1 5023.8 5033.9 5040.9 5144.9 5156.2 5159.0 5165.7 4992.1 5062.2 5102.8 5123.8 5124.4 5355.4 5382.6 5402.0 5426.3 5436.5 5809.1 5829.0 5838.6 5945.4 5950.9 6000.5 6022.3 6026.8 6032.8 6038.6 5394.5 5428.0 5461.6 5487.9 5505.6 6020.2 6034.4 6051.3 6056.4 6057.9 5800.7 5807.2 5808.4 5816.6 5830.4 5769.2 5785.5 5810.8 5831.8 5837.0 5871.2 5882.6 5886.8 5910.2 5936.0 5867.1 5881.6 5916.5 5921.4 5921.6 4471.8 4513.5 4523.8 4555.2 4610.6 4110.1 4138.1 4139.9 4157.4 4161.1 5670.1 5673.0 5685.6 5686.9 5726.5 5717.7 5745.9 5751.3 5827.7 5952.7 5512.1 5531.9 5547.0 5567.8 5570.4 5114.9 5131.7 5147.2 5176.9 5201.7 6203.9 6211.8 6214.2 6215.7 6230.8 5781.9 5912.6 5965.6 5969.3 5972.1 6048.5 6077.3 6093.8 6120.0 6216.6 5833.6 5852.2 5853.3 5855.2 5895.3 5959.9 5971.0 5972.4 5973.0 5975.2 5618.6 5649.0 5681.5 5698.4 5721.5 5784.0 5790.9 5799.8 5805.1 5808.7 5723.1 5726.1 5731.2 5733.3 5740.3 5650.9 5661.1 5760.8 5780.1 5794.3 5721.4 5753.4 5773.6 5783.6 5795.9 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | [#1] ext.html Cycles:180 Average:63912.02 Median:223153.90 stddev:130565.03 (58.5%) stddev-sans-first:130844.69 22:03:38 INFO - PROCESS | 24704 | Values: 570.7 602.1 623.6 649.7 659.6 35192.3 36030.1 36037.3 36049.0 36051.3 35980.6 44856.6 45839.3 45854.8 49184.3 8726.5 8840.5 8845.4 8845.5 8847.3 8256.7 8465.1 8821.1 8921.1 8927.5 10366.3 10670.6 10676.5 10910.2 10932.2 10601.9 10673.3 10675.8 10678.9 10680.7 10569.6 10601.7 10646.3 10650.5 10651.8 42526.0 43056.6 43148.4 43202.6 43258.0 3381.7 3395.4 3444.1 3454.3 3567.0 31408.7 31778.0 33799.2 34191.5 34856.8 4391.8 4458.6 4466.1 4553.8 4592.4 390852.0 404093.0 404280.0 404853.0 405523.0 39755.6 40784.8 67373.0 68464.7 68525.0 42671.8 42846.6 42933.4 42991.4 43014.0 17119.8 17132.7 17353.7 17380.0 17388.0 14400.4 14598.1 14620.6 14622.2 14630.1 9067.6 9222.6 9343.4 9673.4 9835.2 3768.5 3775.7 3788.8 3796.4 3850.9 965.6 1042.7 1060.0 1142.2 1148.1 32680.0 32800.5 32970.7 33257.7 33457.5 1111.7 1137.2 1166.1 1216.3 1231.9 14968.5 17491.4 18067.7 18459.7 19439.0 594179.0 595098.0 595122.0 598855.0 599480.0 61624.7 61934.7 62002.4 62133.0 62134.7 1312.1 1359.0 1379.8 1401.2 1411.5 28179.9 29294.7 29791.9 29821.3 30432.5 52092.0 52573.0 52601.5 52611.5 52793.0 430571.0 436235.6 440072.0 441137.0 515473.0 41865.8 45573.5 45803.8 46123.3 46624.0 49752.5 50290.2 50556.2 50628.2 50957.5 42273.0 42611.1 42850.6 42945.6 43921.3 41630.2 41870.4 42110.4 43239.6 43427.0 42979.0 43646.8 43767.1 44025.1 44273.6 36379.6 37998.6 38201.6 38220.0 38555.4 28731.4 29285.0 29354.6 29413.6 29432.0 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | [#2] jquery.html Cycles:180 Average:30193.27 Median:12130.26 stddev:86869.02 (716.1%) stddev-sans-first:87083.89 22:03:38 INFO - PROCESS | 24704 | Values: 389.7 414.5 424.3 428.5 443.1 14741.9 18989.0 19010.6 19011.2 20042.8 12813.7 13007.5 13041.2 13083.9 13116.9 4008.0 4242.5 5137.0 5279.4 5294.1 5475.8 5703.4 5746.7 5815.9 5840.1 5795.0 5800.4 5903.0 6423.0 6451.9 6443.3 6467.4 6480.8 6483.3 6486.9 5090.8 5401.0 5421.1 5477.0 5490.2 13582.3 13671.0 13690.2 13729.9 13835.9 2297.0 2399.6 2409.6 2758.6 2840.1 9461.7 9886.7 10193.0 10347.6 10468.4 1969.5 2013.2 2027.0 2097.2 2115.3 79851.2 87485.6 88242.0 89524.0 92502.5 11300.3 11571.4 11585.5 11635.7 11820.5 16679.4 16686.3 16697.2 16703.2 16713.2 8407.5 8616.6 8679.5 8689.9 8822.4 8546.4 8570.4 8574.9 8736.9 8767.6 4804.7 4852.7 4852.8 4856.5 4913.4 1989.5 2030.4 2050.3 2072.4 2107.7 967.0 989.8 1030.6 1049.2 1088.7 18784.4 20423.2 20983.2 21893.0 21963.6 1057.2 1065.8 1080.3 1083.2 1084.6 11355.5 11663.1 11813.9 11849.6 11997.9 513855.0 515588.0 517802.0 539920.0 541912.0 97157.5 97749.0 98176.5 99756.0 102730.5 1033.3 1064.5 1075.1 1088.5 1095.5 13805.9 17636.3 18210.6 18239.4 18242.7 44605.8 45261.5 45677.5 45699.8 45877.0 58166.7 58546.4 58647.0 59335.0 60271.7 7855.2 8248.3 8539.6 8720.3 8879.2 12855.9 12877.0 12900.2 13060.9 13065.0 11719.4 11785.6 11849.5 12023.9 12149.8 11329.3 11362.6 11493.8 11527.5 12025.8 11608.7 11729.6 11773.9 11864.3 12232.9 7826.0 7933.3 7959.8 8121.7 8193.3 9893.5 11569.3 11741.5 11745.9 12024.5 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | [#3] mootools.html Cycles:180 Average:5797.74 Median:4883.56 stddev:3249.40 (66.5%) stddev-sans-first:3242.29 22:03:38 INFO - PROCESS | 24704 | Values: 1475.7 1512.7 1607.6 1733.9 1771.5 8431.5 8957.2 8970.3 8982.9 8993.8 7913.8 8190.3 8392.9 8558.2 8668.0 2445.0 2496.4 2498.8 2509.4 2511.3 2477.5 2564.1 2565.1 2568.9 2571.2 2495.0 2498.4 2524.5 2530.1 2531.5 2357.0 2357.2 2375.3 2388.3 2390.9 2431.7 2442.0 2455.8 2463.8 2467.7 8769.6 8817.0 8858.8 8863.3 8866.1 5427.3 5580.8 5586.6 5588.6 5605.7 3422.5 3483.1 3536.8 3547.5 3592.4 1171.2 1172.5 1200.5 1208.6 1243.5 12140.9 12412.8 12419.3 12424.6 12513.4 4767.1 4878.0 4906.8 4939.5 5014.3 10438.9 10448.9 10462.5 10469.1 10478.2 5583.6 5586.7 5588.2 5590.2 5595.6 4510.1 4651.0 4896.3 4937.0 5081.8 4151.1 4162.4 4196.1 4241.0 4247.3 1349.0 1408.3 1417.9 1425.9 1428.4 688.9 772.2 851.8 856.7 858.0 5729.2 5873.4 5886.1 5902.1 6097.1 955.2 972.2 982.7 984.8 1018.6 3860.5 3926.4 3929.2 3966.7 3998.6 10491.5 11080.8 11084.5 11103.4 11117.7 10730.6 10830.9 11002.7 11005.2 11011.9 8376.3 8474.0 8479.6 8498.5 8502.3 5464.1 5602.9 5656.5 5685.9 5698.7 9956.4 10039.0 10040.6 10056.9 10065.7 10155.4 10156.7 10162.7 10269.2 10339.0 7539.8 7677.3 7702.7 7703.4 7703.7 7969.6 8093.2 8162.6 8207.0 8214.0 7259.2 7319.3 7340.5 7419.4 7429.4 7206.8 7256.1 7301.2 7385.3 7460.7 6339.1 6440.3 6440.5 6451.0 6508.8 4806.9 4893.9 4943.4 4990.9 5153.8 4855.6 4889.2 4928.9 4957.7 5010.3 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | [#4] prototype.html Cycles:180 Average:4595.13 Median:5253.59 stddev:1327.48 (25.3%) stddev-sans-first:1292.27 22:03:38 INFO - PROCESS | 24704 | Values: 343.2 344.4 349.9 355.2 360.0 5179.0 5260.9 5321.5 5322.2 5325.7 5117.8 5179.4 5222.8 5225.8 5258.7 4197.6 4202.3 4215.2 4216.1 4217.2 4033.5 4151.6 4204.4 4209.7 4213.4 4107.7 4113.6 4115.2 4119.0 4156.8 4103.7 4112.3 4115.2 4134.2 4139.9 3657.4 3661.8 3676.7 3681.4 3686.0 5032.5 5119.6 5130.4 5149.2 5162.9 4697.2 4707.9 4714.3 4714.4 4741.9 5409.2 5552.9 5553.0 5559.5 5561.9 4051.6 4054.6 4057.6 4065.9 4069.6 5692.0 5705.9 5723.5 5725.6 5730.2 4031.0 4032.5 4033.3 4038.2 4042.7 4010.3 4065.3 4114.9 4121.6 4127.0 4662.2 4672.8 4675.9 4681.3 4691.8 5550.7 5551.4 5559.4 5574.7 5578.8 1291.8 1322.2 1364.0 1376.7 1396.0 923.2 941.9 946.3 947.6 958.7 5117.9 5142.5 5157.8 5176.9 5182.4 5405.6 5412.9 5436.4 5439.3 5439.7 4918.9 5119.4 5121.7 5138.7 5184.2 2887.8 2892.8 2898.2 2898.5 2900.7 5629.2 5631.2 5642.5 5644.0 5665.3 5286.7 5497.8 5528.6 5548.4 5572.4 5552.3 5573.9 5581.2 5632.2 5639.0 5275.3 5378.7 5403.2 5419.8 5443.3 5366.4 5397.5 5402.1 5405.7 5406.4 5556.5 5560.0 5565.2 5575.4 5591.2 3865.5 3952.3 3955.4 3965.2 3977.9 5383.4 5383.9 5400.4 5446.9 5449.3 5385.9 5470.9 5537.1 5542.8 5551.6 5524.6 5531.2 5540.1 5548.6 5576.2 5248.4 5468.6 5489.6 5489.9 5491.7 5553.3 5556.3 5556.7 5557.7 5564.7 5447.9 5456.7 5470.8 5476.6 5485.3 22:03:38 INFO - PROCESS | 24704 | 22:03:38 INFO - PROCESS | 24704 | [#5] yui.html Cycles:180 Average:16623.15 Median:547.99 stddev:22622.86 (4128.3%) stddev-sans-first:22655.15 22:03:38 INFO - PROCESS | 24704 | Values: 806.7 807.5 823.9 862.7 892.5 11977.4 12918.7 12989.5 13000.7 13099.1 11255.7 11734.9 12139.5 12278.3 12297.3 810.7 833.3 834.2 834.5 834.5 830.6 830.8 832.9 835.3 836.2 883.1 884.1 887.7 890.0 890.2 873.8 878.2 880.7 882.0 882.8 644.4 646.2 646.4 647.7 647.7 11134.9 11144.3 11154.4 11339.0 11757.6 11504.9 11927.5 11930.2 11942.5 12209.8 9630.0 9683.8 9891.6 9967.7 9991.2 3642.6 3680.7 3728.6 3762.8 3784.2 63510.7 65190.0 65393.0 65752.0 66858.7 8886.7 9116.5 9188.8 9203.1 9398.6 18893.2 19070.5 19141.0 19154.4 19164.3 7560.1 7783.1 7853.3 7999.6 8122.2 4461.7 4626.7 4685.7 4704.6 4756.7 3156.5 3268.4 3268.6 3276.7 3279.1 544.5 551.4 567.3 570.8 588.7 650.1 653.7 679.8 688.7 690.1 8147.8 8195.9 8206.3 8325.3 8609.3 607.2 628.3 629.2 646.0 671.1 3850.9 3880.5 3970.9 4030.2 4120.2 85027.6 85605.6 90034.0 90273.5 91900.0 49364.5 51840.7 65719.3 75738.6 80909.0 67356.0 68623.0 68811.3 68934.0 72152.0 8764.3 9212.0 9236.6 9290.0 9298.3 45364.0 45769.3 46256.8 47684.5 48676.0 37611.1 37646.2 40012.8 62572.7 62750.0 11552.5 11751.7 11773.5 11819.2 12188.8 12455.9 12749.9 12948.6 12949.5 13262.3 11266.5 11548.7 11690.8 12209.6 12957.1 11901.8 12020.4 12282.7 12534.3 12913.2 12060.1 12129.2 12187.6 12201.9 12360.9 10136.6 10204.5 10417.2 10425.7 10541.0 10057.6 10610.1 10669.6 10673.6 10780.7 22:03:38 INFO - PROCESS | 24704 | -------- Summary: end -------- 22:03:38 INFO - PROCESS | 24704 | 22:03:39 INFO - TEST-INFO | 24704: exit 0 22:03:39 INFO - TEST-OK | dromaeo_css | took 1113719ms 22:03:39 INFO - TEST-START | kraken 22:03:39 INFO - operating with platform_type : linux_ 22:03:39 INFO - Initialising browser for kraken test... 22:03:39 INFO - TEST-INFO | started process 25019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqipkRZ/profile http://localhost:40988/getInfo.html) 22:03:43 INFO - PROCESS | 25019 | __metrics Screen width/height:1600/1200 22:03:43 INFO - PROCESS | 25019 | colorDepth:24 22:03:43 INFO - PROCESS | 25019 | Browser inner width/height: 1024/697 22:03:43 INFO - PROCESS | 25019 | __metrics 22:03:43 INFO - PROCESS | 25019 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:03:43 INFO - PROCESS | 25019 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:03:44 INFO - PROCESS | 25019 | console.error: PushService: 22:03:44 INFO - PROCESS | 25019 | stateChangeProcessEnqueue: Error transitioning state 22:03:44 INFO - PROCESS | 25019 | UnknownError 22:03:44 INFO - TEST-INFO | 25019: exit 0 22:03:44 INFO - Browser initialized. 22:03:44 INFO - Running cycle 1/1 for kraken test... 22:03:44 INFO - TEST-INFO | started process 25114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqipkRZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:03:56 INFO - PROCESS | 25114 | RSS: Main: 143691776 22:03:56 INFO - PROCESS | 25114 | 22:03:59 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-beat-detection) 22:03:59 INFO - PROCESS | 25114 | RSS: Main: 185409536 22:03:59 INFO - PROCESS | 25114 | 22:04:02 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-dft) 22:04:03 INFO - PROCESS | 25114 | RSS: Main: 175394816 22:04:03 INFO - PROCESS | 25114 | 22:04:05 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-fft) 22:04:06 INFO - PROCESS | 25114 | RSS: Main: 266604544 22:04:06 INFO - PROCESS | 25114 | 22:04:08 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-oscillator) 22:04:09 INFO - PROCESS | 25114 | RSS: Main: 173510656 22:04:09 INFO - PROCESS | 25114 | 22:04:11 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:04:11 INFO - PROCESS | 25114 | RSS: Main: 176050176 22:04:11 INFO - PROCESS | 25114 | 22:04:14 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40988/tests/kraken/driver.html?testName=imaging-darkroom) 22:04:15 INFO - PROCESS | 25114 | RSS: Main: 213692416 22:04:15 INFO - PROCESS | 25114 | 22:04:18 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40988/tests/kraken/driver.html?testName=imaging-desaturate) 22:04:19 INFO - PROCESS | 25114 | RSS: Main: 212570112 22:04:19 INFO - PROCESS | 25114 | 22:04:21 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40988/tests/kraken/driver.html?testName=json-parse-financial) 22:04:22 INFO - PROCESS | 25114 | RSS: Main: 212004864 22:04:22 INFO - PROCESS | 25114 | 22:04:23 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:04:24 INFO - PROCESS | 25114 | RSS: Main: 173809664 22:04:24 INFO - PROCESS | 25114 | 22:04:26 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:04:26 INFO - PROCESS | 25114 | RSS: Main: 180994048 22:04:26 INFO - PROCESS | 25114 | 22:04:28 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:04:29 INFO - PROCESS | 25114 | RSS: Main: 190164992 22:04:29 INFO - PROCESS | 25114 | 22:04:31 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:04:32 INFO - PROCESS | 25114 | RSS: Main: 193372160 22:04:32 INFO - PROCESS | 25114 | 22:04:35 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:04:35 INFO - PROCESS | 25114 | RSS: Main: 194973696 22:04:35 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40988/tests/kraken/driver.html?testName=ai-astar) 22:04:37 INFO - PROCESS | 25114 | RSS: Main: 247173120 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | __start_tp_report 22:04:37 INFO - PROCESS | 25114 | _x_x_mozilla_page_load 22:04:37 INFO - PROCESS | 25114 | _x_x_mozilla_page_load_details 22:04:37 INFO - PROCESS | 25114 | |i|pagename|runs| 22:04:37 INFO - PROCESS | 25114 | |0;ai-astar;103;111;112;110;112;110;110;112;108;109 22:04:37 INFO - PROCESS | 25114 | |1;audio-beat-detection;145;116;123;163;124;123;118;127;155;119 22:04:37 INFO - PROCESS | 25114 | |2;audio-dft;159;161;160;159;159;158;162;162;161;159 22:04:37 INFO - PROCESS | 25114 | |3;audio-fft;74;75;75;104;75;77;76;76;97;75 22:04:37 INFO - PROCESS | 25114 | |4;audio-oscillator;83;83;116;81;80;81;102;81;80;109 22:04:37 INFO - PROCESS | 25114 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;117;117 22:04:37 INFO - PROCESS | 25114 | |6;imaging-darkroom;148;146;146;146;146;147;146;146;147;146 22:04:37 INFO - PROCESS | 25114 | |7;imaging-desaturate;84;85;84;85;85;85;85;86;85;84 22:04:37 INFO - PROCESS | 25114 | |8;json-parse-financial;51;51;51;51;52;54;50;50;51;51 22:04:37 INFO - PROCESS | 25114 | |9;json-stringify-tinderbox;60;59;59;60;60;59;60;59;59;60 22:04:37 INFO - PROCESS | 25114 | |10;stanford-crypto-aes;82;74;82;75;76;80;77;75;74;74 22:04:37 INFO - PROCESS | 25114 | |11;stanford-crypto-ccm;124;132;130;121;137;120;119;125;205;129 22:04:37 INFO - PROCESS | 25114 | |12;stanford-crypto-pbkdf2;155;154;152;157;152;153;152;153;154;151 22:04:37 INFO - PROCESS | 25114 | |13;stanford-crypto-sha256-iterative;62;64;65;62;62;60;62;61;60;67 22:04:37 INFO - PROCESS | 25114 | __end_tp_report 22:04:37 INFO - PROCESS | 25114 | __start_cc_report 22:04:37 INFO - PROCESS | 25114 | _x_x_mozilla_cycle_collect,1546 22:04:37 INFO - PROCESS | 25114 | __end_cc_report 22:04:37 INFO - PROCESS | 25114 | __startTimestamp1484546677786__endTimestamp 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | ------- Summary: start ------- 22:04:37 INFO - PROCESS | 25114 | Number of tests: 14 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.71 (2.5%) stddev-sans-first:1.42 22:04:37 INFO - PROCESS | 25114 | Values: 103.0 111.0 112.0 110.0 112.0 110.0 110.0 112.0 108.0 109.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:125.50 stddev:16.75 (13.3%) stddev-sans-first:17.02 22:04:37 INFO - PROCESS | 25114 | Values: 145.0 116.0 123.0 163.0 124.0 123.0 118.0 127.0 155.0 119.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 22:04:37 INFO - PROCESS | 25114 | Values: 159.0 161.0 160.0 159.0 159.0 158.0 162.0 162.0 161.0 159.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.75 (14.2%) stddev-sans-first:11.15 22:04:37 INFO - PROCESS | 25114 | Values: 74.0 75.0 75.0 104.0 75.0 77.0 76.0 76.0 97.0 75.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.00 stddev:13.83 (17.1%) stddev-sans-first:14.46 22:04:37 INFO - PROCESS | 25114 | Values: 83.0 83.0 116.0 81.0 80.0 81.0 102.0 81.0 80.0 109.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:04:37 INFO - PROCESS | 25114 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 22:04:37 INFO - PROCESS | 25114 | Values: 148.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 22:04:37 INFO - PROCESS | 25114 | Values: 84.0 85.0 84.0 85.0 85.0 85.0 85.0 86.0 85.0 84.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.14 (2.2%) stddev-sans-first:1.20 22:04:37 INFO - PROCESS | 25114 | Values: 51.0 51.0 51.0 51.0 52.0 54.0 50.0 50.0 51.0 51.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 22:04:37 INFO - PROCESS | 25114 | Values: 60.0 59.0 59.0 60.0 60.0 59.0 60.0 59.0 59.0 60.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:3.25 (4.2%) stddev-sans-first:2.87 22:04:37 INFO - PROCESS | 25114 | Values: 82.0 74.0 82.0 75.0 76.0 80.0 77.0 75.0 74.0 74.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:129.50 stddev:25.53 (19.7%) stddev-sans-first:26.81 22:04:37 INFO - PROCESS | 25114 | Values: 124.0 132.0 130.0 121.0 137.0 120.0 119.0 125.0 205.0 129.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:1.77 (1.2%) stddev-sans-first:1.76 22:04:37 INFO - PROCESS | 25114 | Values: 155.0 154.0 152.0 157.0 152.0 153.0 152.0 153.0 154.0 151.0 22:04:37 INFO - PROCESS | 25114 | 22:04:37 INFO - PROCESS | 25114 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:2.22 (3.6%) stddev-sans-first:2.35 22:04:37 INFO - PROCESS | 25114 | Values: 62.0 64.0 65.0 62.0 62.0 60.0 62.0 61.0 60.0 67.0 22:04:37 INFO - PROCESS | 25114 | -------- Summary: end -------- 22:04:37 INFO - PROCESS | 25114 | 22:04:38 INFO - TEST-INFO | 25114: exit 0 22:04:38 INFO - TEST-OK | kraken | took 59154ms 22:04:38 INFO - SUITE-END | took 1172s 22:04:38 INFO - Completed test suite (00:19:32) 22:04:38 INFO - javascript benchmark 22:04:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.1713354527824, 3210.357928414316, 3212.919677008074, 3237.2392487765355, 3265.281638039632, 5467.179923011546, 5577.9163312550245, 5578.972105139479, 5594.944050559493, 5607.046802043657, 5486.286782718251, 5534.335879694432, 5548.77804887805, 5549.972250138754, 5583.5254003409755, 5009.073321435528, 5031.798728050873, 5065.949340506603, 5099.15863882459, 5100.515451032146, 4870.512948705119, 5069.518395752416, 5113.411957624883, 5118.6416950813455, 5125.923111153335, 4844.055409195208, 4980.900381992358, 4996.050750357439, 5023.799048038074, 5033.924491132636, 5040.924386134211, 5144.948550514484, 5156.175011998081, 5159.019786240602, 5165.690058596496, 4992.126377883892, 5062.2406639004075, 5102.795888164469, 5123.8206662767, 5124.4106927703415, 5355.410904800468, 5382.6232163748555, 5402.0, 5426.294581704393, 5436.537894278991, 5809.070548712186, 5828.97085514574, 5838.64968101911, 5945.405459454063, 5950.940490595082, 6000.519958403317, 6022.277326720778, 6026.819195424145, 6032.788852390189, 6038.637681739066, 5394.487523685244, 5427.972860135674, 5461.563074954034, 5487.862803429946, 5505.559555235572, 6020.157177995085, 6034.39656034393, 6051.334353221142, 6056.394360563996, 6057.878842423127, 5800.6809625471005, 5807.186993820868, 5808.3901190375245, 5816.5928385013485, 5830.3586605473365, 5769.221155144086, 5785.450382213683, 5810.82567522975, 5831.795887144014, 5837.0, 5871.178035075093, 5882.55880808941, 5886.793962211388, 5910.172575839386, 5936.0, 5867.061270196748, 5881.617694849821, 5916.497097746654, 5921.437463440966, 5921.61509501881, 4471.754053527087, 4513.526079761644, 4523.841665541756, 4555.2256116460285, 4610.561996610317, 4110.0752330725345, 4138.110306284163, 4139.937900931428, 4157.417961485395, 4161.146964872194, 5670.06443936754, 5672.97163514188, 5685.60200785941, 5686.914696279559, 5726.513246374022, 5717.685527296038, 5745.8563535911935, 5751.252337196222, 5827.737751801179, 5952.702364881825, 5512.145617429305, 5531.917021244684, 5547.0, 5567.832965010975, 5570.387257401682, 5114.872128196825, 5131.666441681279, 5147.1507201312115, 5176.948230517722, 5201.661891977009, 6203.906941395882, 6211.782587609502, 6214.223222097328, 6215.658138802319, 6230.844228894314, 5781.942180578309, 5912.615679980788, 5965.582409231486, 5969.313528944227, 5972.104184372379, 6048.455638992512, 6077.270727512727, 6093.75624974996, 6119.969400152971, 6216.595921265103, 5833.620814647034, 5852.239208902815, 5853.268341457318, 5855.180274761622, 5895.263092113486, 5959.91060134107, 5970.9701451492465, 5972.432618901197, 5972.970135149297, 5975.223220981245, 5618.550515958796, 5648.971755141198, 5681.517071049007, 5698.430156984268, 5721.456461636138, 5783.987802134694, 5790.884182316246, 5799.797007104731, 5805.10020946754, 5808.651480911159, 5723.112917497794, 5726.055200891973, 5731.168980497888, 5733.31200255972, 5740.282464691913, 5650.858728531655, 5661.094224923992, 5760.8271751847515, 5780.132980053026, 5794.304683438015, 5721.370649228498, 5753.424657534213, 5773.595848290579, 5783.624064435967, 5795.8551036224435], "value": 5459.661027317912, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6547538739063, 602.0667964654785, 623.6102435977514, 649.6556824882814, 659.5778701630957, 35192.2961540769, 36030.09924751876, 36037.2792544149, 36049.0, 36051.27897442053, 35980.640193598054, 44856.55143448564, 45839.31241031379, 45854.77072614641, 49184.262236066395, 8726.52004139772, 8840.513771742551, 8845.425047371933, 8845.469271843678, 8847.292216622654, 8256.711015114472, 8465.111163327854, 8821.073787252342, 8921.107889211093, 8927.508987005713, 10366.326188797742, 10670.573177072907, 10676.519556619933, 10910.23628346016, 10932.180086493505, 10601.946990265038, 10673.306235094733, 10675.83986240207, 10678.946605267001, 10680.732981675443, 10569.577216911315, 10601.73495662607, 10646.25476216665, 10650.520726567323, 10651.78696426075, 42526.0, 43056.569434305886, 43148.35277470841, 43202.56797432048, 43258.0, 3381.695647391722, 3395.371856206585, 3444.1389652586854, 3454.3436747017986, 3567.0, 31408.685913140805, 31778.0, 33799.217473131495, 34191.48712769311, 34856.82571587151, 4391.8462853799965, 4458.554144585548, 4466.1067786442845, 4553.840615578472, 4592.380028696117, 390852.0, 404093.0, 404280.0, 404852.99999999703, 405523.0, 39755.60244397519, 40784.79607602002, 67373.0, 68464.6576767113, 68525.0, 42671.786641066596, 42846.57153428488, 42933.35599966003, 42991.35512967308, 43014.0, 17119.828801712072, 17132.743008854875, 17353.7396939046, 17380.0, 17388.0436575987, 14400.351984160738, 14598.051126676732, 14620.561383158521, 14622.195779232032, 14630.122192668474, 9067.591958361889, 9222.584983675752, 9343.439393636403, 9673.419594824332, 9835.164011058998, 3768.5477742670505, 3775.715127838798, 3788.791616461121, 3796.3925771876366, 3850.9229815404096, 965.5896244096231, 1042.713253855196, 1059.9682009539727, 1142.154805443982, 1148.1388958281289, 32680.0, 32800.50799238013, 32970.67029329676, 33257.66742332594, 33457.49813752795, 1111.7331840358256, 1137.2039572299423, 1166.125405945541, 1216.3370962825104, 1231.926084434919, 14968.47610333633, 17491.38780142689, 18067.72898406525, 18459.723104153447, 19439.0, 594179.0, 595098.0, 595122.0, 598855.0, 599480.0, 61624.69187654123, 61934.69032654898, 62002.37997619966, 62133.0, 62134.689326553074, 1312.0880987713447, 1358.9864101359058, 1379.8068270442145, 1401.2363262022222, 1411.5412490940485, 28179.859100704365, 29294.70705293005, 29791.851040745525, 29821.254468638457, 30432.543511847784, 52092.0, 52573.0, 52601.473985259654, 52611.47388526066, 52793.0, 430571.0, 436235.6376436195, 440072.0, 441137.0, 515473.0, 41865.79067104645, 45573.54426455693, 45803.77098114488, 46123.3081503771, 46624.0, 49752.50247497479, 50290.24564631606, 50556.24165637445, 50628.24057639065, 50957.490425095275, 42273.0, 42611.14777704367, 42850.57149428466, 42945.570544294154, 43921.34117988297, 41630.16739665129, 41870.37194442025, 42110.36834447424, 43239.56760432355, 43427.0, 42979.0, 43646.781766090964, 43767.12465750731, 44025.11949760923, 44273.55726442694, 36379.636203638685, 37998.62001379951, 38201.61798381981, 38220.0, 38555.42166867443, 28731.425371492034, 29285.0, 29354.559681604365, 29413.558796618498, 29432.0], "value": 20180.785738474246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7427697719506, 414.47775802488854, 424.3147317082911, 428.5371798457666, 443.0562901020825, 14741.926290368547, 18989.0, 19010.61978760424, 19011.239550417966, 20042.799572004275, 12813.743725125492, 13007.479700811957, 13041.21752694839, 13083.869161308385, 13116.93441532791, 4007.9799601001955, 4242.469691288589, 5136.974315128428, 5279.366476022883, 5294.126469132589, 5475.835724928259, 5703.429657034305, 5746.655200687972, 5815.912761308584, 5840.094785308284, 5795.0, 5800.361960184377, 5903.0, 6422.967885160568, 6451.903221451682, 6443.25902521209, 6467.385598368194, 6480.8055758326855, 6483.254425741029, 6486.902696459557, 5090.77091530882, 5400.972995134999, 5421.051316019681, 5477.04151773442, 5490.231367608538, 13582.25297608631, 13671.043026988114, 13690.178589284675, 13729.931350343284, 13835.930820345935, 2296.9655455168186, 2399.6280576510667, 2409.614461686122, 2758.5518102372034, 2840.1053668094482, 9461.716148515556, 9886.653967111188, 10192.980701929822, 10347.586096556128, 10468.42423666698, 1969.5470041890303, 2013.1645367172605, 2026.98986505068, 2097.182098981383, 2115.2596591193114, 79851.20148798496, 87485.562572188, 88242.0, 89524.0, 92502.5374873128, 11300.265482743594, 11571.42142892852, 11585.536578536765, 11635.709107272216, 11820.468078936468, 16679.416220432468, 16686.33254669824, 16697.165141742866, 16703.16484175786, 16713.164341782864, 8407.537585432738, 8616.569171541398, 8679.522626255617, 8689.869651955225, 8822.426542274732, 8546.401751877309, 8570.357223208159, 8574.914250857411, 8736.91263087361, 8767.605457754416, 4804.711717296974, 4852.733099679481, 4852.757362131879, 4856.465788763233, 4913.385826771653, 1989.502624343914, 2030.4213299209655, 2050.3438899552, 2072.357569153567, 2107.694384314266, 967.0320896974623, 989.7575094101991, 1030.6289735695143, 1049.2393015064017, 1088.733260351219, 18784.436466906016, 20423.183072677224, 20983.16067357319, 21893.014814333073, 21963.560728785655, 1057.2176589323844, 1065.7921705267554, 1080.287010573018, 1083.1930211992117, 1084.6258040975852, 11355.54577816878, 11663.125265605113, 11813.936745692929, 11849.644510664693, 11997.880021199851, 513855.0, 515588.0, 517802.0, 539920.0, 541912.0, 97157.51421242849, 97749.0, 98176.50911745538, 99756.0, 102730.48634756778, 1033.3489901362093, 1064.510325250378, 1075.1398880895408, 1088.4612117002134, 1095.4741723972538, 13805.861941380457, 17636.34468691226, 18210.635787283914, 18239.361622343153, 18242.72635910436, 44605.77697111494, 45261.54738452705, 45677.54322456733, 45699.771501142284, 45877.0, 58166.7091664539, 58546.4145358558, 58647.0, 59334.98987116946, 60271.69864150651, 7855.175206603224, 8248.257656810916, 8539.573021349031, 8720.258778003941, 8879.200871921557, 12855.871441285468, 12877.034222433167, 12900.161489503153, 13060.869391305965, 13065.0, 11719.355435451133, 11785.587504437304, 11849.466773995364, 12023.879761202275, 12149.81775273354, 11329.320240785579, 11362.602308919148, 11493.82759258595, 11527.481263343338, 12025.759484810429, 11608.6517404478, 11729.648110556696, 11773.941130294294, 11864.347460889734, 12232.877671223174, 7826.0, 7933.286004259644, 7959.761207163794, 8121.675132994614, 8193.303569196685, 9893.455859927773, 11569.305841649528, 11741.530338786353, 11745.941270293593, 12024.519019239133], "value": 9245.50435575162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.7269905067562, 1512.6672132130932, 1607.6222087809363, 1733.8786284960058, 1771.4508502364267, 8431.536265505394, 8957.19385255326, 8970.3272254581, 8982.865257021142, 8993.820123597525, 7913.841723165548, 8190.344772418192, 8392.91607083929, 8558.229759321659, 8668.046514883374, 2444.9511009779794, 2496.3634273260295, 2498.812589055819, 2509.397744541306, 2511.3470497670646, 2477.54165479386, 2564.0897481394118, 2565.115035312814, 2568.858712770797, 2571.151519998396, 2495.0394098272113, 2498.4253621667026, 2524.4572416930355, 2530.0891678995545, 2531.50635626053, 2356.9764302357016, 2357.198552492161, 2375.3111597636666, 2388.283514945527, 2390.940226494334, 2431.732509423962, 2441.9865755711357, 2455.815813813971, 2463.81521385895, 2467.6545283660303, 8769.561521923943, 8816.955915220447, 8858.822823543558, 8863.290936725047, 8866.113388661146, 5427.267318911936, 5580.804671836507, 5586.608937374385, 5588.636738611977, 5605.747741351608, 3422.503736958152, 3483.1292176955762, 3536.752427330088, 3547.5210846535647, 3592.425211966099, 1171.1626187276054, 1172.5192671004932, 1200.5257923120319, 1208.570957310151, 1243.5212443209339, 12140.878591214063, 12412.75174496505, 12419.31693756843, 12424.56514022005, 12513.43689533964, 4767.070421267819, 4877.951220487821, 4906.779194936236, 4939.530744579331, 5014.348134742533, 10438.895611043945, 10448.947755261328, 10462.47687615616, 10469.057784799405, 10478.161747060218, 5583.553315734813, 5586.692731899703, 5588.189712491747, 5590.2453168821685, 5595.63628364155, 4510.120526497367, 4651.0, 4896.2655601660035, 4937.0, 5081.771320290596, 4151.12826306479, 4162.375643653476, 4196.097838964637, 4240.978795106004, 4247.299195632748, 1348.9932550337185, 1408.2747385096684, 1417.922014289224, 1425.9144451332954, 1428.357239242345, 688.9276625954303, 772.1814876231213, 851.7827953871847, 856.7429771068779, 858.038996324121, 5729.169270455844, 5873.412658734178, 5886.087656413263, 5902.085176797603, 6097.146399504073, 955.2071780422233, 972.2367941166151, 982.7346616413529, 984.7882705218412, 1018.6129270877168, 3860.478835357247, 3926.3521518949055, 3929.214157168578, 3966.702497312713, 3998.5601583825755, 10491.475426228812, 11080.778384432266, 11084.501197446134, 11103.389313587668, 11117.666470005914, 10730.570777168827, 10830.945845270724, 11002.724931876766, 11005.17461190414, 11011.889881101246, 8376.288015518749, 8474.0, 8479.618417171243, 8498.53258070812, 8502.2773064289, 5464.1257398816, 5602.915956260741, 5656.462636049569, 5685.914711279417, 5698.715064246854, 9956.352837065568, 10039.0, 10040.64857729976, 10056.899431005597, 10065.748356291151, 10155.441450720282, 10156.695299141038, 10162.745931351776, 10269.229807764297, 10339.0, 7539.849203016019, 7677.30904218623, 7702.730404435818, 7703.38372930153, 7703.730369437043, 7969.6015199240965, 8093.231143041402, 8162.632681529227, 8207.0, 8214.0, 7259.2377800330205, 7319.34125928669, 7340.522866013692, 7419.369353605004, 7429.368503677248, 7206.783796486114, 7256.129264488295, 7301.196868344584, 7385.335319821242, 7460.738874139379, 6339.080833279057, 6440.259370172303, 6440.452561532322, 6451.032345148265, 6508.772192973223, 4806.927896081632, 4893.926591101207, 4943.431505376928, 4990.850274491771, 5153.768080436314, 4855.611551075976, 4889.168841297059, 4928.901421971469, 4957.702537847741, 5010.323606313101], "value": 4677.894048698008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1866476450812, 344.39902370363717, 349.85306171408007, 355.2327172317719, 359.9651003365325, 5178.974105129479, 5260.894782104356, 5321.494458026486, 5322.152648333143, 5325.707086110262, 5117.846464606058, 5179.394387739803, 5222.791088356461, 5225.824189557347, 5258.737063146837, 4197.622214000739, 4202.285611446062, 4215.178040282146, 4216.072464057902, 4217.219814334358, 4033.5159780826343, 4151.605597468236, 4204.432401625787, 4209.663226941837, 4213.389058586518, 4107.650849677781, 4113.56807535209, 4115.176964607075, 4118.97940510297, 4156.771377574232, 4103.722434049101, 4112.300908845474, 4115.218108559379, 4134.193832202722, 4139.937900931488, 3657.414813629833, 3661.7802931824176, 3676.7242456815848, 3681.44778283257, 3686.0232038509816, 5032.496750324938, 5119.641625086246, 5130.410002849682, 5149.201873709543, 5162.92255616166, 4697.224957881946, 4707.917179048838, 4714.339992401066, 4714.38712967312, 4741.881452963669, 5409.161579955114, 5552.944470555283, 5552.972700050504, 5559.527440167591, 5561.9420814298965, 4051.5745846686264, 4054.5945405459515, 4057.6348128668265, 4065.9390109148385, 4069.5930406959365, 5691.9715401423555, 5705.942940570624, 5723.484886360247, 5725.599208055438, 5730.169125476783, 4030.9596904030586, 4032.4556184915245, 4033.2941735196223, 4038.2327357801923, 4042.717009809344, 4010.3382941814857, 4065.288574499451, 4114.917701645951, 4121.649659778953, 4126.968257935516, 4662.160811054043, 4672.813087476463, 4675.929861052087, 4681.344611754357, 4691.81232750693, 5550.694711790809, 5551.3631025262675, 5559.416261292587, 5574.721263936787, 5578.804741834017, 1291.8449786025737, 1322.233104799214, 1363.9522616708368, 1376.7384197002536, 1395.9860401396058, 923.2198792020732, 941.8634298026748, 946.2619157057507, 947.6398968392105, 958.6836344006462, 5117.8996515749295, 5142.534377702337, 5157.819476318311, 5176.8964620707375, 5182.352205974254, 5405.621606487587, 5412.864678383072, 5436.374816896028, 5439.3200849893765, 5439.673619582838, 4918.926216106761, 5119.385673719177, 5121.692698438031, 5138.665986710852, 5184.222366644958, 2887.815995441859, 2892.7975041747295, 2898.217710997466, 2898.4927637663322, 2900.7244311790346, 5629.155626656035, 5631.227077857845, 5642.548596112301, 5644.0, 5665.348484924204, 5286.731184515688, 5497.780088796403, 5528.640638358494, 5548.361938377057, 5572.359178694421, 5552.333719953632, 5573.916391254053, 5581.190727344512, 5632.211490391349, 5638.97180514103, 5275.314209152785, 5378.655336165959, 5403.243545903655, 5419.783208671766, 5443.292371991616, 5366.356037275552, 5397.517142114514, 5402.135658294654, 5405.675659460445, 5406.351237851483, 5556.49974506889, 5559.969816449963, 5565.220869078251, 5575.442455754554, 5591.217229587943, 3865.458835763052, 3952.26883026641, 3955.3869150281753, 3965.167314863911, 3977.920441591094, 5383.434739352469, 5383.946160538345, 5400.405955344988, 5446.945530544803, 5449.3460784706085, 5385.892282154413, 5470.863228419322, 5537.086380747131, 5542.806001790079, 5551.639143455663, 5524.613277070566, 5531.170324451365, 5540.141278101901, 5548.611597188319, 5576.219329293983, 5248.448912864094, 5468.644538105011, 5489.615726899079, 5489.862753431196, 5491.670499770026, 5553.305836770403, 5556.305461817273, 5556.749946252509, 5557.722113894209, 5564.693941833238, 5447.855950250333, 5456.690394305258, 5470.753816078366, 5476.616636835383, 5485.286912701324], "value": 4175.892639077035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.6652339279195, 807.5235610989512, 823.8599438095523, 862.706679728892, 892.535881341702, 11977.4011299435, 12918.677033074166, 12989.480420783157, 13000.674983125404, 13099.148555343896, 11255.66233013011, 11734.882651173486, 12139.514419423213, 12278.263304201753, 12297.262164270127, 810.6797814863125, 833.3083540661266, 834.157500924068, 834.486790623765, 834.5034704350901, 830.5639539241886, 830.779843341515, 832.8750687396908, 835.3108685334623, 836.1847198981005, 883.1168831168832, 884.1335491218609, 887.7203680840514, 889.9599518021672, 890.2255038116847, 873.7902903303225, 878.1745159550003, 880.6873559886276, 881.9559022048904, 882.8190221004679, 644.391050457318, 646.1503123392723, 646.4472875691263, 647.7117682631231, 647.7150053976235, 11134.888651113466, 11144.33134011962, 11154.442277886154, 11339.0, 11757.58848440309, 11504.940726234387, 11927.463264153133, 11930.224535405257, 11942.46258918342, 12209.816852747215, 9630.02584470189, 9683.757906052335, 9891.554880030415, 9967.700968970943, 9991.150752186073, 3642.5811031731423, 3680.650338217865, 3728.608496107897, 3762.7930463824478, 3784.2431513697097, 63510.68244658793, 65190.0, 65393.0, 65752.0, 66858.66570667115, 8886.688965886293, 9116.45301281912, 9188.770280742901, 9203.125703058198, 9398.624055037722, 18893.244270229035, 19070.523236919187, 19141.0, 19154.425367239004, 19164.329248476235, 7560.130584982688, 7783.104942931635, 7853.253940875607, 7999.600019998977, 8122.228388303101, 4461.665375096881, 4626.699264547794, 4685.718856868599, 4704.576588107018, 4756.7145971241835, 3156.463401221798, 3268.444364458048, 3268.5587445695, 3276.737860971117, 3279.1474216703828, 544.5317027356471, 551.4485514485515, 567.2625586737225, 570.7916610437161, 588.7203578300273, 650.1125963060483, 653.7221680785647, 679.7586856665911, 688.7141836138047, 690.0580707334552, 8147.79630509242, 8195.877061844078, 8206.261436470626, 8325.292350150185, 8609.268212201907, 607.2288193993692, 628.3151365012159, 629.2103410220236, 646.0374042676473, 671.080619551218, 3850.9229815403537, 3880.5149356330458, 3970.940435893464, 4030.234255491447, 4120.1553681495225, 85027.5748621253, 85605.57197213975, 90034.0, 90273.54863225773, 91900.0, 49364.50635493671, 51840.74079629653, 65719.34280657228, 75738.62130689422, 80909.0, 67356.0, 68623.0, 68811.31188688149, 68934.0, 72152.0, 8764.339102282438, 9212.0, 9236.630534778533, 9290.0, 9298.302627303116, 45364.0, 45769.31346029745, 46256.768716156206, 47684.5231547694, 48676.0, 37611.05972350713, 37646.2470750578, 40012.799936000134, 62572.687136564025, 62750.0, 11552.537898483966, 11751.706207344885, 11773.52905883755, 11819.172657914207, 12188.817167742314, 12455.875441245471, 12749.93625031869, 12948.611541653765, 12949.54676586315, 13262.336883155996, 11266.493007814832, 11548.653540393801, 11690.76618467643, 12209.633710988684, 12957.093003489665, 11901.76196476083, 12020.398980051137, 12282.692932676755, 12534.310612916013, 12913.225206487641, 12060.095492837896, 12129.21160124589, 12187.573434929735, 12201.938990304992, 12360.938195308965, 10136.594536218468, 10204.540795664065, 10417.166626669698, 10425.687229383131, 10541.0, 10057.597696092367, 10610.098141658045, 10669.57321707123, 10673.57305707763, 10780.676579702622], "value": 6711.707030989839, "unit": "score"}], "name": "dromaeo_css", "value": 7149.659541047133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 110.0, 112.0, 110.0, 110.0, 112.0, 108.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 123.0, 163.0, 124.0, 123.0, 118.0, 127.0, 155.0, 119.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 159.0, 159.0, 158.0, 162.0, 162.0, 161.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 104.0, 75.0, 77.0, 76.0, 76.0, 97.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 81.0, 80.0, 81.0, 102.0, 81.0, 80.0, 109.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.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": [148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 52.0, 54.0, 50.0, 50.0, 51.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 82.0, 75.0, 76.0, 80.0, 77.0, 75.0, 74.0, 74.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 130.0, 121.0, 137.0, 120.0, 119.0, 125.0, 205.0, 129.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 152.0, 157.0, 152.0, 153.0, 152.0, 153.0, 154.0, 151.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 65.0, 62.0, 62.0, 60.0, 62.0, 61.0, 60.0, 67.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1456.6, "alertThreshold": 2.0}]} 22:04:39 INFO - Return code: 0 22:04:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:04:39 INFO - # TBPL SUCCESS # 22:04:39 INFO - Running post-action listener: _resource_record_post_action 22:04:39 INFO - [mozharness: 2017-01-16 06:04:39.077474Z] Finished run-tests step (success) 22:04:39 INFO - Running post-run listener: _resource_record_post_run 22:04:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 345939968; Read time: 32; Write time: 270924 22:04:39 INFO - TinderboxPrint: CPU usage
13.0% 22:04:39 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 32 22:04:39 INFO - TinderboxPrint: I/O write bytes / time
345,939,968 / 270,924 22:04:39 INFO - TinderboxPrint: CPU idle
8,256.5 (87.0%) 22:04:39 INFO - TinderboxPrint: CPU user
1,190.5 (12.5%) 22:04:39 INFO - TinderboxPrint: Swap in / out
0 / 0 22:04:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108310528; Read time: 0; Write time: 119768 22:04:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 237629440; Read time: 24; Write time: 151156 22:04:39 INFO - Running post-run listener: _upload_blobber_files 22:04:39 INFO - Blob upload gear active. 22:04:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:04:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:04:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:04:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:04:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:40 INFO - (blobuploader) - INFO - Done attempting. 22:04:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:04:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:04:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:44 INFO - (blobuploader) - INFO - Done attempting. 22:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:45 INFO - (blobuploader) - INFO - Done attempting. 22:04:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:04:45 INFO - Return code: 0 22:04:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:04:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:04:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19fae083076be293c07c4227a904c25fa6946a01cefcbef628d70309696083beb13dff6e358450d72d0b5c311d32c473dcee480a7d34478c18ac570e3fefaff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b2a84868823650c715c4a644b799aedbe031b08df246974ff2c6d322c4afb8099fb4a8aa4db1e66930bbe471dc298b1487b5ad921732832d7e621cafc3307d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8289935e22efa190aba7f5d57ec8ec3ee8234ef44c9b0c4f90daf00091728ac2a4ee5f1ec0b4c724f6e87f58cd0ea0b80822a6a94fa02aea5592994d505afcc7"} 22:04:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:04:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:04:45 INFO - Contents: 22:04:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19fae083076be293c07c4227a904c25fa6946a01cefcbef628d70309696083beb13dff6e358450d72d0b5c311d32c473dcee480a7d34478c18ac570e3fefaff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b2a84868823650c715c4a644b799aedbe031b08df246974ff2c6d322c4afb8099fb4a8aa4db1e66930bbe471dc298b1487b5ad921732832d7e621cafc3307d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8289935e22efa190aba7f5d57ec8ec3ee8234ef44c9b0c4f90daf00091728ac2a4ee5f1ec0b4c724f6e87f58cd0ea0b80822a6a94fa02aea5592994d505afcc7"} 22:04:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:04:45 INFO - Copying logs to upload dir... 22:04:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:04:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.941633 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-15 22:04:45.174753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 22:04:45.182622) ========= 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=923d835db2ba3686ebe126b700000192-1484543735.160317-176674690 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/19fae083076be293c07c4227a904c25fa6946a01cefcbef628d70309696083beb13dff6e358450d72d0b5c311d32c473dcee480a7d34478c18ac570e3fefaff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b2a84868823650c715c4a644b799aedbe031b08df246974ff2c6d322c4afb8099fb4a8aa4db1e66930bbe471dc298b1487b5ad921732832d7e621cafc3307d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8289935e22efa190aba7f5d57ec8ec3ee8234ef44c9b0c4f90daf00091728ac2a4ee5f1ec0b4c724f6e87f58cd0ea0b80822a6a94fa02aea5592994d505afcc7"} build_url:https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/MPtHIaMxRSy11EWrmfCJhQ/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/19fae083076be293c07c4227a904c25fa6946a01cefcbef628d70309696083beb13dff6e358450d72d0b5c311d32c473dcee480a7d34478c18ac570e3fefaff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b2a84868823650c715c4a644b799aedbe031b08df246974ff2c6d322c4afb8099fb4a8aa4db1e66930bbe471dc298b1487b5ad921732832d7e621cafc3307d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8289935e22efa190aba7f5d57ec8ec3ee8234ef44c9b0c4f90daf00091728ac2a4ee5f1ec0b4c724f6e87f58cd0ea0b80822a6a94fa02aea5592994d505afcc7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 22:04:45.210567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 22:04:45.210899) ========= 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=923d835db2ba3686ebe126b700000192-1484543735.160317-176674690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 22:04:45.260001) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 22:04:45.262371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 22:04:45.262692) ========= ========= Total master_lag: 0.24 =========