builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1484994713.76 results: success (0) buildid: 20170121004004 builduid: b1e21b1400f94c1cb3f53e3f32612070 revision: a891cb2fa60257c3a8cb84bb0356fba508e42f3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.763794) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.764198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.764509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.818097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.818358) ========= 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=cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-21 02:31:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2017-01-21 02:31:54 (32.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078544 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.915439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.915740) ========= 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=cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019795 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.972539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:53.972888) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a891cb2fa60257c3a8cb84bb0356fba508e42f3e --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 a891cb2fa60257c3a8cb84bb0356fba508e42f3e --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=cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-21 02:31:54,461 truncating revision to first 12 chars 2017-01-21 02:31:54,461 Setting DEBUG logging. 2017-01-21 02:31:54,461 attempt 1/10 2017-01-21 02:31:54,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a891cb2fa602?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-21 02:31:54,746 unpacking tar archive at: mozilla-aurora-a891cb2fa602/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539920 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:54.531930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:54.532378) ========= script_repo_revision: a891cb2fa60257c3a8cb84bb0356fba508e42f3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:54.532957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:54.533389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 02:31:54.560912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-01-21 02:31:54.561228) ========= /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=cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:55 INFO - MultiFileLogger online at 20170121 02:31:55 in /builds/slave/test 02:31:55 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 02:31:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:55 INFO - {'append_to_log': False, 02:31:55 INFO - 'base_work_dir': '/builds/slave/test', 02:31:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:31:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:55 INFO - 'branch': 'Mozilla-Aurora', 02:31:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:55 INFO - 'config_files': ('talos/linux_config.py',), 02:31:55 INFO - 'default_actions': ('clobber', 02:31:55 INFO - 'read-buildbot-config', 02:31:55 INFO - 'download-and-extract', 02:31:55 INFO - 'populate-webroot', 02:31:55 INFO - 'create-virtualenv', 02:31:55 INFO - 'install', 02:31:55 INFO - 'run-tests'), 02:31:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:55 INFO - 'download_minidump_stackwalk': True, 02:31:55 INFO - 'download_symbols': 'ondemand', 02:31:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:55 INFO - 'installer_path': 'installer.exe', 02:31:55 INFO - 'log_level': 'info', 02:31:55 INFO - 'log_name': 'talos', 02:31:55 INFO - 'log_to_console': True, 02:31:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:55 INFO - 'opt_config_files': (), 02:31:55 INFO - 'pip_index': False, 02:31:55 INFO - 'sps_profile': False, 02:31:55 INFO - 'sps_profile_interval': 0, 02:31:55 INFO - 'suite': 'dromaeojs', 02:31:55 INFO - 'system_bits': '32', 02:31:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:55 INFO - 'title': 'talos-linux64-ix-054', 02:31:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:55 INFO - 'use_talos_json': True, 02:31:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:55 INFO - 'work_dir': 'build'} 02:31:55 INFO - [mozharness: 2017-01-21 10:31:55.141561Z] Running clobber step. 02:31:55 INFO - Running pre-action listener: _resource_record_pre_action 02:31:55 INFO - Running main action method: clobber 02:31:55 INFO - rmtree: /builds/slave/test/build 02:31:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:55 INFO - Running post-action listener: _resource_record_post_action 02:31:55 INFO - [mozharness: 2017-01-21 10:31:55.615224Z] Finished clobber step (success) 02:31:55 INFO - [mozharness: 2017-01-21 10:31:55.615326Z] Running read-buildbot-config step. 02:31:55 INFO - Running pre-action listener: _resource_record_pre_action 02:31:55 INFO - Running main action method: read_buildbot_config 02:31:55 INFO - Using buildbot properties: 02:31:55 INFO - { 02:31:55 INFO - "project": "", 02:31:55 INFO - "product": "firefox", 02:31:55 INFO - "script_repo_revision": "production", 02:31:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:31:55 INFO - "repository": "", 02:31:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:31:55 INFO - "buildid": "20170121004004", 02:31:55 INFO - "stage_platform": "linux64-pgo", 02:31:55 INFO - "basedir": "/builds/slave/test", 02:31:55 INFO - "nightly_build": "True", 02:31:55 INFO - "buildnumber": 715, 02:31:55 INFO - "slavename": "talos-linux64-ix-054", 02:31:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:31:55 INFO - "platform": "ubuntu64_hw", 02:31:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:31:55 INFO - "branch": "mozilla-aurora", 02:31:55 INFO - "repo_path": "releases/mozilla-aurora", 02:31:55 INFO - "revision": "a891cb2fa60257c3a8cb84bb0356fba508e42f3e", 02:31:55 INFO - "pgo_build": "True", 02:31:55 INFO - "builduid": "b1e21b1400f94c1cb3f53e3f32612070", 02:31:55 INFO - "slavebuilddir": "test" 02:31:55 INFO - } 02:31:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:31:55 INFO - Running post-action listener: _resource_record_post_action 02:31:55 INFO - [mozharness: 2017-01-21 10:31:55.617842Z] Finished read-buildbot-config step (success) 02:31:55 INFO - [mozharness: 2017-01-21 10:31:55.617932Z] Running download-and-extract step. 02:31:55 INFO - Running pre-action listener: _resource_record_pre_action 02:31:55 INFO - Running main action method: download_and_extract 02:31:55 INFO - mkdir: /builds/slave/test/build/tests 02:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:55 INFO - trying https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:55 INFO - Downloading https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/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 02:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/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 02:31:56 INFO - Downloaded 1361 bytes. 02:31:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:56 INFO - Using the following test package requirements: 02:31:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:31:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:31:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'jsshell-linux-x86_64.zip'], 02:31:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:31:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:31:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:31:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:31:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:31:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:31:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:56 INFO - Fetch https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:56 INFO - Http code: 200 02:31:56 INFO - via: 1.1 7db492e48a5d55351dcb787a8a14e113.cloudfront.net (CloudFront) 02:31:56 INFO - x-amz-cf-id: Hf_URry6I1iY-0ezQ37e3bsnmmKDKyYI6XrQEYDQev9wc0sCF6jWPA== 02:31:56 INFO - x-amz-version-id: upMgCQbDBOqwgUYMbypB3ZzzoOJGNDNg 02:31:58 INFO - Expected file size: 21950857 02:31:58 INFO - Obtained file size: 21950857 02:32:02 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 02:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:32:02 INFO - Http code: 200 02:32:02 INFO - via: 1.1 8e86372eaaa62fc64b70e7bcde725dd9.cloudfront.net (CloudFront) 02:32:02 INFO - x-amz-cf-id: eY_xiosq3E_Fld4_GA8z7TboId0WiX8_7CEuvgfpROYmTfZbE9OW7A== 02:32:02 INFO - x-amz-version-id: upMgCQbDBOqwgUYMbypB3ZzzoOJGNDNg 02:32:03 INFO - Expected file size: 21950857 02:32:03 INFO - Obtained file size: 21950857 02:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:32:08 INFO - Http code: 200 02:32:08 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 02:32:08 INFO - x-amz-cf-id: V7YmZhuXpnQ7bjkg4LAPHF1lMxp3wP7odjuPCIV30WOHAtykuB68RQ== 02:32:08 INFO - x-amz-version-id: RewsAOQnOUhVHNfREbtjM.1tkBVr0H7d 02:32:09 INFO - Expected file size: 14402992 02:32:09 INFO - Obtained file size: 14402992 02:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:09 INFO - trying https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:09 INFO - Downloading https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/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 02:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/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 02:32:12 INFO - Downloaded 64508388 bytes. 02:32:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:12 INFO - mkdir: /builds/slave/test/properties 02:32:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:12 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:12 INFO - Contents: 02:32:12 INFO - build_url:https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - Running post-action listener: _resource_record_post_action 02:32:13 INFO - Running post-action listener: set_extra_try_arguments 02:32:13 INFO - [mozharness: 2017-01-21 10:32:13.167605Z] Finished download-and-extract step (success) 02:32:13 INFO - [mozharness: 2017-01-21 10:32:13.167834Z] Running populate-webroot step. 02:32:13 INFO - Running pre-action listener: _resource_record_pre_action 02:32:13 INFO - Running main action method: populate_webroot 02:32:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:13 INFO - '--tppagecycles', 02:32:13 INFO - '7'], 02:32:13 INFO - 'tests': ['tsvgm']}}, 02:32:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['damp', 'tps']}, 02:32:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'tests': ['damp', 'tps']}, 02:32:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['dromaeo_dom']}, 02:32:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['basic_compositor_video']}, 02:32:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['a11yr', 02:32:13 INFO - 'ts_paint', 02:32:13 INFO - 'tpaint', 02:32:13 INFO - 'sessionrestore', 02:32:13 INFO - 'sessionrestore_no_auto_restore', 02:32:13 INFO - 'tabpaint']}, 02:32:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tsvgx', 02:32:13 INFO - 'tsvgr_opacity', 02:32:13 INFO - 'tart', 02:32:13 INFO - 'tscrollx', 02:32:13 INFO - 'cart']}, 02:32:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:13 INFO - 'tsvgr_opacity', 02:32:13 INFO - 'tart', 02:32:13 INFO - 'tscrollx', 02:32:13 INFO - 'cart']}, 02:32:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s'], 02:32:13 INFO - 'tests': ['tp5o']}, 02:32:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'tests': ['tp5o']}, 02:32:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--disable-e10s', 02:32:13 INFO - '--xperf_path', 02:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:13 INFO - 'tests': ['tp5n']}, 02:32:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:13 INFO - 'talos_options': ['--xperf_path', 02:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:13 INFO - 'tests': ['tp5n']}}, 02:32:13 INFO - 'talos.zip': {'path': '', 02:32:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:13 INFO - Running post-action listener: _resource_record_post_action 02:32:13 INFO - [mozharness: 2017-01-21 10:32:13.190399Z] Finished populate-webroot step (success) 02:32:13 INFO - [mozharness: 2017-01-21 10:32:13.190505Z] Running create-virtualenv step. 02:32:13 INFO - Running pre-action listener: _resource_record_pre_action 02:32:13 INFO - Running main action method: create_virtualenv 02:32:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:32:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:13 INFO - Using real prefix '/usr' 02:32:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:13 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:15 INFO - Installing pip.................done. 02:32:15 INFO - Return code: 0 02:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:15 INFO - Reading from file tmpfile_stdout 02:32:15 INFO - Output received: 02:32:15 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) 02:32:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:15 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')]} 02:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:15 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')]} 02:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:15 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 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:15 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 02:32:15 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 02:32:15 INFO - Using env: {'DISPLAY': ':0', 02:32:15 INFO - 'HOME': '/home/cltbld', 02:32:15 INFO - 'LANG': 'en_US.UTF-8', 02:32:15 INFO - 'LANGUAGE': 'en_US:en', 02:32:15 INFO - 'LOGNAME': 'cltbld', 02:32:15 INFO - 'MAIL': '/var/mail/cltbld', 02:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:15 INFO - 'MOZ_NO_REMOTE': '1', 02:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:15 INFO - 'NO_EM_RESTART': '1', 02:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:15 INFO - 'PWD': '/builds/slave/test', 02:32:15 INFO - 'SHELL': '/bin/bash', 02:32:15 INFO - 'SHLVL': '1', 02:32:15 INFO - 'TERM': 'linux', 02:32:15 INFO - 'TMOUT': '86400', 02:32:15 INFO - 'USER': 'cltbld', 02:32:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:15 INFO - '_': '/tools/buildbot/bin/python'} 02:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:32:16 INFO - Cleaning up... 02:32:16 INFO - Return code: 0 02:32:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:32:16 INFO - Using env: {'DISPLAY': ':0', 02:32:16 INFO - 'HOME': '/home/cltbld', 02:32:16 INFO - 'LANG': 'en_US.UTF-8', 02:32:16 INFO - 'LANGUAGE': 'en_US:en', 02:32:16 INFO - 'LOGNAME': 'cltbld', 02:32:16 INFO - 'MAIL': '/var/mail/cltbld', 02:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:16 INFO - 'MOZ_NO_REMOTE': '1', 02:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:16 INFO - 'NO_EM_RESTART': '1', 02:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:16 INFO - 'PWD': '/builds/slave/test', 02:32:16 INFO - 'SHELL': '/bin/bash', 02:32:16 INFO - 'SHLVL': '1', 02:32:16 INFO - 'TERM': 'linux', 02:32:16 INFO - 'TMOUT': '86400', 02:32:16 INFO - 'USER': 'cltbld', 02:32:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:16 INFO - '_': '/tools/buildbot/bin/python'} 02:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:16 INFO - Downloading/unpacking psutil>=3.1.1 02:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:18 INFO - Installing collected packages: psutil 02:32:18 INFO - Running setup.py install for psutil 02:32:18 INFO - building 'psutil._psutil_linux' extension 02:32:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:32:18 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 02:32:18 INFO - building 'psutil._psutil_posix' extension 02:32:18 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 02:32:18 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 02:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:18 INFO - Successfully installed psutil 02:32:18 INFO - Cleaning up... 02:32:19 INFO - Return code: 0 02:32:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:32:19 INFO - Using env: {'DISPLAY': ':0', 02:32:19 INFO - 'HOME': '/home/cltbld', 02:32:19 INFO - 'LANG': 'en_US.UTF-8', 02:32:19 INFO - 'LANGUAGE': 'en_US:en', 02:32:19 INFO - 'LOGNAME': 'cltbld', 02:32:19 INFO - 'MAIL': '/var/mail/cltbld', 02:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:19 INFO - 'MOZ_NO_REMOTE': '1', 02:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:19 INFO - 'NO_EM_RESTART': '1', 02:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:19 INFO - 'PWD': '/builds/slave/test', 02:32:19 INFO - 'SHELL': '/bin/bash', 02:32:19 INFO - 'SHLVL': '1', 02:32:19 INFO - 'TERM': 'linux', 02:32:19 INFO - 'TMOUT': '86400', 02:32:19 INFO - 'USER': 'cltbld', 02:32:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:19 INFO - '_': '/tools/buildbot/bin/python'} 02:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:21 INFO - Installing collected packages: mozsystemmonitor 02:32:21 INFO - Running setup.py install for mozsystemmonitor 02:32:21 INFO - Successfully installed mozsystemmonitor 02:32:21 INFO - Cleaning up... 02:32:21 INFO - Return code: 0 02:32:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:32:21 INFO - Using env: {'DISPLAY': ':0', 02:32:21 INFO - 'HOME': '/home/cltbld', 02:32:21 INFO - 'LANG': 'en_US.UTF-8', 02:32:21 INFO - 'LANGUAGE': 'en_US:en', 02:32:21 INFO - 'LOGNAME': 'cltbld', 02:32:21 INFO - 'MAIL': '/var/mail/cltbld', 02:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:21 INFO - 'MOZ_NO_REMOTE': '1', 02:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:21 INFO - 'NO_EM_RESTART': '1', 02:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:21 INFO - 'PWD': '/builds/slave/test', 02:32:21 INFO - 'SHELL': '/bin/bash', 02:32:21 INFO - 'SHLVL': '1', 02:32:21 INFO - 'TERM': 'linux', 02:32:21 INFO - 'TMOUT': '86400', 02:32:21 INFO - 'USER': 'cltbld', 02:32:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:21 INFO - '_': '/tools/buildbot/bin/python'} 02:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:21 INFO - Downloading/unpacking jsonschema==2.5.1 02:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:23 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:23 INFO - warning: no files found matching '*.txt' 02:32:23 INFO - no previously-included directories found matching 'build' 02:32:23 INFO - no previously-included directories found matching 'dist' 02:32:23 INFO - no previously-included directories found matching '.git*' 02:32:23 INFO - Installing collected packages: jsonschema, functools32 02:32:24 INFO - Running setup.py install for functools32 02:32:24 INFO - warning: no files found matching '*.txt' 02:32:24 INFO - no previously-included directories found matching 'build' 02:32:24 INFO - no previously-included directories found matching 'dist' 02:32:24 INFO - no previously-included directories found matching '.git*' 02:32:24 INFO - Successfully installed jsonschema functools32 02:32:24 INFO - Cleaning up... 02:32:24 INFO - Return code: 0 02:32:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:32:24 INFO - Using env: {'DISPLAY': ':0', 02:32:24 INFO - 'HOME': '/home/cltbld', 02:32:24 INFO - 'LANG': 'en_US.UTF-8', 02:32:24 INFO - 'LANGUAGE': 'en_US:en', 02:32:24 INFO - 'LOGNAME': 'cltbld', 02:32:24 INFO - 'MAIL': '/var/mail/cltbld', 02:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:24 INFO - 'MOZ_NO_REMOTE': '1', 02:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:24 INFO - 'NO_EM_RESTART': '1', 02:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:24 INFO - 'PWD': '/builds/slave/test', 02:32:24 INFO - 'SHELL': '/bin/bash', 02:32:24 INFO - 'SHLVL': '1', 02:32:24 INFO - 'TERM': 'linux', 02:32:24 INFO - 'TMOUT': '86400', 02:32:24 INFO - 'USER': 'cltbld', 02:32:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:24 INFO - '_': '/tools/buildbot/bin/python'} 02:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:24 INFO - Cleaning up... 02:32:24 INFO - Return code: 0 02:32:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:32:24 INFO - Using env: {'DISPLAY': ':0', 02:32:24 INFO - 'HOME': '/home/cltbld', 02:32:24 INFO - 'LANG': 'en_US.UTF-8', 02:32:24 INFO - 'LANGUAGE': 'en_US:en', 02:32:24 INFO - 'LOGNAME': 'cltbld', 02:32:24 INFO - 'MAIL': '/var/mail/cltbld', 02:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:24 INFO - 'MOZ_NO_REMOTE': '1', 02:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:24 INFO - 'NO_EM_RESTART': '1', 02:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:24 INFO - 'PWD': '/builds/slave/test', 02:32:24 INFO - 'SHELL': '/bin/bash', 02:32:24 INFO - 'SHLVL': '1', 02:32:24 INFO - 'TERM': 'linux', 02:32:24 INFO - 'TMOUT': '86400', 02:32:24 INFO - 'USER': 'cltbld', 02:32:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:24 INFO - '_': '/tools/buildbot/bin/python'} 02:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:27 INFO - Downloading docopt-0.6.1.tar.gz 02:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:27 INFO - Running setup.py install for blobuploader 02:32:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:27 INFO - Running setup.py install for requests 02:32:27 INFO - Running setup.py install for docopt 02:32:27 INFO - Successfully installed blobuploader requests docopt 02:32:27 INFO - Cleaning up... 02:32:28 INFO - Return code: 0 02:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:32:28 INFO - Using env: {'DISPLAY': ':0', 02:32:28 INFO - 'HOME': '/home/cltbld', 02:32:28 INFO - 'LANG': 'en_US.UTF-8', 02:32:28 INFO - 'LANGUAGE': 'en_US:en', 02:32:28 INFO - 'LOGNAME': 'cltbld', 02:32:28 INFO - 'MAIL': '/var/mail/cltbld', 02:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:28 INFO - 'MOZ_NO_REMOTE': '1', 02:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:28 INFO - 'NO_EM_RESTART': '1', 02:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:28 INFO - 'PWD': '/builds/slave/test', 02:32:28 INFO - 'SHELL': '/bin/bash', 02:32:28 INFO - 'SHLVL': '1', 02:32:28 INFO - 'TERM': 'linux', 02:32:28 INFO - 'TMOUT': '86400', 02:32:28 INFO - 'USER': 'cltbld', 02:32:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:28 INFO - '_': '/tools/buildbot/bin/python'} 02:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:28 INFO - Running setup.py (path:/tmp/pip-BFlL4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:28 INFO - Running setup.py (path:/tmp/pip-Pzalu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:28 INFO - Running setup.py (path:/tmp/pip-0RlQAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:28 INFO - Running setup.py (path:/tmp/pip-tIjWxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:28 INFO - Running setup.py (path:/tmp/pip-GBoj_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:28 INFO - Running setup.py (path:/tmp/pip-i6fuz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:28 INFO - Running setup.py (path:/tmp/pip-2PORXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:28 INFO - Running setup.py (path:/tmp/pip-sKpSed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:28 INFO - Running setup.py (path:/tmp/pip-PbTp0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:28 INFO - Running setup.py (path:/tmp/pip-n09QuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:28 INFO - Running setup.py (path:/tmp/pip-Xj8WVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:29 INFO - Running setup.py (path:/tmp/pip-odtcDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:29 INFO - Running setup.py (path:/tmp/pip-eiKRNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:29 INFO - Running setup.py (path:/tmp/pip-ePc18i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:29 INFO - Running setup.py (path:/tmp/pip-d7NjpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:29 INFO - Running setup.py (path:/tmp/pip-rOGKmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:29 INFO - Running setup.py (path:/tmp/pip-LPKDjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:29 INFO - Running setup.py install for manifestparser 02:32:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:29 INFO - Running setup.py install for mozcrash 02:32:29 INFO - Running setup.py install for mozdebug 02:32:29 INFO - Running setup.py install for mozdevice 02:32:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:29 INFO - Running setup.py install for mozfile 02:32:30 INFO - Running setup.py install for mozhttpd 02:32:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozinfo 02:32:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozInstall 02:32:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozleak 02:32:30 INFO - Running setup.py install for mozlog 02:32:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for moznetwork 02:32:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozprocess 02:32:30 INFO - Running setup.py install for mozprofile 02:32:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozrunner 02:32:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozscreenshot 02:32:31 INFO - Running setup.py install for moztest 02:32:31 INFO - Running setup.py install for mozversion 02:32:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:31 INFO - Cleaning up... 02:32:31 INFO - Return code: 0 02:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:32:31 INFO - Using env: {'DISPLAY': ':0', 02:32:31 INFO - 'HOME': '/home/cltbld', 02:32:31 INFO - 'LANG': 'en_US.UTF-8', 02:32:31 INFO - 'LANGUAGE': 'en_US:en', 02:32:31 INFO - 'LOGNAME': 'cltbld', 02:32:31 INFO - 'MAIL': '/var/mail/cltbld', 02:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:31 INFO - 'MOZ_NO_REMOTE': '1', 02:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:31 INFO - 'NO_EM_RESTART': '1', 02:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:31 INFO - 'PWD': '/builds/slave/test', 02:32:31 INFO - 'SHELL': '/bin/bash', 02:32:31 INFO - 'SHLVL': '1', 02:32:31 INFO - 'TERM': 'linux', 02:32:31 INFO - 'TMOUT': '86400', 02:32:31 INFO - 'USER': 'cltbld', 02:32:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:31 INFO - '_': '/tools/buildbot/bin/python'} 02:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:31 INFO - Running setup.py (path:/tmp/pip-NXXVid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:31 INFO - Running setup.py (path:/tmp/pip-Tsy7a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:31 INFO - Running setup.py (path:/tmp/pip-9sIe4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:31 INFO - Running setup.py (path:/tmp/pip-5q4Q__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:31 INFO - Running setup.py (path:/tmp/pip-4h8L80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:31 INFO - Running setup.py (path:/tmp/pip-_YP1Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:31 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)) 02:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:31 INFO - Running setup.py (path:/tmp/pip-Q9D_jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:32 INFO - Running setup.py (path:/tmp/pip-O3GK2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:32 INFO - Running setup.py (path:/tmp/pip-2XKfRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:32 INFO - Running setup.py (path:/tmp/pip-AvfNDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:32 INFO - Running setup.py (path:/tmp/pip-FnSobo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:32 INFO - Running setup.py (path:/tmp/pip-F4SCDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:32 INFO - Running setup.py (path:/tmp/pip-aE8_zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:32 INFO - Running setup.py (path:/tmp/pip-bj89hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:32 INFO - Running setup.py (path:/tmp/pip-DZm8Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:32 INFO - Running setup.py (path:/tmp/pip-lGa0Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:32 INFO - Running setup.py (path:/tmp/pip-RTb9sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:32 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)) 02:32:32 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)) 02:32:32 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)) 02:32:32 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)) 02:32:32 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)) 02:32:32 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)) 02:32:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:34 INFO - Downloading blessings-1.6.tar.gz 02:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:34 INFO - Installing collected packages: blessings 02:32:34 INFO - Running setup.py install for blessings 02:32:34 INFO - Successfully installed blessings 02:32:34 INFO - Cleaning up... 02:32:35 INFO - Return code: 0 02:32:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:35 INFO - Reading from file tmpfile_stdout 02:32:35 INFO - Current package versions: 02:32:35 INFO - argparse == 1.2.1 02:32:35 INFO - blessings == 1.6 02:32:35 INFO - blobuploader == 1.2.4 02:32:35 INFO - docopt == 0.6.1 02:32:35 INFO - functools32 == 3.2.3-2 02:32:35 INFO - jsonschema == 2.5.1 02:32:35 INFO - manifestparser == 1.1 02:32:35 INFO - mozInstall == 1.12 02:32:35 INFO - mozcrash == 1.0 02:32:35 INFO - mozdebug == 0.1 02:32:35 INFO - mozdevice == 0.48 02:32:35 INFO - mozfile == 1.2 02:32:35 INFO - mozhttpd == 0.7 02:32:35 INFO - mozinfo == 0.9 02:32:35 INFO - mozleak == 0.1 02:32:35 INFO - mozlog == 3.4 02:32:35 INFO - moznetwork == 0.27 02:32:35 INFO - mozprocess == 0.23 02:32:35 INFO - mozprofile == 0.28 02:32:35 INFO - mozrunner == 6.13 02:32:35 INFO - mozscreenshot == 0.1 02:32:35 INFO - mozsystemmonitor == 0.3 02:32:35 INFO - moztest == 0.8 02:32:35 INFO - mozversion == 1.4 02:32:35 INFO - psutil == 3.1.1 02:32:35 INFO - requests == 1.2.3 02:32:35 INFO - wsgiref == 0.1.2 02:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:35 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 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32:35 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 02:32:35 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 02:32:35 INFO - Using env: {'DISPLAY': ':0', 02:32:35 INFO - 'HOME': '/home/cltbld', 02:32:35 INFO - 'LANG': 'en_US.UTF-8', 02:32:35 INFO - 'LANGUAGE': 'en_US:en', 02:32:35 INFO - 'LOGNAME': 'cltbld', 02:32:35 INFO - 'MAIL': '/var/mail/cltbld', 02:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:35 INFO - 'MOZ_NO_REMOTE': '1', 02:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:35 INFO - 'NO_EM_RESTART': '1', 02:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:35 INFO - 'PWD': '/builds/slave/test', 02:32:35 INFO - 'SHELL': '/bin/bash', 02:32:35 INFO - 'SHLVL': '1', 02:32:35 INFO - 'TERM': 'linux', 02:32:35 INFO - 'TMOUT': '86400', 02:32:35 INFO - 'USER': 'cltbld', 02:32:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:35 INFO - '_': '/tools/buildbot/bin/python'} 02:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 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)) 02:32:35 INFO - Cleaning up... 02:32:35 INFO - Return code: 0 02:32:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bde40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', '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 02:32: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'] in /builds/slave/test/build 02:32: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 02:32:35 INFO - Using env: {'DISPLAY': ':0', 02:32:35 INFO - 'HOME': '/home/cltbld', 02:32:35 INFO - 'LANG': 'en_US.UTF-8', 02:32:35 INFO - 'LANGUAGE': 'en_US:en', 02:32:35 INFO - 'LOGNAME': 'cltbld', 02:32:35 INFO - 'MAIL': '/var/mail/cltbld', 02:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:35 INFO - 'MOZ_NO_REMOTE': '1', 02:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:35 INFO - 'NO_EM_RESTART': '1', 02:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:35 INFO - 'PWD': '/builds/slave/test', 02:32:35 INFO - 'SHELL': '/bin/bash', 02:32:35 INFO - 'SHLVL': '1', 02:32:35 INFO - 'TERM': 'linux', 02:32:35 INFO - 'TMOUT': '86400', 02:32:35 INFO - 'USER': 'cltbld', 02:32:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:35 INFO - '_': '/tools/buildbot/bin/python'} 02:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:35 INFO - Cleaning up... 02:32:35 INFO - Return code: 0 02:32:35 INFO - Running post-action listener: _resource_record_post_action 02:32:35 INFO - Running post-action listener: _start_resource_monitoring 02:32:35 INFO - Starting resource monitoring. 02:32:35 INFO - [mozharness: 2017-01-21 10:32:35.726863Z] Finished create-virtualenv step (success) 02:32:35 INFO - [mozharness: 2017-01-21 10:32:35.727325Z] Running install step. 02:32:35 INFO - Running pre-action listener: _resource_record_pre_action 02:32:35 INFO - Running main action method: install 02:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:35 INFO - Reading from file tmpfile_stdout 02:32:35 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:36 INFO - Reading from file tmpfile_stdout 02:32:36 INFO - Output received: 02:32:36 INFO - Usage: mozinstall [options] installer 02:32:36 INFO - Options: 02:32:36 INFO - -h, --help show this help message and exit 02:32:36 INFO - -d DEST, --destination=DEST 02:32:36 INFO - Directory to install application into. [default: 02:32:36 INFO - "/builds/slave/test"] 02:32:36 INFO - --app=APP Application being installed. [default: firefox] 02:32:36 INFO - mkdir: /builds/slave/test/build/application 02:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:32:52 INFO - Reading from file tmpfile_stdout 02:32:52 INFO - Output received: 02:32:52 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:52 INFO - Running post-action listener: _resource_record_post_action 02:32:52 INFO - [mozharness: 2017-01-21 10:32:52.095772Z] Finished install step (success) 02:32:52 INFO - [mozharness: 2017-01-21 10:32:52.096015Z] Running run-tests step. 02:32:52 INFO - Running pre-action listener: _resource_record_pre_action 02:32:52 INFO - Running main action method: run_tests 02:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:52 INFO - Python 2.7.3 02:32:52 INFO - Return code: 0 02:32:52 INFO - grabbing minidump binary from tooltool 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1627f60>, '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 0x1628d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16291d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:32:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:32:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:32:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:52 INFO - Return code: 0 02:32:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:52 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/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 02:32:52 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/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 02:32:52 INFO - Using env: {'DISPLAY': ':0', 02:32:52 INFO - 'HOME': '/home/cltbld', 02:32:52 INFO - 'LANG': 'en_US.UTF-8', 02:32:52 INFO - 'LANGUAGE': 'en_US:en', 02:32:52 INFO - 'LOGNAME': 'cltbld', 02:32:52 INFO - 'MAIL': '/var/mail/cltbld', 02:32:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:52 INFO - 'MOZ_NO_REMOTE': '1', 02:32:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:52 INFO - 'NO_EM_RESTART': '1', 02:32:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:52 INFO - 'PWD': '/builds/slave/test', 02:32:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:52 INFO - 'SHELL': '/bin/bash', 02:32:52 INFO - 'SHLVL': '1', 02:32:52 INFO - 'TERM': 'linux', 02:32:52 INFO - 'TMOUT': '86400', 02:32:52 INFO - 'USER': 'cltbld', 02:32:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548', 02:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:52 INFO - '_': '/tools/buildbot/bin/python'} 02:32:52 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/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 02:32:52 INFO - mozversion application_buildid: 20170121004004 02:32:52 INFO - mozversion application_changeset: a891cb2fa60257c3a8cb84bb0356fba508e42f3e 02:32:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:32:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:52 INFO - mozversion application_name: Firefox 02:32:52 INFO - mozversion application_remotingname: firefox-dev 02:32:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:52 INFO - mozversion application_vendor: Mozilla 02:32:52 INFO - mozversion application_version: 52.0a2 02:32:52 INFO - mozversion platform_buildid: 20170121004004 02:32:52 INFO - mozversion platform_changeset: a891cb2fa60257c3a8cb84bb0356fba508e42f3e 02:32:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:52 INFO - mozversion platform_version: 52.0a2 02:32:52 INFO - using testdate: 1484994772 02:32:52 INFO - actual date: 1484994772 02:32:52 INFO - starting webserver on 'localhost:57902' 02:32:52 INFO - SUITE-START | Running 2 tests 02:32:52 INFO - TEST-START | dromaeo_css 02:32:52 INFO - operating with platform_type : linux_ 02:32:52 INFO - Initialising browser for dromaeo_css test... 02:32:52 INFO - TEST-INFO | started process 1344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnGJ7HW/profile http://localhost:57902/getInfo.html) 02:32:56 INFO - PROCESS | 1344 | __metrics Screen width/height:1600/1200 02:32:56 INFO - PROCESS | 1344 | colorDepth:24 02:32:56 INFO - PROCESS | 1344 | Browser inner width/height: 1024/697 02:32:56 INFO - PROCESS | 1344 | __metrics 02:32:57 INFO - PROCESS | 1344 | 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" 02:32:57 INFO - PROCESS | 1344 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:57 INFO - PROCESS | 1344 | console.error: PushService: 02:32:57 INFO - PROCESS | 1344 | stateChangeProcessEnqueue: Error transitioning state 02:32:57 INFO - PROCESS | 1344 | UnknownError 02:32:58 INFO - TEST-INFO | 1344: exit 0 02:32:58 INFO - Browser initialized. 02:32:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:58 INFO - TEST-INFO | started process 1438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnGJ7HW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:10 INFO - PROCESS | 1438 | RSS: Main: 144113664 02:33:10 INFO - PROCESS | 1438 | 02:36:11 INFO - PROCESS | 1438 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57902/tests/dromaeo/cssquery-ext.html) 02:36:13 INFO - PROCESS | 1438 | RSS: Main: 248041472 02:36:13 INFO - PROCESS | 1438 | 02:39:15 INFO - PROCESS | 1438 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-ext.html (next: http://localhost:57902/tests/dromaeo/cssquery-jquery.html) 02:39:16 INFO - PROCESS | 1438 | RSS: Main: 225226752 02:39:16 INFO - PROCESS | 1438 | 02:42:17 INFO - PROCESS | 1438 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57902/tests/dromaeo/cssquery-mootools.html) 02:42:18 INFO - PROCESS | 1438 | RSS: Main: 177508352 02:42:18 INFO - PROCESS | 1438 | 02:45:20 INFO - PROCESS | 1438 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57902/tests/dromaeo/cssquery-prototype.html) 02:45:21 INFO - PROCESS | 1438 | RSS: Main: 177876992 02:45:21 INFO - PROCESS | 1438 | 02:48:23 INFO - PROCESS | 1438 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57902/tests/dromaeo/cssquery-yui.html) 02:48:24 INFO - PROCESS | 1438 | RSS: Main: 173436928 02:48:24 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-yui.html (next: http://localhost:57902/tests/dromaeo/cssquery-dojo.html) 02:51:26 INFO - PROCESS | 1438 | RSS: Main: 265244672 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | __start_tp_report 02:51:26 INFO - PROCESS | 1438 | _x_x_mozilla_page_load 02:51:26 INFO - PROCESS | 1438 | _x_x_mozilla_page_load_details 02:51:26 INFO - PROCESS | 1438 | |i|pagename|runs| 02:51:26 INFO - PROCESS | 1438 | |0;dojo.html;3221.677832216779;3229.111994201595;3265.7387409007283;3289.5723555937725;3306.6362700103;5551.472610102039;5659.4340565943385;5664.1220610805285;5671.489565939065;5683.0622947213715;5621.662700237978;5659;5665.830025099243;5679.864027194557;5717.6283541569765;5110.412302585213;5115.693058416488;5125.308083408748;5159.5614372778355;5207;5022.874428139289;5212.192110222922;5220;5220.712860792655;5236.162214045753;4996.575291100261;5081;5086.21163719624;5138.640295179339;5138.7173705446185;5105.617078719092;5139.100657384962;5143.048536020848;5158.561522270612;5212.061828870802;5037.773300201463;5118.744062796883;5155.690658560498;5168.638195326329;5194.896102077975;5371.409144994048;5469.425710300401;5469.589780766459;5478.260434841285;5502.119660854244;5901.17383566301;5911.172435858984;5931.317898441691;6020.488258498033;6037.698115094227;6076.939230607726;6093.878122437571;6095.451409373133;6098.603590766586;6101.511879049665;5468.152436372368;5510.338759348904;5568.387477377485;5710.2862142232225;5714.371419143891;6163.660998645028;6182.1345011698395;6195.81412557624;6204.72078756448;6207.565470417027;5950.851228719317;5951.642901425842;5951.940480595225;5952.434518720715;5960.880782384328;5750.7987220447085;5792.333881603669;6021.789237376671;6100.298465676416;6106.053561697944;6041.24484439445;6043.093535969552;6045.365236650088;6071.119687645267;6079.361667024988;5967.761289548456;6008.489278411296;6020.307664618625;6031.577789554777;6070.392960703983;4519.570640789119;4557.886052848639;4562.1560011398;4581.74800385982;4597.586217240464;4125.814338354721;4137.420761093449;4139.834406623761;4140.171965606891;4170.270202714573;5755.366909639936;5756.827295181151;5769.451902069297;5772.740226689809;5782.797602083907;5876.970615146983;5893.882122357529;5923.08192230205;5934.584579079423;6054.303755068224;5695.45893140151;5699.145128230799;5700.971495142498;5702.344230413555;5730.885382292414;5138.2292656101135;5149.639525233272;5150.304708864331;5150.510701483353;5173.430922598511;6067.150598916155;6136.825445958321;6161.229846269216;6184.6598437086395;6186.969065154645;5947.583669143119;6047.09293605945;6074.240719910012;6094.299155597163;6139.969300153471;6262.655553944577;6280.152179455715;6291.874162516816;6296.716647750771;6302.810915672537;5716.142578613241;5719.170720245458;5948.970255148696;5960.940390596039;5994.400559943971;5927.8221653350465;5933;5947.9702601486715;5973.701314934323;6002.609830361012;5854.356020837789;5862.648241105548;5875.030619947832;5921.733521991435;5930.11048342752;5620.437956204347;5888.3228428729535;5896.705164741831;5903.2325797646035;5905.350411454822;5667.064934285797;5778.451047150514;5834.766609335748;5849.532037436909;5906.586538942404;6006.909896351645;6008.519318454601;6013.759449622141;6020.578559500793;6022.5784195105925;5635.211070450058;5685.943140568706;5712.571557133148;5844.853878653068;5851.736671849691 02:51:26 INFO - PROCESS | 1438 | |1;ext.html;575.326867564949;596.7821745063052;613.5153228949127;623.1867413026;633.9634697269962;32545.83727081364;44901.77549112254;45044.324335134996;45102.77448612761;45207.32189017163;45048;45574;45617.54382456175;45634.087318253616;45642;8175.182481751807;8359.373047021467;8686.261667758232;8820.647174113028;8837.911620883773;10513.264071514997;10760.892391076106;10766.354018758899;10770.29993050453;10772.40751758653;10627.309224900395;10637.893621063768;10688.144948404148;10705.732356691067;10708.1968852336;10381.273310868204;10387.792244155113;10419.583216671324;10439;10452.634157804516;10484.842727359095;10504.947475262652;10540.472976351151;10545.84181237282;10549.894501054969;42299.36550951738;42708.359374609405;42718.57281427177;42757.144857102685;42793.57206427927;3556.324298383299;3569.928601427983;3632.055665526982;3683.9447408288897;4072.2873497137884;30666.386672266653;32080.518792218136;32093;32367.190820229447;32619.6738032619;4408.493023302329;4452.465704115494;4470.993658975019;4475.39582156408;4527.4114365132655;351048;357250;358521;359070;359162;67558;68128.6593567039;68236;68295.65852170707;68479.65760171167;40993.38509922354;41701.37447938283;41738.373924391155;44093.559064408946;44117;19172.13725382361;19349.839009659183;19381.709274360896;19392.2243110274;19398.224071037283;13566.457341706222;13640.045196836325;13647.249401282827;14158.433662653584;14756.188409637572;21250.149994000378;21527.461813454476;21645.458863528536;22612.547749044927;22628.660570091462;7954.642041108164;8223.506589604644;8242.629081691339;8263.107912230671;8389.286910612544;1003.8393856982848;1065.8880817514205;1071.7910007548453;1100.1034157161887;1174.7591743692522;33105.83447082749;33180.66819331824;33424.83287583546;33547.15354933276;33722.49416258758;983.3902980152351;1084.9457527123611;1121.6915348279288;1146.587228597704;1160.4719852467108;16032.679346413006;17055.914720426317;17636.030018348858;18103.72844407335;18233;491214;493143;493520;494844;496091;61162.388376116556;62209.688951554956;62213.377866220755;62290.68854655788;62366.376336236055;1297.2994582925303;1349.3320806200993;1366.0164681429355;1394.623451668044;1448.8840892728556;27498.587521187597;31937.041888743373;33836.66163338335;34653.653463465045;35324.646753532135;48090.5190948086;52137.47862521478;52246;52298.477015229364;52335.47664523306;457458;463475;463783;464554;466974;40141;46366;46465.30302045404;46771.532284676716;49233.75383123061;50195;50347.74826125846;50568.747156263984;50639.49360506348;50689.74655126701;41768.37347439852;42070;42378;42609.147817044104;43289.567104328555;41343;41430.792846035576;41985.58014419817;42997;43666.56333436625;41813.372799408644;42136.57863421326;42545.36181957335;42661.36007959821;43178;34926;37801.81099094597;38221.80889095537;41531.1693766129;42491.3626295612;28642;28689.71310286954;29060;29061.7093829059;29402.852985734935 02:51:26 INFO - PROCESS | 1438 | |2;jquery.html;417.2281279632678;420.7888835227681;428.72990016289737;439.17873576412103;440.645280549158;18842;18933.715994260063;20044.69932951007;20181.495462613442;20476.385708428752;18600.906995465004;18902.96033718145;18974.43076707701;18980.525486862836;19323.51691207717;5144.4598317176715;5400.83797486076;5432.266644003068;5476.479734425223;5486.094794358926;5308.389535203462;5347.117725575295;5347.278117454152;5350.384705758848;5364.570834333244;5833.066709326508;5863.472287494124;5872.354041055481;5875.794347197849;5876.177335173079;5312.840614781563;5357.383900851413;5870.618409803349;5871.677057761822;5876.08920617305;5226.451222621646;5231.633785635007;5234.031704134747;5236.633435659467;5240.3973543042275;14530.418783248657;18019.819801801947;20376.184952601878;24264.1507547235;24451.877740611362;2282.3837563857833;2401.075585899424;2474.1587860127465;2503.0738626708053;3025.848707564613;10277.537510812032;10785.460726963698;11130.109591232682;14215.928920355333;14482.348294326675;1917.9956944992516;1918.9361617289298;1926.730257763914;2006.518435575466;2027.3715148304072;79493;85136;85697.57151214266;87771.12228877694;89843.55078224567;11926.522939082513;12131.939340303243;12133.817992730115;12172.147949643617;12264.202826816228;15679.451219207502;15827.446039388566;16307.83692163087;17096;17131.05779182132;6466.773662921775;6572.145621069326;7988.480748751313;8588.8711669325;8717.171868672465;8034.718784842503;8073.515589064675;8110.756677299691;8225.177482251847;8232.382571307056;5146.716930568855;5193.298904647824;5225.425203227642;5234.293370395024;5369.4630536946;2121.4060063182333;2195.6047911376104;2218.378853920905;2231.5871563760757;2239.0595949701164;884.5665623844399;967.6951760195516;976.0922342221802;1026.2303272545591;1062.5431064642278;19303;19463;19633.410997670093;19811.20755169777;19898.801011989985;1000.6797824696173;1023.5291765787672;1029.156092004564;1036.3419228789621;1082.826747720361;10557.788844223072;11032.889671103187;11263;11286.943565282121;11314.830277545843;485077;488096;488693;488743;495628;56263.71868140715;91859;93531;96689.51655241678;97091;985.6156099121348;987.5407935309971;1004.9346792458613;1022.3354819367471;1032.1381646325403;14933.551993440215;16813;16882.324707011583;17617.647647047244;17784.3775467858;42385.78807105945;44628.55371446244;45710.1715931359;45772.54227457816;46675.29987050129;57553.424465756485;58233.4176658245;59306.11040834477;59826;60295.39704602898;6420.967895160495;8771.824563508822;8956.641734330553;9287.72136835896;9302;13017.349132543146;13234.536791212262;13320.200787952754;13422.127561708458;13531.59405217845;11031.282966607145;11044.116470682166;11173.162012849232;11369.886301136883;11806.1145414096;11148.275362101438;11297;11313.71715707114;11368.147388945697;11687.824682629598;9386.45123554606;11271.380074096003;11366.204365694322;11606.651800446;12019.218750781522;9052.456852588866;9085.13691199335;9347.719568412958;9430.764230894009;9442.433453992782;11017;11229.71925701864;11271.211015228855;11434.94282528582;11477 02:51:26 INFO - PROCESS | 1438 | |3;mootools.html;1349.4871948659509;1516.2267243705714;1544.8686861616761;1626.7885174927258;1705.3093497133666;7609.162992070867;8349.41554091214;8633.827323453526;8644.740657780261;8882.64469421224;8688.261497772697;8754.3871928965;8757.562121893912;8761.737147885558;8770.736877893658;2420.3828023853894;2432.9756702433015;2451.4361696809747;2452.1172377943926;2454.803615710739;2409.8554086754853;2437.3662847659557;2444.40112172518;2452.3133522613607;2456.447299357639;2365.2431222008963;2379.2267513058327;2412.1316326122583;2422.994457300227;2424.9393765155837;2324.360800779782;2336.4158960259933;2350.82368822339;2353.329301149173;2356.3166681662296;2328.5459335429596;2360.9645855312183;2412.408959804859;2421.1041914491752;2423.9394015149765;7598;7821.804454888674;8922.28621710268;8929.687460938901;9033.735277061216;5325.041492531343;5472.616916815825;5489.533389661883;5602.38373778884;5609.382967873531;3492.406290930548;3561.2521370512222;3613.2050948791225;3615.891523254307;3681.944770828413;1135.3641960502146;1162.7906976744182;1174.2367461150236;1181.2440038375446;2119.194706011721;12187.756244875141;12671.619851404472;12686.429110690042;12731.363431828464;12739.936300318439;4755.690880092783;4812;4846.636502262344;4931.90136197274;5007.324011258506;9830.901690982999;9870.654527091661;9885.802283954281;9895.703128906145;9907.801843963225;5530.585206109477;5541.418151094077;5547.445255474501;5548.750306236229;5555;5003.374578177728;5028.220625803006;5045.84862454127;5045.949540504622;5206.245094461357;3774.490443790108;3847.9038024049623;3879.1465877506903;3937.370020796659;3970.5830887756947;1194.6117511808698;1198.7242934125027;1201.0751721174647;1216.0575553945587;1220.4629962816332;905.8867641544807;932.7621456528677;937.2455173585329;939.7274790310734;965.2229954886244;5657.660540367591;5719.571032172604;5732.34078081026;5968.403159684084;5972.910406343908;416.26529176004374;419.09057345560205;420.8548050922427;424.8677275061925;426.20725450661746;4019.8191081401405;4060.3503439449546;4075.3275709508193;4076.510818701775;4158.771267580251;9573.18627916621;9639.325247232766;10520.789584208273;10724.946375268073;10788.56845726178;10908.672739817817;10960.342379457099;10997.945010274898;11025.558977640805;11153.832692509619;8214.342852571779;8457.40798144124;8479.109693482218;8484;8501.872471912802;5980.401959803985;6000.339962604197;6032.366601506954;6067.423594758491;6109.2974307955155;9688.176504996873;9903.653372131941;9928.156106731009;9958.751031224278;10040.849387259343;10049.849252261369;10310.639127630797;10340.431276279876;10418.531166097695;10420.47897605132;7469.514481558681;7471.3649339806725;7479.252074792477;7482.401407887465;7597;8006.439549231498;8080.676772929252;8086.110527841815;8088.514689118671;8090.7168249111;7101.183363913216;7173.497855150298;7256.129264488295;7273.709051638087;7347.485676002629;6867.416269616939;6984.266652001466;7050.823729406806;7083.893741593984;7098.503104782616;6887.552309099892;6902.689378978059;6943.479239057192;6944.722211111701;6945.236024037251;4577.93133102997;4594.816207351669;4605.631549476101;4687.320338550823;4688.742119183341;4730.290456431563;4794.760261986957;4840.128776820206;4843.564079232886;5074.797008119634 02:51:26 INFO - PROCESS | 1438 | |4;prototype.html;334.1295924117675;336.2115838359048;338.88647303153436;342.7378055787323;347.3851283228687;5430.619856610039;5440.564754819615;5464.2896423464945;5475.835724928249;5488.8319113949965;5061.822836200734;5175.870603234921;5186.507281808223;5240.37115546135;5350.35795704516;4192.056787222881;4193.475815523059;4208.810603522848;4209.810558524866;4253.532111467736;4200.957990420103;4230.17511585241;4236.8772275347055;4244.342126970325;4274.679399045069;3917.3144699677587;3976.6818654507715;4123.896902577445;4149.688773341996;4184.748915065091;4120.91758164835;4122.40225167349;4150.771707556083;4152.4601801765875;4154.397612346208;3662;3668.651478109602;3669.8165091745573;3671.8066628345628;3688.6311368863167;5152.9484705152845;5192.55863251624;5228.451012643655;5274.736263186864;5286.735663216824;4743.027679325764;4744.217204161309;4760.785764640565;4772.880677983044;4786.7845946932475;5569.605069819976;5582.888342233173;5588.3573389060375;5593.804216852432;5607.299087614048;3894.6300101490597;3988.3419235826054;4000.8199631016673;4069.409935559357;4073.226087043482;5780.682062486561;5791.333996590404;5792.333881603628;5799.623024503394;5803.361630220672;4094.529129150126;4100.282450571138;4107.8973025674595;4135.421041054255;4144.129732756155;3951.9012024699036;4090.8363665453644;4259.699762128478;4262.126264115849;4268.445102136702;4697.812087516461;4716.740579268173;4722.960948591304;4729.408823897013;4789.976050119727;5545;5611.110278206726;5622.550195984393;5625.212470254168;5626.324841019104;1316.7498175346846;1361.237706884148;1362.1826903857805;1378.379729121879;1381.461230120254;904.1410659873015;911.7447114807865;930.4510338900081;936.6300311376968;945.5933948402253;5190.351206099238;5244.872352444243;5271.156614941668;5279.9208011879855;5286.81496147633;5546.91679624806;5554.583406244547;5559.583031272671;5560.165975103767;5562.638428502134;5200.635955483155;5289.550388216968;5490.913452887877;5536.280283563192;5541.113421852484;2947.322115913352;2956.2609347663083;2961.748251398612;2966.4215477982016;2967.8219306841656;5651.858703532444;5789.218455508537;5801.752623186036;5804.912926306109;5817.331006934257;5627;5644.74598643062;5668.044524638993;5684.516816070681;5696.829095127153;5746.741396637161;5751.194832723422;5754.6547207167705;5769.423057694197;5818.44724751148;5304.15133578641;5509;5521.558275338044;5558.666480011212;5603.271574695426;5501.642393244426;5510.724463776875;5529.198266251451;5529.419410961791;5540.75066622011;5459.426760190123;5759.452851979056;5760.567957403127;5777.537796976316;5797.579428137419;4040.4545386372465;4048.838046478108;4050.817713202972;4059.776712280735;4067.511898572072;5509.3664228614225;5532.806351777668;5566.192902029264;5578.210894552723;5592.608517403743;5320.053803853373;5343.9198412024625;5467.17992301158;5486;5499.890002200013;5353.75908084145;5428.56571474289;5442.401335852974;5447.066291466631;5466.863328416822;5335.73321333924;5370.46941621636;5387.622866399472;5421.512063914267;5489.972550137224;5507.862303442446;5599.60802743804;5637;5641.5204707600315;5644.266245388073;5468.316460442445;5477.75350109238;5489.505944465017;5510;5511.255980442749 02:51:26 INFO - PROCESS | 1438 | |5;yui.html;782.2724865874737;797.8603744344742;820.706126376777;824.3446460064248;892.4020905992984;13899.027068105224;14668.11991280524;15055.397784088624;15211.391544338241;15283.235838208087;12519.874801251985;13452.461901523951;13581.253031083286;13586.864131358683;13707.246101464416;837.300853787087;849.8045449546609;850.5067061104545;851.199872120205;851.3104385447776;861.3970220845401;862.3618522293489;864.6498168241841;864.9048604653483;865;902.2421166220373;902.2736696958946;902.3999040637968;902.7291812456269;903.5030733096803;899.0470101692162;900.9099090090971;901.4050726520497;902.9187373136383;902.9819403611924;657.5364368120463;658.045833541367;658.8550518885837;659.5416185750905;661.206552137437;12622.242665440102;12908.677283067904;12952;12952.740945181044;13066.608001759867;12517.623061463231;12671.049671274692;12723.618291451272;12975.935120324433;13163.144395614254;10836.620718274902;10905.400202988832;10939.617113400993;11270.211085224038;11452.828207576893;3811.5997820228754;3820.923581528382;3867.7099217558793;3910.8631197907935;3940.625640564142;38426.42360364597;45599.31601025987;58042;59101.40898591045;67745.9999999995;11993.520259189709;12214.633560993185;12409.193402428813;12421.068419868365;12546.498140074478;21652.24217152392;21684.78315216859;21817.890910545662;21825.345239642837;21863.78136218649;8849.380543361904;8979.820403591892;8981.910180898107;9004.099590041074;9085.13691199335;4668.276417155346;4757.191277482836;4817.5182481752245;4819.95180048202;4959.7272150032095;3415.8121303328558;3523.2777280657406;3525.383057964846;3526.3299973005046;3541;636.5703150373572;643.2955913274957;644.5552568727563;647.0133047103111;649.0523835200565;671.1509939925998;781.6170076662509;793.742033838993;805.3838813307824;826.3017750001239;9258.351915365995;9551.61793528265;9606.711798646053;9776.560054797408;9994.350367226107;640.9967950160219;669.8693754717783;697.5919087333966;714.8999140120387;782.9921700782919;4438.134563760101;4653.464851542049;4695.436547614308;4697.718136911796;4716.174669432836;86865.5656721725;90118;91309;92524.53737731268;95299;79209.60395197987;79914.20085799183;82774;83364;84020.15979840246;71711.64144179245;71878.9218161728;71919;72798.27201728021;74423;8454.619542120743;8509.36179786531;8727.170918762708;8927.866082008644;9047.276217902683;49507;49928;50155.74922125366;50350;50449.747751261006;61833;67985.66007169933;68455;69127.3087269141;69446.30553694398;12314.59690219475;12590.307533085768;12674.936625316814;12742.74514509686;12972.897303729289;13456.065280127454;13529.729405412034;13548.458061677422;13638.79541806854;13667.17996920188;12562.23783166614;12781.360931953552;12795.61613151607;12806.871931280568;13049.608511744664;12064.879351206375;12075.879241207476;12084.75830483403;12701.93649031749;13422.127561708458;11896.345700986183;12171.208871423683;12645.304508252135;12775.169613975062;13367.866321336662;10484.685459436228;10499.842502362319;10998.890011099787;11091.500882460146;11150.553977840795;9519.714408567754;9725.854112188465;9734.318597698093;10711.464426778786;10748.838767418338 02:51:26 INFO - PROCESS | 1438 | __end_tp_report 02:51:26 INFO - PROCESS | 1438 | __start_cc_report 02:51:26 INFO - PROCESS | 1438 | _x_x_mozilla_cycle_collect,1040 02:51:26 INFO - PROCESS | 1438 | __end_cc_report 02:51:26 INFO - PROCESS | 1438 | __startTimestamp1484995886959__endTimestamp 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | ------- Summary: start ------- 02:51:26 INFO - PROCESS | 1438 | Number of tests: 6 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | [#0] dojo.html Cycles:165 Average:5589.29 Median:5778.45 stddev:632.73 (10.9%) stddev-sans-first:606.80 02:51:26 INFO - PROCESS | 1438 | Values: 3221.7 3229.1 3265.7 3289.6 3306.6 5551.5 5659.4 5664.1 5671.5 5683.1 5621.7 5659.0 5665.8 5679.9 5717.6 5110.4 5115.7 5125.3 5159.6 5207.0 5022.9 5212.2 5220.0 5220.7 5236.2 4996.6 5081.0 5086.2 5138.6 5138.7 5105.6 5139.1 5143.0 5158.6 5212.1 5037.8 5118.7 5155.7 5168.6 5194.9 5371.4 5469.4 5469.6 5478.3 5502.1 5901.2 5911.2 5931.3 6020.5 6037.7 6076.9 6093.9 6095.5 6098.6 6101.5 5468.2 5510.3 5568.4 5710.3 5714.4 6163.7 6182.1 6195.8 6204.7 6207.6 5950.9 5951.6 5951.9 5952.4 5960.9 5750.8 5792.3 6021.8 6100.3 6106.1 6041.2 6043.1 6045.4 6071.1 6079.4 5967.8 6008.5 6020.3 6031.6 6070.4 4519.6 4557.9 4562.2 4581.7 4597.6 4125.8 4137.4 4139.8 4140.2 4170.3 5755.4 5756.8 5769.5 5772.7 5782.8 5877.0 5893.9 5923.1 5934.6 6054.3 5695.5 5699.1 5701.0 5702.3 5730.9 5138.2 5149.6 5150.3 5150.5 5173.4 6067.2 6136.8 6161.2 6184.7 6187.0 5947.6 6047.1 6074.2 6094.3 6140.0 6262.7 6280.2 6291.9 6296.7 6302.8 5716.1 5719.2 5949.0 5960.9 5994.4 5927.8 5933.0 5948.0 5973.7 6002.6 5854.4 5862.6 5875.0 5921.7 5930.1 5620.4 5888.3 5896.7 5903.2 5905.4 5667.1 5778.5 5834.8 5849.5 5906.6 6006.9 6008.5 6013.8 6020.6 6022.6 5635.2 5685.9 5712.6 5844.9 5851.7 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | [#1] ext.html Cycles:180 Average:61177.95 Median:41386.90 stddev:116684.42 (281.9%) stddev-sans-first:116923.03 02:51:26 INFO - PROCESS | 1438 | Values: 575.3 596.8 613.5 623.2 634.0 32545.8 44901.8 45044.3 45102.8 45207.3 45048.0 45574.0 45617.5 45634.1 45642.0 8175.2 8359.4 8686.3 8820.6 8837.9 10513.3 10760.9 10766.4 10770.3 10772.4 10627.3 10637.9 10688.1 10705.7 10708.2 10381.3 10387.8 10419.6 10439.0 10452.6 10484.8 10504.9 10540.5 10545.8 10549.9 42299.4 42708.4 42718.6 42757.1 42793.6 3556.3 3569.9 3632.1 3683.9 4072.3 30666.4 32080.5 32093.0 32367.2 32619.7 4408.5 4452.5 4471.0 4475.4 4527.4 351048.0 357250.0 358521.0 359070.0 359162.0 67558.0 68128.7 68236.0 68295.7 68479.7 40993.4 41701.4 41738.4 44093.6 44117.0 19172.1 19349.8 19381.7 19392.2 19398.2 13566.5 13640.0 13647.2 14158.4 14756.2 21250.1 21527.5 21645.5 22612.5 22628.7 7954.6 8223.5 8242.6 8263.1 8389.3 1003.8 1065.9 1071.8 1100.1 1174.8 33105.8 33180.7 33424.8 33547.2 33722.5 983.4 1084.9 1121.7 1146.6 1160.5 16032.7 17055.9 17636.0 18103.7 18233.0 491214.0 493143.0 493520.0 494844.0 496091.0 61162.4 62209.7 62213.4 62290.7 62366.4 1297.3 1349.3 1366.0 1394.6 1448.9 27498.6 31937.0 33836.7 34653.7 35324.6 48090.5 52137.5 52246.0 52298.5 52335.5 457458.0 463475.0 463783.0 464554.0 466974.0 40141.0 46366.0 46465.3 46771.5 49233.8 50195.0 50347.7 50568.7 50639.5 50689.7 41768.4 42070.0 42378.0 42609.1 43289.6 41343.0 41430.8 41985.6 42997.0 43666.6 41813.4 42136.6 42545.4 42661.4 43178.0 34926.0 37801.8 38221.8 41531.2 42491.4 28642.0 28689.7 29060.0 29061.7 29402.9 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | [#2] jquery.html Cycles:180 Average:29113.21 Median:13463.02 stddev:80717.23 (599.5%) stddev-sans-first:80914.90 02:51:26 INFO - PROCESS | 1438 | Values: 417.2 420.8 428.7 439.2 440.6 18842.0 18933.7 20044.7 20181.5 20476.4 18600.9 18903.0 18974.4 18980.5 19323.5 5144.5 5400.8 5432.3 5476.5 5486.1 5308.4 5347.1 5347.3 5350.4 5364.6 5833.1 5863.5 5872.4 5875.8 5876.2 5312.8 5357.4 5870.6 5871.7 5876.1 5226.5 5231.6 5234.0 5236.6 5240.4 14530.4 18019.8 20376.2 24264.2 24451.9 2282.4 2401.1 2474.2 2503.1 3025.8 10277.5 10785.5 11130.1 14215.9 14482.3 1918.0 1918.9 1926.7 2006.5 2027.4 79493.0 85136.0 85697.6 87771.1 89843.6 11926.5 12131.9 12133.8 12172.1 12264.2 15679.5 15827.4 16307.8 17096.0 17131.1 6466.8 6572.1 7988.5 8588.9 8717.2 8034.7 8073.5 8110.8 8225.2 8232.4 5146.7 5193.3 5225.4 5234.3 5369.5 2121.4 2195.6 2218.4 2231.6 2239.1 884.6 967.7 976.1 1026.2 1062.5 19303.0 19463.0 19633.4 19811.2 19898.8 1000.7 1023.5 1029.2 1036.3 1082.8 10557.8 11032.9 11263.0 11286.9 11314.8 485077.0 488096.0 488693.0 488743.0 495628.0 56263.7 91859.0 93531.0 96689.5 97091.0 985.6 987.5 1004.9 1022.3 1032.1 14933.6 16813.0 16882.3 17617.6 17784.4 42385.8 44628.6 45710.2 45772.5 46675.3 57553.4 58233.4 59306.1 59826.0 60295.4 6421.0 8771.8 8956.6 9287.7 9302.0 13017.3 13234.5 13320.2 13422.1 13531.6 11031.3 11044.1 11173.2 11369.9 11806.1 11148.3 11297.0 11313.7 11368.1 11687.8 9386.5 11271.4 11366.2 11606.7 12019.2 9052.5 9085.1 9347.7 9430.8 9442.4 11017.0 11229.7 11271.2 11434.9 11477.0 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | [#3] mootools.html Cycles:180 Average:5725.20 Median:4889.27 stddev:3236.56 (66.2%) stddev-sans-first:3228.93 02:51:26 INFO - PROCESS | 1438 | Values: 1349.5 1516.2 1544.9 1626.8 1705.3 7609.2 8349.4 8633.8 8644.7 8882.6 8688.3 8754.4 8757.6 8761.7 8770.7 2420.4 2433.0 2451.4 2452.1 2454.8 2409.9 2437.4 2444.4 2452.3 2456.4 2365.2 2379.2 2412.1 2423.0 2424.9 2324.4 2336.4 2350.8 2353.3 2356.3 2328.5 2361.0 2412.4 2421.1 2423.9 7598.0 7821.8 8922.3 8929.7 9033.7 5325.0 5472.6 5489.5 5602.4 5609.4 3492.4 3561.3 3613.2 3615.9 3681.9 1135.4 1162.8 1174.2 1181.2 2119.2 12187.8 12671.6 12686.4 12731.4 12739.9 4755.7 4812.0 4846.6 4931.9 5007.3 9830.9 9870.7 9885.8 9895.7 9907.8 5530.6 5541.4 5547.4 5548.8 5555.0 5003.4 5028.2 5045.8 5045.9 5206.2 3774.5 3847.9 3879.1 3937.4 3970.6 1194.6 1198.7 1201.1 1216.1 1220.5 905.9 932.8 937.2 939.7 965.2 5657.7 5719.6 5732.3 5968.4 5972.9 416.3 419.1 420.9 424.9 426.2 4019.8 4060.4 4075.3 4076.5 4158.8 9573.2 9639.3 10520.8 10724.9 10788.6 10908.7 10960.3 10997.9 11025.6 11153.8 8214.3 8457.4 8479.1 8484.0 8501.9 5980.4 6000.3 6032.4 6067.4 6109.3 9688.2 9903.7 9928.2 9958.8 10040.8 10049.8 10310.6 10340.4 10418.5 10420.5 7469.5 7471.4 7479.3 7482.4 7597.0 8006.4 8080.7 8086.1 8088.5 8090.7 7101.2 7173.5 7256.1 7273.7 7347.5 6867.4 6984.3 7050.8 7083.9 7098.5 6887.6 6902.7 6943.5 6944.7 6945.2 4577.9 4594.8 4605.6 4687.3 4688.7 4730.3 4794.8 4840.1 4843.6 5074.8 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | [#4] prototype.html Cycles:180 Average:4658.24 Median:5352.06 stddev:1357.64 (25.4%) stddev-sans-first:1322.09 02:51:26 INFO - PROCESS | 1438 | Values: 334.1 336.2 338.9 342.7 347.4 5430.6 5440.6 5464.3 5475.8 5488.8 5061.8 5175.9 5186.5 5240.4 5350.4 4192.1 4193.5 4208.8 4209.8 4253.5 4201.0 4230.2 4236.9 4244.3 4274.7 3917.3 3976.7 4123.9 4149.7 4184.7 4120.9 4122.4 4150.8 4152.5 4154.4 3662.0 3668.7 3669.8 3671.8 3688.6 5152.9 5192.6 5228.5 5274.7 5286.7 4743.0 4744.2 4760.8 4772.9 4786.8 5569.6 5582.9 5588.4 5593.8 5607.3 3894.6 3988.3 4000.8 4069.4 4073.2 5780.7 5791.3 5792.3 5799.6 5803.4 4094.5 4100.3 4107.9 4135.4 4144.1 3951.9 4090.8 4259.7 4262.1 4268.4 4697.8 4716.7 4723.0 4729.4 4790.0 5545.0 5611.1 5622.6 5625.2 5626.3 1316.7 1361.2 1362.2 1378.4 1381.5 904.1 911.7 930.5 936.6 945.6 5190.4 5244.9 5271.2 5279.9 5286.8 5546.9 5554.6 5559.6 5560.2 5562.6 5200.6 5289.6 5490.9 5536.3 5541.1 2947.3 2956.3 2961.7 2966.4 2967.8 5651.9 5789.2 5801.8 5804.9 5817.3 5627.0 5644.7 5668.0 5684.5 5696.8 5746.7 5751.2 5754.7 5769.4 5818.4 5304.2 5509.0 5521.6 5558.7 5603.3 5501.6 5510.7 5529.2 5529.4 5540.8 5459.4 5759.5 5760.6 5777.5 5797.6 4040.5 4048.8 4050.8 4059.8 4067.5 5509.4 5532.8 5566.2 5578.2 5592.6 5320.1 5343.9 5467.2 5486.0 5499.9 5353.8 5428.6 5442.4 5447.1 5466.9 5335.7 5370.5 5387.6 5421.5 5490.0 5507.9 5599.6 5637.0 5641.5 5644.3 5468.3 5477.8 5489.5 5510.0 5511.3 02:51:26 INFO - PROCESS | 1438 | 02:51:26 INFO - PROCESS | 1438 | [#5] yui.html Cycles:180 Average:18117.19 Median:50041.87 stddev:24440.51 (48.8%) stddev-sans-first:24474.41 02:51:26 INFO - PROCESS | 1438 | Values: 782.3 797.9 820.7 824.3 892.4 13899.0 14668.1 15055.4 15211.4 15283.2 12519.9 13452.5 13581.3 13586.9 13707.2 837.3 849.8 850.5 851.2 851.3 861.4 862.4 864.6 864.9 865.0 902.2 902.3 902.4 902.7 903.5 899.0 900.9 901.4 902.9 903.0 657.5 658.0 658.9 659.5 661.2 12622.2 12908.7 12952.0 12952.7 13066.6 12517.6 12671.0 12723.6 12975.9 13163.1 10836.6 10905.4 10939.6 11270.2 11452.8 3811.6 3820.9 3867.7 3910.9 3940.6 38426.4 45599.3 58042.0 59101.4 67746.0 11993.5 12214.6 12409.2 12421.1 12546.5 21652.2 21684.8 21817.9 21825.3 21863.8 8849.4 8979.8 8981.9 9004.1 9085.1 4668.3 4757.2 4817.5 4820.0 4959.7 3415.8 3523.3 3525.4 3526.3 3541.0 636.6 643.3 644.6 647.0 649.1 671.2 781.6 793.7 805.4 826.3 9258.4 9551.6 9606.7 9776.6 9994.4 641.0 669.9 697.6 714.9 783.0 4438.1 4653.5 4695.4 4697.7 4716.2 86865.6 90118.0 91309.0 92524.5 95299.0 79209.6 79914.2 82774.0 83364.0 84020.2 71711.6 71878.9 71919.0 72798.3 74423.0 8454.6 8509.4 8727.2 8927.9 9047.3 49507.0 49928.0 50155.7 50350.0 50449.7 61833.0 67985.7 68455.0 69127.3 69446.3 12314.6 12590.3 12674.9 12742.7 12972.9 13456.1 13529.7 13548.5 13638.8 13667.2 12562.2 12781.4 12795.6 12806.9 13049.6 12064.9 12075.9 12084.8 12701.9 13422.1 11896.3 12171.2 12645.3 12775.2 13367.9 10484.7 10499.8 10998.9 11091.5 11150.6 9519.7 9725.9 9734.3 10711.5 10748.8 02:51:26 INFO - PROCESS | 1438 | -------- Summary: end -------- 02:51:26 INFO - PROCESS | 1438 | 02:51:27 INFO - TEST-INFO | 1438: exit 0 02:51:27 INFO - TEST-OK | dromaeo_css | took 1115370ms 02:51:27 INFO - TEST-START | kraken 02:51:27 INFO - operating with platform_type : linux_ 02:51:27 INFO - Initialising browser for kraken test... 02:51:27 INFO - TEST-INFO | started process 1757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqeJVb3/profile http://localhost:57902/getInfo.html) 02:51:31 INFO - PROCESS | 1757 | __metrics Screen width/height:1600/1200 02:51:31 INFO - PROCESS | 1757 | colorDepth:24 02:51:31 INFO - PROCESS | 1757 | Browser inner width/height: 1024/697 02:51:31 INFO - PROCESS | 1757 | __metrics 02:51:32 INFO - PROCESS | 1757 | 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" 02:51:32 INFO - PROCESS | 1757 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:32 INFO - PROCESS | 1757 | console.error: PushService: 02:51:32 INFO - PROCESS | 1757 | stateChangeProcessEnqueue: Error transitioning state 02:51:32 INFO - PROCESS | 1757 | UnknownError 02:51:33 INFO - TEST-INFO | 1757: exit 0 02:51:33 INFO - Browser initialized. 02:51:33 INFO - Running cycle 1/1 for kraken test... 02:51:33 INFO - TEST-INFO | started process 1850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqeJVb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:45 INFO - PROCESS | 1850 | RSS: Main: 144478208 02:51:45 INFO - PROCESS | 1850 | 02:51:47 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:48 INFO - PROCESS | 1850 | RSS: Main: 184569856 02:51:48 INFO - PROCESS | 1850 | 02:51:51 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-dft) 02:51:51 INFO - PROCESS | 1850 | RSS: Main: 174825472 02:51:51 INFO - PROCESS | 1850 | 02:51:54 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-fft) 02:51:55 INFO - PROCESS | 1850 | RSS: Main: 266727424 02:51:55 INFO - PROCESS | 1850 | 02:51:57 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-oscillator) 02:51:57 INFO - PROCESS | 1850 | RSS: Main: 173363200 02:51:57 INFO - PROCESS | 1850 | 02:51:59 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:00 INFO - PROCESS | 1850 | RSS: Main: 175726592 02:52:00 INFO - PROCESS | 1850 | 02:52:03 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57902/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:04 INFO - PROCESS | 1850 | RSS: Main: 214106112 02:52:04 INFO - PROCESS | 1850 | 02:52:07 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57902/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:08 INFO - PROCESS | 1850 | RSS: Main: 212447232 02:52:08 INFO - PROCESS | 1850 | 02:52:10 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57902/tests/kraken/driver.html?testName=json-parse-financial) 02:52:11 INFO - PROCESS | 1850 | RSS: Main: 212017152 02:52:11 INFO - PROCESS | 1850 | 02:52:12 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:13 INFO - PROCESS | 1850 | RSS: Main: 173883392 02:52:13 INFO - PROCESS | 1850 | 02:52:15 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:15 INFO - PROCESS | 1850 | RSS: Main: 180637696 02:52:15 INFO - PROCESS | 1850 | 02:52:17 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:18 INFO - PROCESS | 1850 | RSS: Main: 189464576 02:52:18 INFO - PROCESS | 1850 | 02:52:20 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:21 INFO - PROCESS | 1850 | RSS: Main: 199008256 02:52:21 INFO - PROCESS | 1850 | 02:52:24 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:24 INFO - PROCESS | 1850 | RSS: Main: 194834432 02:52:24 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57902/tests/kraken/driver.html?testName=ai-astar) 02:52:26 INFO - PROCESS | 1850 | RSS: Main: 247599104 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | __start_tp_report 02:52:26 INFO - PROCESS | 1850 | _x_x_mozilla_page_load 02:52:26 INFO - PROCESS | 1850 | _x_x_mozilla_page_load_details 02:52:26 INFO - PROCESS | 1850 | |i|pagename|runs| 02:52:26 INFO - PROCESS | 1850 | |0;ai-astar;104;114;113;115;114;112;112;114;111;112 02:52:26 INFO - PROCESS | 1850 | |1;audio-beat-detection;142;118;123;148;119;118;117;121;144;117 02:52:26 INFO - PROCESS | 1850 | |2;audio-dft;162;160;160;160;160;163;160;162;160;160 02:52:26 INFO - PROCESS | 1850 | |3;audio-fft;74;75;75;111;74;76;75;75;95;75 02:52:26 INFO - PROCESS | 1850 | |4;audio-oscillator;82;81;110;81;82;81;108;83;82;108 02:52:26 INFO - PROCESS | 1850 | |5;imaging-gaussian-blur;117;118;117;117;117;117;119;118;117;117 02:52:26 INFO - PROCESS | 1850 | |6;imaging-darkroom;145;147;146;145;145;146;145;146;146;146 02:52:26 INFO - PROCESS | 1850 | |7;imaging-desaturate;84;85;84;85;84;85;86;84;85;84 02:52:26 INFO - PROCESS | 1850 | |8;json-parse-financial;50;53;50;50;50;53;51;51;50;50 02:52:26 INFO - PROCESS | 1850 | |9;json-stringify-tinderbox;59;58;58;59;60;59;59;59;59;59 02:52:26 INFO - PROCESS | 1850 | |10;stanford-crypto-aes;75;75;75;75;75;74;74;81;82;77 02:52:26 INFO - PROCESS | 1850 | |11;stanford-crypto-ccm;123;122;122;121;133;122;132;120;160;123 02:52:26 INFO - PROCESS | 1850 | |12;stanford-crypto-pbkdf2;158;157;158;154;152;159;154;151;157;159 02:52:26 INFO - PROCESS | 1850 | |13;stanford-crypto-sha256-iterative;65;61;64;62;71;67;64;63;62;62 02:52:26 INFO - PROCESS | 1850 | __end_tp_report 02:52:26 INFO - PROCESS | 1850 | __start_cc_report 02:52:26 INFO - PROCESS | 1850 | _x_x_mozilla_cycle_collect,1594 02:52:26 INFO - PROCESS | 1850 | __end_cc_report 02:52:26 INFO - PROCESS | 1850 | __startTimestamp1484995946612__endTimestamp 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | ------- Summary: start ------- 02:52:26 INFO - PROCESS | 1850 | Number of tests: 14 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.11 (2.7%) stddev-sans-first:1.32 02:52:26 INFO - PROCESS | 1850 | Values: 104.0 114.0 113.0 115.0 114.0 112.0 112.0 114.0 111.0 112.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:122.00 stddev:12.61 (10.3%) stddev-sans-first:12.10 02:52:26 INFO - PROCESS | 1850 | Values: 142.0 118.0 123.0 148.0 119.0 118.0 117.0 121.0 144.0 117.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 02:52:26 INFO - PROCESS | 1850 | Values: 162.0 160.0 160.0 160.0 160.0 163.0 160.0 162.0 160.0 160.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:12.46 (16.6%) stddev-sans-first:12.99 02:52:26 INFO - PROCESS | 1850 | Values: 74.0 75.0 75.0 111.0 74.0 76.0 75.0 75.0 95.0 75.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:81.50 stddev:13.05 (16.0%) stddev-sans-first:13.53 02:52:26 INFO - PROCESS | 1850 | Values: 82.0 81.0 110.0 81.0 82.0 81.0 108.0 83.0 82.0 108.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:52:26 INFO - PROCESS | 1850 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 119.0 118.0 117.0 117.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 02:52:26 INFO - PROCESS | 1850 | Values: 145.0 147.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 02:52:26 INFO - PROCESS | 1850 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 86.0 84.0 85.0 84.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:50.50 stddev:1.23 (2.4%) stddev-sans-first:1.27 02:52:26 INFO - PROCESS | 1850 | Values: 50.0 53.0 50.0 50.0 50.0 53.0 51.0 51.0 50.0 50.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 02:52:26 INFO - PROCESS | 1850 | Values: 59.0 58.0 58.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.00 stddev:2.87 (3.8%) stddev-sans-first:3.00 02:52:26 INFO - PROCESS | 1850 | Values: 75.0 75.0 75.0 75.0 75.0 74.0 74.0 81.0 82.0 77.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:123.00 stddev:12.18 (9.9%) stddev-sans-first:12.80 02:52:26 INFO - PROCESS | 1850 | Values: 123.0 122.0 122.0 121.0 133.0 122.0 132.0 120.0 160.0 123.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:157.50 stddev:2.92 (1.9%) stddev-sans-first:3.00 02:52:26 INFO - PROCESS | 1850 | Values: 158.0 157.0 158.0 154.0 152.0 159.0 154.0 151.0 157.0 159.0 02:52:26 INFO - PROCESS | 1850 | 02:52:26 INFO - PROCESS | 1850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:3.00 (4.7%) stddev-sans-first:3.16 02:52:26 INFO - PROCESS | 1850 | Values: 65.0 61.0 64.0 62.0 71.0 67.0 64.0 63.0 62.0 62.0 02:52:26 INFO - PROCESS | 1850 | -------- Summary: end -------- 02:52:26 INFO - PROCESS | 1850 | 02:52:27 INFO - TEST-INFO | 1850: exit 0 02:52:27 INFO - TEST-OK | kraken | took 59944ms 02:52:27 INFO - SUITE-END | took 1175s 02:52:27 INFO - Completed test suite (00:19:35) 02:52:27 INFO - javascript benchmark 02:52:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3221.677832216779, 3229.111994201595, 3265.7387409007283, 3289.5723555937725, 3306.6362700103, 5551.472610102039, 5659.4340565943385, 5664.1220610805285, 5671.489565939065, 5683.0622947213715, 5621.662700237978, 5659.0, 5665.830025099243, 5679.864027194557, 5717.6283541569765, 5110.412302585213, 5115.693058416488, 5125.308083408748, 5159.5614372778355, 5207.0, 5022.874428139289, 5212.192110222922, 5220.0, 5220.712860792655, 5236.162214045753, 4996.575291100261, 5081.0, 5086.21163719624, 5138.640295179339, 5138.7173705446185, 5105.617078719092, 5139.100657384962, 5143.048536020848, 5158.561522270612, 5212.061828870802, 5037.773300201463, 5118.744062796883, 5155.690658560498, 5168.638195326329, 5194.896102077975, 5371.409144994048, 5469.425710300401, 5469.589780766459, 5478.260434841285, 5502.119660854244, 5901.17383566301, 5911.172435858984, 5931.317898441691, 6020.488258498033, 6037.698115094227, 6076.939230607726, 6093.878122437571, 6095.451409373133, 6098.603590766586, 6101.511879049665, 5468.152436372368, 5510.338759348904, 5568.387477377485, 5710.2862142232225, 5714.371419143891, 6163.660998645028, 6182.1345011698395, 6195.81412557624, 6204.72078756448, 6207.565470417027, 5950.851228719317, 5951.642901425842, 5951.940480595225, 5952.434518720715, 5960.880782384328, 5750.7987220447085, 5792.333881603669, 6021.789237376671, 6100.298465676416, 6106.053561697944, 6041.24484439445, 6043.093535969552, 6045.365236650088, 6071.119687645267, 6079.361667024988, 5967.761289548456, 6008.489278411296, 6020.307664618625, 6031.577789554777, 6070.392960703983, 4519.570640789119, 4557.886052848639, 4562.1560011398, 4581.74800385982, 4597.586217240464, 4125.814338354721, 4137.420761093449, 4139.834406623761, 4140.171965606891, 4170.270202714573, 5755.366909639936, 5756.827295181151, 5769.451902069297, 5772.740226689809, 5782.797602083907, 5876.970615146983, 5893.882122357529, 5923.08192230205, 5934.584579079423, 6054.303755068224, 5695.45893140151, 5699.145128230799, 5700.971495142498, 5702.344230413555, 5730.885382292414, 5138.2292656101135, 5149.639525233272, 5150.304708864331, 5150.510701483353, 5173.430922598511, 6067.150598916155, 6136.825445958321, 6161.229846269216, 6184.6598437086395, 6186.969065154645, 5947.583669143119, 6047.09293605945, 6074.240719910012, 6094.299155597163, 6139.969300153471, 6262.655553944577, 6280.152179455715, 6291.874162516816, 6296.716647750771, 6302.810915672537, 5716.142578613241, 5719.170720245458, 5948.970255148696, 5960.940390596039, 5994.400559943971, 5927.8221653350465, 5933.0, 5947.9702601486715, 5973.701314934323, 6002.609830361012, 5854.356020837789, 5862.648241105548, 5875.030619947832, 5921.733521991435, 5930.11048342752, 5620.437956204347, 5888.3228428729535, 5896.705164741831, 5903.2325797646035, 5905.350411454822, 5667.064934285797, 5778.451047150514, 5834.766609335748, 5849.532037436909, 5906.586538942404, 6006.909896351645, 6008.519318454601, 6013.759449622141, 6020.578559500793, 6022.5784195105925, 5635.211070450058, 5685.943140568706, 5712.571557133148, 5844.853878653068, 5851.736671849691], "value": 5546.83542041931, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.326867564949, 596.7821745063052, 613.5153228949127, 623.1867413026, 633.9634697269962, 32545.83727081364, 44901.77549112254, 45044.324335134996, 45102.77448612761, 45207.32189017163, 45048.0, 45574.0, 45617.54382456175, 45634.087318253616, 45642.0, 8175.182481751807, 8359.373047021467, 8686.261667758232, 8820.647174113028, 8837.911620883773, 10513.264071514997, 10760.892391076106, 10766.354018758899, 10770.29993050453, 10772.40751758653, 10627.309224900395, 10637.893621063768, 10688.144948404148, 10705.732356691067, 10708.1968852336, 10381.273310868204, 10387.792244155113, 10419.583216671324, 10439.0, 10452.634157804516, 10484.842727359095, 10504.947475262652, 10540.472976351151, 10545.84181237282, 10549.894501054969, 42299.36550951738, 42708.359374609405, 42718.57281427177, 42757.144857102685, 42793.57206427927, 3556.324298383299, 3569.928601427983, 3632.055665526982, 3683.9447408288897, 4072.2873497137884, 30666.386672266653, 32080.518792218136, 32093.0, 32367.190820229447, 32619.6738032619, 4408.493023302329, 4452.465704115494, 4470.993658975019, 4475.39582156408, 4527.4114365132655, 351048.0, 357250.0, 358521.0, 359070.0, 359162.0, 67558.0, 68128.6593567039, 68236.0, 68295.65852170707, 68479.65760171167, 40993.38509922354, 41701.37447938283, 41738.373924391155, 44093.559064408946, 44117.0, 19172.13725382361, 19349.839009659183, 19381.709274360896, 19392.2243110274, 19398.224071037283, 13566.457341706222, 13640.045196836325, 13647.249401282827, 14158.433662653584, 14756.188409637572, 21250.149994000378, 21527.461813454476, 21645.458863528536, 22612.547749044927, 22628.660570091462, 7954.642041108164, 8223.506589604644, 8242.629081691339, 8263.107912230671, 8389.286910612544, 1003.8393856982848, 1065.8880817514205, 1071.7910007548453, 1100.1034157161887, 1174.7591743692522, 33105.83447082749, 33180.66819331824, 33424.83287583546, 33547.15354933276, 33722.49416258758, 983.3902980152351, 1084.9457527123611, 1121.6915348279288, 1146.587228597704, 1160.4719852467108, 16032.679346413006, 17055.914720426317, 17636.030018348858, 18103.72844407335, 18233.0, 491214.0, 493143.0, 493520.0, 494844.0, 496091.0, 61162.388376116556, 62209.688951554956, 62213.377866220755, 62290.68854655788, 62366.376336236055, 1297.2994582925303, 1349.3320806200993, 1366.0164681429355, 1394.623451668044, 1448.8840892728556, 27498.587521187597, 31937.041888743373, 33836.66163338335, 34653.653463465045, 35324.646753532135, 48090.5190948086, 52137.47862521478, 52246.0, 52298.477015229364, 52335.47664523306, 457458.0, 463475.0, 463783.0, 464554.0, 466974.0, 40141.0, 46366.0, 46465.30302045404, 46771.532284676716, 49233.75383123061, 50195.0, 50347.74826125846, 50568.747156263984, 50639.49360506348, 50689.74655126701, 41768.37347439852, 42070.0, 42378.0, 42609.147817044104, 43289.567104328555, 41343.0, 41430.792846035576, 41985.58014419817, 42997.0, 43666.56333436625, 41813.372799408644, 42136.57863421326, 42545.36181957335, 42661.36007959821, 43178.0, 34926.0, 37801.81099094597, 38221.80889095537, 41531.1693766129, 42491.3626295612, 28642.0, 28689.71310286954, 29060.0, 29061.7093829059, 29402.852985734935], "value": 21288.227510862198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.2281279632678, 420.7888835227681, 428.72990016289737, 439.17873576412103, 440.645280549158, 18842.0, 18933.715994260063, 20044.69932951007, 20181.495462613442, 20476.385708428752, 18600.906995465004, 18902.96033718145, 18974.43076707701, 18980.525486862836, 19323.51691207717, 5144.4598317176715, 5400.83797486076, 5432.266644003068, 5476.479734425223, 5486.094794358926, 5308.389535203462, 5347.117725575295, 5347.278117454152, 5350.384705758848, 5364.570834333244, 5833.066709326508, 5863.472287494124, 5872.354041055481, 5875.794347197849, 5876.177335173079, 5312.840614781563, 5357.383900851413, 5870.618409803349, 5871.677057761822, 5876.08920617305, 5226.451222621646, 5231.633785635007, 5234.031704134747, 5236.633435659467, 5240.3973543042275, 14530.418783248657, 18019.819801801947, 20376.184952601878, 24264.1507547235, 24451.877740611362, 2282.3837563857833, 2401.075585899424, 2474.1587860127465, 2503.0738626708053, 3025.848707564613, 10277.537510812032, 10785.460726963698, 11130.109591232682, 14215.928920355333, 14482.348294326675, 1917.9956944992516, 1918.9361617289298, 1926.730257763914, 2006.518435575466, 2027.3715148304072, 79493.0, 85136.0, 85697.57151214266, 87771.12228877694, 89843.55078224567, 11926.522939082513, 12131.939340303243, 12133.817992730115, 12172.147949643617, 12264.202826816228, 15679.451219207502, 15827.446039388566, 16307.83692163087, 17096.0, 17131.05779182132, 6466.773662921775, 6572.145621069326, 7988.480748751313, 8588.8711669325, 8717.171868672465, 8034.718784842503, 8073.515589064675, 8110.756677299691, 8225.177482251847, 8232.382571307056, 5146.716930568855, 5193.298904647824, 5225.425203227642, 5234.293370395024, 5369.4630536946, 2121.4060063182333, 2195.6047911376104, 2218.378853920905, 2231.5871563760757, 2239.0595949701164, 884.5665623844399, 967.6951760195516, 976.0922342221802, 1026.2303272545591, 1062.5431064642278, 19303.0, 19463.0, 19633.410997670093, 19811.20755169777, 19898.801011989985, 1000.6797824696173, 1023.5291765787672, 1029.156092004564, 1036.3419228789621, 1082.826747720361, 10557.788844223072, 11032.889671103187, 11263.0, 11286.943565282121, 11314.830277545843, 485077.0, 488096.0, 488693.0, 488743.0, 495628.0, 56263.71868140715, 91859.0, 93531.0, 96689.51655241678, 97091.0, 985.6156099121348, 987.5407935309971, 1004.9346792458613, 1022.3354819367471, 1032.1381646325403, 14933.551993440215, 16813.0, 16882.324707011583, 17617.647647047244, 17784.3775467858, 42385.78807105945, 44628.55371446244, 45710.1715931359, 45772.54227457816, 46675.29987050129, 57553.424465756485, 58233.4176658245, 59306.11040834477, 59826.0, 60295.39704602898, 6420.967895160495, 8771.824563508822, 8956.641734330553, 9287.72136835896, 9302.0, 13017.349132543146, 13234.536791212262, 13320.200787952754, 13422.127561708458, 13531.59405217845, 11031.282966607145, 11044.116470682166, 11173.162012849232, 11369.886301136883, 11806.1145414096, 11148.275362101438, 11297.0, 11313.71715707114, 11368.147388945697, 11687.824682629598, 9386.45123554606, 11271.380074096003, 11366.204365694322, 11606.651800446, 12019.218750781522, 9052.456852588866, 9085.13691199335, 9347.719568412958, 9430.764230894009, 9442.433453992782, 11017.0, 11229.71925701864, 11271.211015228855, 11434.94282528582, 11477.0], "value": 9345.562905780493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.4871948659509, 1516.2267243705714, 1544.8686861616761, 1626.7885174927258, 1705.3093497133666, 7609.162992070867, 8349.41554091214, 8633.827323453526, 8644.740657780261, 8882.64469421224, 8688.261497772697, 8754.3871928965, 8757.562121893912, 8761.737147885558, 8770.736877893658, 2420.3828023853894, 2432.9756702433015, 2451.4361696809747, 2452.1172377943926, 2454.803615710739, 2409.8554086754853, 2437.3662847659557, 2444.40112172518, 2452.3133522613607, 2456.447299357639, 2365.2431222008963, 2379.2267513058327, 2412.1316326122583, 2422.994457300227, 2424.9393765155837, 2324.360800779782, 2336.4158960259933, 2350.82368822339, 2353.329301149173, 2356.3166681662296, 2328.5459335429596, 2360.9645855312183, 2412.408959804859, 2421.1041914491752, 2423.9394015149765, 7598.0, 7821.804454888674, 8922.28621710268, 8929.687460938901, 9033.735277061216, 5325.041492531343, 5472.616916815825, 5489.533389661883, 5602.38373778884, 5609.382967873531, 3492.406290930548, 3561.2521370512222, 3613.2050948791225, 3615.891523254307, 3681.944770828413, 1135.3641960502146, 1162.7906976744182, 1174.2367461150236, 1181.2440038375446, 2119.194706011721, 12187.756244875141, 12671.619851404472, 12686.429110690042, 12731.363431828464, 12739.936300318439, 4755.690880092783, 4812.0, 4846.636502262344, 4931.90136197274, 5007.324011258506, 9830.901690982999, 9870.654527091661, 9885.802283954281, 9895.703128906145, 9907.801843963225, 5530.585206109477, 5541.418151094077, 5547.445255474501, 5548.750306236229, 5555.0, 5003.374578177728, 5028.220625803006, 5045.84862454127, 5045.949540504622, 5206.245094461357, 3774.490443790108, 3847.9038024049623, 3879.1465877506903, 3937.370020796659, 3970.5830887756947, 1194.6117511808698, 1198.7242934125027, 1201.0751721174647, 1216.0575553945587, 1220.4629962816332, 905.8867641544807, 932.7621456528677, 937.2455173585329, 939.7274790310734, 965.2229954886244, 5657.660540367591, 5719.571032172604, 5732.34078081026, 5968.403159684084, 5972.910406343908, 416.26529176004374, 419.09057345560205, 420.8548050922427, 424.8677275061925, 426.20725450661746, 4019.8191081401405, 4060.3503439449546, 4075.3275709508193, 4076.510818701775, 4158.771267580251, 9573.18627916621, 9639.325247232766, 10520.789584208273, 10724.946375268073, 10788.56845726178, 10908.672739817817, 10960.342379457099, 10997.945010274898, 11025.558977640805, 11153.832692509619, 8214.342852571779, 8457.40798144124, 8479.109693482218, 8484.0, 8501.872471912802, 5980.401959803985, 6000.339962604197, 6032.366601506954, 6067.423594758491, 6109.2974307955155, 9688.176504996873, 9903.653372131941, 9928.156106731009, 9958.751031224278, 10040.849387259343, 10049.849252261369, 10310.639127630797, 10340.431276279876, 10418.531166097695, 10420.47897605132, 7469.514481558681, 7471.3649339806725, 7479.252074792477, 7482.401407887465, 7597.0, 8006.439549231498, 8080.676772929252, 8086.110527841815, 8088.514689118671, 8090.7168249111, 7101.183363913216, 7173.497855150298, 7256.129264488295, 7273.709051638087, 7347.485676002629, 6867.416269616939, 6984.266652001466, 7050.823729406806, 7083.893741593984, 7098.503104782616, 6887.552309099892, 6902.689378978059, 6943.479239057192, 6944.722211111701, 6945.236024037251, 4577.93133102997, 4594.816207351669, 4605.631549476101, 4687.320338550823, 4688.742119183341, 4730.290456431563, 4794.760261986957, 4840.128776820206, 4843.564079232886, 5074.797008119634], "value": 4535.363884470625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.1295924117675, 336.2115838359048, 338.88647303153436, 342.7378055787323, 347.3851283228687, 5430.619856610039, 5440.564754819615, 5464.2896423464945, 5475.835724928249, 5488.8319113949965, 5061.822836200734, 5175.870603234921, 5186.507281808223, 5240.37115546135, 5350.35795704516, 4192.056787222881, 4193.475815523059, 4208.810603522848, 4209.810558524866, 4253.532111467736, 4200.957990420103, 4230.17511585241, 4236.8772275347055, 4244.342126970325, 4274.679399045069, 3917.3144699677587, 3976.6818654507715, 4123.896902577445, 4149.688773341996, 4184.748915065091, 4120.91758164835, 4122.40225167349, 4150.771707556083, 4152.4601801765875, 4154.397612346208, 3662.0, 3668.651478109602, 3669.8165091745573, 3671.8066628345628, 3688.6311368863167, 5152.9484705152845, 5192.55863251624, 5228.451012643655, 5274.736263186864, 5286.735663216824, 4743.027679325764, 4744.217204161309, 4760.785764640565, 4772.880677983044, 4786.7845946932475, 5569.605069819976, 5582.888342233173, 5588.3573389060375, 5593.804216852432, 5607.299087614048, 3894.6300101490597, 3988.3419235826054, 4000.8199631016673, 4069.409935559357, 4073.226087043482, 5780.682062486561, 5791.333996590404, 5792.333881603628, 5799.623024503394, 5803.361630220672, 4094.529129150126, 4100.282450571138, 4107.8973025674595, 4135.421041054255, 4144.129732756155, 3951.9012024699036, 4090.8363665453644, 4259.699762128478, 4262.126264115849, 4268.445102136702, 4697.812087516461, 4716.740579268173, 4722.960948591304, 4729.408823897013, 4789.976050119727, 5545.0, 5611.110278206726, 5622.550195984393, 5625.212470254168, 5626.324841019104, 1316.7498175346846, 1361.237706884148, 1362.1826903857805, 1378.379729121879, 1381.461230120254, 904.1410659873015, 911.7447114807865, 930.4510338900081, 936.6300311376968, 945.5933948402253, 5190.351206099238, 5244.872352444243, 5271.156614941668, 5279.9208011879855, 5286.81496147633, 5546.91679624806, 5554.583406244547, 5559.583031272671, 5560.165975103767, 5562.638428502134, 5200.635955483155, 5289.550388216968, 5490.913452887877, 5536.280283563192, 5541.113421852484, 2947.322115913352, 2956.2609347663083, 2961.748251398612, 2966.4215477982016, 2967.8219306841656, 5651.858703532444, 5789.218455508537, 5801.752623186036, 5804.912926306109, 5817.331006934257, 5627.0, 5644.74598643062, 5668.044524638993, 5684.516816070681, 5696.829095127153, 5746.741396637161, 5751.194832723422, 5754.6547207167705, 5769.423057694197, 5818.44724751148, 5304.15133578641, 5509.0, 5521.558275338044, 5558.666480011212, 5603.271574695426, 5501.642393244426, 5510.724463776875, 5529.198266251451, 5529.419410961791, 5540.75066622011, 5459.426760190123, 5759.452851979056, 5760.567957403127, 5777.537796976316, 5797.579428137419, 4040.4545386372465, 4048.838046478108, 4050.817713202972, 4059.776712280735, 4067.511898572072, 5509.3664228614225, 5532.806351777668, 5566.192902029264, 5578.210894552723, 5592.608517403743, 5320.053803853373, 5343.9198412024625, 5467.17992301158, 5486.0, 5499.890002200013, 5353.75908084145, 5428.56571474289, 5442.401335852974, 5447.066291466631, 5466.863328416822, 5335.73321333924, 5370.46941621636, 5387.622866399472, 5421.512063914267, 5489.972550137224, 5507.862303442446, 5599.60802743804, 5637.0, 5641.5204707600315, 5644.266245388073, 5468.316460442445, 5477.75350109238, 5489.505944465017, 5510.0, 5511.255980442749], "value": 4223.173936354918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.2724865874737, 797.8603744344742, 820.706126376777, 824.3446460064248, 892.4020905992984, 13899.027068105224, 14668.11991280524, 15055.397784088624, 15211.391544338241, 15283.235838208087, 12519.874801251985, 13452.461901523951, 13581.253031083286, 13586.864131358683, 13707.246101464416, 837.300853787087, 849.8045449546609, 850.5067061104545, 851.199872120205, 851.3104385447776, 861.3970220845401, 862.3618522293489, 864.6498168241841, 864.9048604653483, 865.0, 902.2421166220373, 902.2736696958946, 902.3999040637968, 902.7291812456269, 903.5030733096803, 899.0470101692162, 900.9099090090971, 901.4050726520497, 902.9187373136383, 902.9819403611924, 657.5364368120463, 658.045833541367, 658.8550518885837, 659.5416185750905, 661.206552137437, 12622.242665440102, 12908.677283067904, 12952.0, 12952.740945181044, 13066.608001759867, 12517.623061463231, 12671.049671274692, 12723.618291451272, 12975.935120324433, 13163.144395614254, 10836.620718274902, 10905.400202988832, 10939.617113400993, 11270.211085224038, 11452.828207576893, 3811.5997820228754, 3820.923581528382, 3867.7099217558793, 3910.8631197907935, 3940.625640564142, 38426.42360364597, 45599.31601025987, 58042.0, 59101.40898591045, 67745.9999999995, 11993.520259189709, 12214.633560993185, 12409.193402428813, 12421.068419868365, 12546.498140074478, 21652.24217152392, 21684.78315216859, 21817.890910545662, 21825.345239642837, 21863.78136218649, 8849.380543361904, 8979.820403591892, 8981.910180898107, 9004.099590041074, 9085.13691199335, 4668.276417155346, 4757.191277482836, 4817.5182481752245, 4819.95180048202, 4959.7272150032095, 3415.8121303328558, 3523.2777280657406, 3525.383057964846, 3526.3299973005046, 3541.0, 636.5703150373572, 643.2955913274957, 644.5552568727563, 647.0133047103111, 649.0523835200565, 671.1509939925998, 781.6170076662509, 793.742033838993, 805.3838813307824, 826.3017750001239, 9258.351915365995, 9551.61793528265, 9606.711798646053, 9776.560054797408, 9994.350367226107, 640.9967950160219, 669.8693754717783, 697.5919087333966, 714.8999140120387, 782.9921700782919, 4438.134563760101, 4653.464851542049, 4695.436547614308, 4697.718136911796, 4716.174669432836, 86865.5656721725, 90118.0, 91309.0, 92524.53737731268, 95299.0, 79209.60395197987, 79914.20085799183, 82774.0, 83364.0, 84020.15979840246, 71711.64144179245, 71878.9218161728, 71919.0, 72798.27201728021, 74423.0, 8454.619542120743, 8509.36179786531, 8727.170918762708, 8927.866082008644, 9047.276217902683, 49507.0, 49928.0, 50155.74922125366, 50350.0, 50449.747751261006, 61833.0, 67985.66007169933, 68455.0, 69127.3087269141, 69446.30553694398, 12314.59690219475, 12590.307533085768, 12674.936625316814, 12742.74514509686, 12972.897303729289, 13456.065280127454, 13529.729405412034, 13548.458061677422, 13638.79541806854, 13667.17996920188, 12562.23783166614, 12781.360931953552, 12795.61613151607, 12806.871931280568, 13049.608511744664, 12064.879351206375, 12075.879241207476, 12084.75830483403, 12701.93649031749, 13422.127561708458, 11896.345700986183, 12171.208871423683, 12645.304508252135, 12775.169613975062, 13367.866321336662, 10484.685459436228, 10499.842502362319, 10998.890011099787, 11091.500882460146, 11150.553977840795, 9519.714408567754, 9725.854112188465, 9734.318597698093, 10711.464426778786, 10748.838767418338], "value": 7251.075972227921, "unit": "score"}], "name": "dromaeo_css", "value": 7315.576276635493, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 115.0, 114.0, 112.0, 112.0, 114.0, 111.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 123.0, 148.0, 119.0, 118.0, 117.0, 121.0, 144.0, 117.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 160.0, 160.0, 163.0, 160.0, 162.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 111.0, 74.0, 76.0, 75.0, 75.0, 95.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 81.0, 82.0, 81.0, 108.0, 83.0, 82.0, 108.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 50.0, 50.0, 50.0, 53.0, 51.0, 51.0, 50.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 75.0, 74.0, 74.0, 81.0, 82.0, 77.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 122.0, 121.0, 133.0, 122.0, 132.0, 120.0, 160.0, 123.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 154.0, 152.0, 159.0, 154.0, 151.0, 157.0, 159.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 64.0, 62.0, 71.0, 67.0, 64.0, 63.0, 62.0, 62.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1451.2999999999997, "alertThreshold": 2.0}]} 02:52:27 INFO - Return code: 0 02:52:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:27 INFO - # TBPL SUCCESS # 02:52:27 INFO - Running post-action listener: _resource_record_post_action 02:52:27 INFO - [mozharness: 2017-01-21 10:52:27.940522Z] Finished run-tests step (success) 02:52:27 INFO - Running post-run listener: _resource_record_post_run 02:52:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356921344; Read time: 36; Write time: 204916 02:52:28 INFO - TinderboxPrint: CPU usage
13.0% 02:52:28 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 02:52:28 INFO - TinderboxPrint: I/O write bytes / time
356,921,344 / 204,916 02:52:28 INFO - TinderboxPrint: CPU idle
8,276.1 (87.0%) 02:52:28 INFO - TinderboxPrint: CPU user
1,193.8 (12.5%) 02:52:28 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108466176; Read time: 0; Write time: 68756 02:52:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248455168; Read time: 20; Write time: 136160 02:52:28 INFO - Running post-run listener: _upload_blobber_files 02:52:28 INFO - Blob upload gear active. 02:52:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:28 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 02:52:28 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'] 02:52:28 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 02:52:28 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:29 INFO - (blobuploader) - INFO - Done attempting. 02:52:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:32 INFO - (blobuploader) - INFO - Done attempting. 02:52:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:52:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:33 INFO - (blobuploader) - INFO - Done attempting. 02:52:33 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:33 INFO - Return code: 0 02:52:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a3bbaceac70d6eb3ec97af8c57dc13428d5100de2d60ae7f72eab07da0404192208200b8435a77d9836e2756c65a3bd18f7db504e8bfe3fb3cc386ce08f80dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecbd474183e303550ceddf4191b9d2113290bc75dce6d00e8b7c34800064193ca1ecfeb1062c3632ad76d371f57729ac595facf53b60ada1d57fc669462dd1e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02b750719c433313f40b785a3dfb82b55310bf26035847aa9ab8e8f2275e07d0a25b1adade03cb7b4fdd9ddcf8ede382c8e952f65cfbb3ae42af1fd77e39540"} 02:52:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:33 INFO - Contents: 02:52:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a3bbaceac70d6eb3ec97af8c57dc13428d5100de2d60ae7f72eab07da0404192208200b8435a77d9836e2756c65a3bd18f7db504e8bfe3fb3cc386ce08f80dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecbd474183e303550ceddf4191b9d2113290bc75dce6d00e8b7c34800064193ca1ecfeb1062c3632ad76d371f57729ac595facf53b60ada1d57fc669462dd1e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02b750719c433313f40b785a3dfb82b55310bf26035847aa9ab8e8f2275e07d0a25b1adade03cb7b4fdd9ddcf8ede382c8e952f65cfbb3ae42af1fd77e39540"} 02:52:33 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:33 INFO - Copying logs to upload dir... 02:52:33 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.796013 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-01-21 02:52:33.367307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 02:52:33.371105) ========= 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=cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548 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/7a3bbaceac70d6eb3ec97af8c57dc13428d5100de2d60ae7f72eab07da0404192208200b8435a77d9836e2756c65a3bd18f7db504e8bfe3fb3cc386ce08f80dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecbd474183e303550ceddf4191b9d2113290bc75dce6d00e8b7c34800064193ca1ecfeb1062c3632ad76d371f57729ac595facf53b60ada1d57fc669462dd1e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02b750719c433313f40b785a3dfb82b55310bf26035847aa9ab8e8f2275e07d0a25b1adade03cb7b4fdd9ddcf8ede382c8e952f65cfbb3ae42af1fd77e39540"} build_url:https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/U-rkT40fSdypLxyTAizEIg/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/7a3bbaceac70d6eb3ec97af8c57dc13428d5100de2d60ae7f72eab07da0404192208200b8435a77d9836e2756c65a3bd18f7db504e8bfe3fb3cc386ce08f80dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecbd474183e303550ceddf4191b9d2113290bc75dce6d00e8b7c34800064193ca1ecfeb1062c3632ad76d371f57729ac595facf53b60ada1d57fc669462dd1e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02b750719c433313f40b785a3dfb82b55310bf26035847aa9ab8e8f2275e07d0a25b1adade03cb7b4fdd9ddcf8ede382c8e952f65cfbb3ae42af1fd77e39540"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 02:52:33.396447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:52:33.396821) ========= 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=cbe409c6de289db6ac707de3000001d4-1484993338.839666-985007548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:52:33.480419) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 02:52:33.480747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 02:52:33.481101) ========= ========= Total master_lag: 0.18 =========