builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1476354777.71 results: success (0) buildid: 20161013023623 builduid: 732ff31885c84a5eb292fb39a2f23093 revision: 536613038a4770545077bfd557b27aed5991c9a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.708097) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.708556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.708844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.723764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.724161) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 03:32:57-- 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% 221M=0s 2016-10-13 03:32:57 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113750 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.851558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.851879) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017348 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:57.901596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 03:32:57.901957) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 536613038a4770545077bfd557b27aed5991c9a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 536613038a4770545077bfd557b27aed5991c9a2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 03:32:58,034 truncating revision to first 12 chars 2016-10-13 03:32:58,034 Setting DEBUG logging. 2016-10-13 03:32:58,034 attempt 1/10 2016-10-13 03:32:58,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/536613038a47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 03:32:58,625 unpacking tar archive at: mozilla-central-536613038a47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936629 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 03:32:58.998125) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:58.998438) ========= script_repo_revision: 536613038a4770545077bfd557b27aed5991c9a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:58.998842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:58.999100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 03:32:59.014937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-13 03:32:59.015307) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:59 INFO - MultiFileLogger online at 20161013 03:32:59 in /builds/slave/test 03:32:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:59 INFO - {'append_to_log': False, 03:32:59 INFO - 'base_work_dir': '/builds/slave/test', 03:32:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:59 INFO - 'branch': 'Firefox-Non-PGO', 03:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:59 INFO - 'config_files': ('talos/linux_config.py',), 03:32:59 INFO - 'default_actions': ('clobber', 03:32:59 INFO - 'read-buildbot-config', 03:32:59 INFO - 'download-and-extract', 03:32:59 INFO - 'populate-webroot', 03:32:59 INFO - 'create-virtualenv', 03:32:59 INFO - 'install', 03:32:59 INFO - 'run-tests'), 03:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:59 INFO - 'download_minidump_stackwalk': True, 03:32:59 INFO - 'download_symbols': 'ondemand', 03:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:59 INFO - 'installer_path': 'installer.exe', 03:32:59 INFO - 'log_level': 'info', 03:32:59 INFO - 'log_name': 'talos', 03:32:59 INFO - 'log_to_console': True, 03:32:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:59 INFO - 'opt_config_files': (), 03:32:59 INFO - 'pip_index': False, 03:32:59 INFO - 'sps_profile': False, 03:32:59 INFO - 'sps_profile_interval': 0, 03:32:59 INFO - 'suite': 'dromaeojs', 03:32:59 INFO - 'system_bits': '32', 03:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:59 INFO - 'title': 'talos-linux64-ix-013', 03:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:59 INFO - 'use_talos_json': True, 03:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:59 INFO - 'work_dir': 'build'} 03:32:59 INFO - [mozharness: 2016-10-13 10:32:59.243978Z] Running clobber step. 03:32:59 INFO - Running pre-action listener: _resource_record_pre_action 03:32:59 INFO - Running main action method: clobber 03:32:59 INFO - rmtree: /builds/slave/test/build 03:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:00 INFO - Running post-action listener: _resource_record_post_action 03:33:00 INFO - [mozharness: 2016-10-13 10:33:00.210584Z] Finished clobber step (success) 03:33:00 INFO - [mozharness: 2016-10-13 10:33:00.210683Z] Running read-buildbot-config step. 03:33:00 INFO - Running pre-action listener: _resource_record_pre_action 03:33:00 INFO - Running main action method: read_buildbot_config 03:33:00 INFO - Using buildbot properties: 03:33:00 INFO - { 03:33:00 INFO - "project": "", 03:33:00 INFO - "product": "firefox", 03:33:00 INFO - "script_repo_revision": "production", 03:33:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:33:00 INFO - "repository": "", 03:33:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:33:00 INFO - "buildid": "20161013023623", 03:33:00 INFO - "pgo_build": "False", 03:33:00 INFO - "basedir": "/builds/slave/test", 03:33:00 INFO - "buildnumber": 671, 03:33:00 INFO - "slavename": "talos-linux64-ix-013", 03:33:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:00 INFO - "platform": "ubuntu64_hw", 03:33:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:33:00 INFO - "branch": "mozilla-central", 03:33:00 INFO - "repo_path": "mozilla-central", 03:33:00 INFO - "revision": "536613038a4770545077bfd557b27aed5991c9a2", 03:33:00 INFO - "stage_platform": "linux64", 03:33:00 INFO - "builduid": "732ff31885c84a5eb292fb39a2f23093", 03:33:00 INFO - "slavebuilddir": "test" 03:33:00 INFO - } 03:33:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:33:00 INFO - Running post-action listener: _resource_record_post_action 03:33:00 INFO - [mozharness: 2016-10-13 10:33:00.213130Z] Finished read-buildbot-config step (success) 03:33:00 INFO - [mozharness: 2016-10-13 10:33:00.213218Z] Running download-and-extract step. 03:33:00 INFO - Running pre-action listener: _resource_record_pre_action 03:33:00 INFO - Running main action method: download_and_extract 03:33:00 INFO - mkdir: /builds/slave/test/build/tests 03:33:00 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')]} 03:33:00 INFO - trying https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:33:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:33:00 INFO - Downloaded 1361 bytes. 03:33:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:33:00 INFO - Using the following test package requirements: 03:33:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:33:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'jsshell-linux-x86_64.zip'], 03:33:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:33:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:33:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:33:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:33:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:33:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:33:01 INFO - Http code: 200 03:33:01 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 03:33:01 INFO - x-amz-cf-id: AmmcphJB8mZn0bvT-cT5GWHP7-t-n89FNdCnG_iZsQolPXDPWFwU0A== 03:33:01 INFO - x-amz-version-id: uPAR9_D.HHxJf0dkr.OysjstacAnueOf 03:33:01 INFO - Expected file size: 20547953 03:33:01 INFO - Obtained file size: 20547953 03:33:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:33:06 INFO - Http code: 200 03:33:06 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 03:33:06 INFO - x-amz-cf-id: TY54ltFcVur60vhcHFmzbs0NLoT7Gbi-ZOg1Lm8p8SE9-zElKKOKWA== 03:33:06 INFO - x-amz-version-id: uPAR9_D.HHxJf0dkr.OysjstacAnueOf 03:33:06 INFO - Expected file size: 20547953 03:33:06 INFO - Obtained file size: 20547953 03:33:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:33:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:33:11 INFO - Http code: 200 03:33:11 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 03:33:11 INFO - x-amz-cf-id: Qspt1QjlSEv4TG-CpMfaXhXf79v0ANHIPnJpXQdHURlC9JSdXmbiMg== 03:33:11 INFO - x-amz-version-id: WR9CHuD0FUozfoqKnvwdLGBjdbf2cuEi 03:33:11 INFO - Expected file size: 14409006 03:33:11 INFO - Obtained file size: 14409006 03:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:12 INFO - trying https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:33:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:13 INFO - Downloaded 55930780 bytes. 03:33:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:33:13 INFO - mkdir: /builds/slave/test/properties 03:33:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:13 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:13 INFO - Contents: 03:33:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:33:13 INFO - Running post-action listener: _resource_record_post_action 03:33:13 INFO - Running post-action listener: set_extra_try_arguments 03:33:13 INFO - [mozharness: 2016-10-13 10:33:13.788634Z] Finished download-and-extract step (success) 03:33:13 INFO - [mozharness: 2016-10-13 10:33:13.788930Z] Running populate-webroot step. 03:33:13 INFO - Running pre-action listener: _resource_record_pre_action 03:33:13 INFO - Running main action method: populate_webroot 03:33:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:13 INFO - '--tppagecycles', 03:33:13 INFO - '7'], 03:33:13 INFO - 'tests': ['tsvgm']}}, 03:33:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['damp', 'tps']}, 03:33:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'tests': ['damp', 'tps']}, 03:33:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['dromaeo_dom']}, 03:33:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['basic_compositor_video']}, 03:33:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['a11yr', 03:33:13 INFO - 'ts_paint', 03:33:13 INFO - 'tpaint', 03:33:13 INFO - 'sessionrestore', 03:33:13 INFO - 'sessionrestore_no_auto_restore', 03:33:13 INFO - 'tabpaint']}, 03:33:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:13 INFO - 'ts_paint', 03:33:13 INFO - 'tpaint', 03:33:13 INFO - 'sessionrestore', 03:33:13 INFO - 'sessionrestore_no_auto_restore', 03:33:13 INFO - 'tabpaint']}, 03:33:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:13 INFO - 'ts_paint', 03:33:13 INFO - 'tpaint', 03:33:13 INFO - 'sessionrestore', 03:33:13 INFO - 'sessionrestore_no_auto_restore', 03:33:13 INFO - 'tabpaint']}, 03:33:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:13 INFO - 'ts_paint', 03:33:13 INFO - 'tpaint', 03:33:13 INFO - 'sessionrestore', 03:33:13 INFO - 'sessionrestore_no_auto_restore', 03:33:13 INFO - 'tabpaint']}, 03:33:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['a11yr', 03:33:13 INFO - 'ts_paint', 03:33:13 INFO - 'tpaint', 03:33:13 INFO - 'sessionrestore', 03:33:13 INFO - 'sessionrestore_no_auto_restore', 03:33:13 INFO - 'tabpaint']}, 03:33:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['a11yr', 03:33:13 INFO - 'ts_paint', 03:33:13 INFO - 'tpaint', 03:33:13 INFO - 'sessionrestore', 03:33:13 INFO - 'sessionrestore_no_auto_restore', 03:33:13 INFO - 'tabpaint']}, 03:33:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['tsvgx', 03:33:13 INFO - 'tsvgr_opacity', 03:33:13 INFO - 'tart', 03:33:13 INFO - 'tscrollx', 03:33:13 INFO - 'cart']}, 03:33:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:13 INFO - 'tsvgr_opacity', 03:33:13 INFO - 'tart', 03:33:13 INFO - 'tscrollx', 03:33:13 INFO - 'cart']}, 03:33:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'talos_options': ['--disable-e10s'], 03:33:13 INFO - 'tests': ['tp5o']}, 03:33:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'tests': ['tp5o']}, 03:33:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'talos_options': ['--disable-e10s', 03:33:13 INFO - '--xperf_path', 03:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:13 INFO - 'tests': ['tp5n']}, 03:33:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:13 INFO - 'talos_options': ['--xperf_path', 03:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:13 INFO - 'tests': ['tp5n']}}, 03:33:13 INFO - 'talos.zip': {'path': '', 03:33:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:13 INFO - Running post-action listener: _resource_record_post_action 03:33:13 INFO - [mozharness: 2016-10-13 10:33:13.808685Z] Finished populate-webroot step (success) 03:33:13 INFO - [mozharness: 2016-10-13 10:33:13.808777Z] Running create-virtualenv step. 03:33:13 INFO - Running pre-action listener: _resource_record_pre_action 03:33:13 INFO - Running main action method: create_virtualenv 03:33:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33: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 03:33:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:13 INFO - Using real prefix '/usr' 03:33:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:16 INFO - Installing pip.................done. 03:33:16 INFO - Return code: 0 03:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:16 INFO - Reading from file tmpfile_stdout 03:33:16 INFO - Output received: 03:33:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:33:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:16 INFO - Using env: {'DISPLAY': ':0', 03:33:16 INFO - 'HOME': '/home/cltbld', 03:33:16 INFO - 'LANG': 'en_US.UTF-8', 03:33:16 INFO - 'LANGUAGE': 'en_US:en', 03:33:16 INFO - 'LOGNAME': 'cltbld', 03:33:16 INFO - 'MAIL': '/var/mail/cltbld', 03:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:16 INFO - 'MOZ_NO_REMOTE': '1', 03:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:16 INFO - 'NO_EM_RESTART': '1', 03:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:16 INFO - 'PWD': '/builds/slave/test', 03:33:16 INFO - 'SHELL': '/bin/bash', 03:33:16 INFO - 'SHLVL': '1', 03:33:16 INFO - 'TERM': 'linux', 03:33:16 INFO - 'TMOUT': '86400', 03:33:16 INFO - 'USER': 'cltbld', 03:33:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:16 INFO - '_': '/tools/buildbot/bin/python'} 03:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33: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 03:33:16 INFO - Cleaning up... 03:33:16 INFO - Return code: 0 03:33:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:16 INFO - Using env: {'DISPLAY': ':0', 03:33:16 INFO - 'HOME': '/home/cltbld', 03:33:16 INFO - 'LANG': 'en_US.UTF-8', 03:33:16 INFO - 'LANGUAGE': 'en_US:en', 03:33:16 INFO - 'LOGNAME': 'cltbld', 03:33:16 INFO - 'MAIL': '/var/mail/cltbld', 03:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:16 INFO - 'MOZ_NO_REMOTE': '1', 03:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:16 INFO - 'NO_EM_RESTART': '1', 03:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:16 INFO - 'PWD': '/builds/slave/test', 03:33:16 INFO - 'SHELL': '/bin/bash', 03:33:16 INFO - 'SHLVL': '1', 03:33:16 INFO - 'TERM': 'linux', 03:33:16 INFO - 'TMOUT': '86400', 03:33:16 INFO - 'USER': 'cltbld', 03:33:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:16 INFO - '_': '/tools/buildbot/bin/python'} 03:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:17 INFO - Downloading/unpacking psutil>=3.1.1 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:19 INFO - Installing collected packages: psutil 03:33:19 INFO - Running setup.py install for psutil 03:33:19 INFO - building 'psutil._psutil_linux' extension 03:33:19 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 03:33:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:33:19 INFO - building 'psutil._psutil_posix' extension 03:33:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:33:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:33:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:19 INFO - Successfully installed psutil 03:33:19 INFO - Cleaning up... 03:33:19 INFO - Return code: 0 03:33:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:19 INFO - Using env: {'DISPLAY': ':0', 03:33:19 INFO - 'HOME': '/home/cltbld', 03:33:19 INFO - 'LANG': 'en_US.UTF-8', 03:33:19 INFO - 'LANGUAGE': 'en_US:en', 03:33:19 INFO - 'LOGNAME': 'cltbld', 03:33:19 INFO - 'MAIL': '/var/mail/cltbld', 03:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:19 INFO - 'MOZ_NO_REMOTE': '1', 03:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:19 INFO - 'NO_EM_RESTART': '1', 03:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:19 INFO - 'PWD': '/builds/slave/test', 03:33:19 INFO - 'SHELL': '/bin/bash', 03:33:19 INFO - 'SHLVL': '1', 03:33:19 INFO - 'TERM': 'linux', 03:33:19 INFO - 'TMOUT': '86400', 03:33:19 INFO - 'USER': 'cltbld', 03:33:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:19 INFO - '_': '/tools/buildbot/bin/python'} 03:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:21 INFO - Installing collected packages: mozsystemmonitor 03:33:21 INFO - Running setup.py install for mozsystemmonitor 03:33:21 INFO - Successfully installed mozsystemmonitor 03:33:21 INFO - Cleaning up... 03:33:21 INFO - Return code: 0 03:33:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:21 INFO - Using env: {'DISPLAY': ':0', 03:33:21 INFO - 'HOME': '/home/cltbld', 03:33:21 INFO - 'LANG': 'en_US.UTF-8', 03:33:21 INFO - 'LANGUAGE': 'en_US:en', 03:33:21 INFO - 'LOGNAME': 'cltbld', 03:33:21 INFO - 'MAIL': '/var/mail/cltbld', 03:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:21 INFO - 'MOZ_NO_REMOTE': '1', 03:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:21 INFO - 'NO_EM_RESTART': '1', 03:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:21 INFO - 'PWD': '/builds/slave/test', 03:33:21 INFO - 'SHELL': '/bin/bash', 03:33:21 INFO - 'SHLVL': '1', 03:33:21 INFO - 'TERM': 'linux', 03:33:21 INFO - 'TMOUT': '86400', 03:33:21 INFO - 'USER': 'cltbld', 03:33:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:21 INFO - '_': '/tools/buildbot/bin/python'} 03:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:22 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:24 INFO - warning: no files found matching '*.txt' 03:33:24 INFO - no previously-included directories found matching 'build' 03:33:24 INFO - no previously-included directories found matching 'dist' 03:33:24 INFO - no previously-included directories found matching '.git*' 03:33:24 INFO - Installing collected packages: jsonschema, functools32 03:33:24 INFO - Running setup.py install for functools32 03:33:24 INFO - warning: no files found matching '*.txt' 03:33:24 INFO - no previously-included directories found matching 'build' 03:33:24 INFO - no previously-included directories found matching 'dist' 03:33:24 INFO - no previously-included directories found matching '.git*' 03:33:24 INFO - Successfully installed jsonschema functools32 03:33:24 INFO - Cleaning up... 03:33:24 INFO - Return code: 0 03:33:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:24 INFO - Using env: {'DISPLAY': ':0', 03:33:24 INFO - 'HOME': '/home/cltbld', 03:33:24 INFO - 'LANG': 'en_US.UTF-8', 03:33:24 INFO - 'LANGUAGE': 'en_US:en', 03:33:24 INFO - 'LOGNAME': 'cltbld', 03:33:24 INFO - 'MAIL': '/var/mail/cltbld', 03:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:24 INFO - 'MOZ_NO_REMOTE': '1', 03:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:24 INFO - 'NO_EM_RESTART': '1', 03:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:24 INFO - 'PWD': '/builds/slave/test', 03:33:24 INFO - 'SHELL': '/bin/bash', 03:33:24 INFO - 'SHLVL': '1', 03:33:24 INFO - 'TERM': 'linux', 03:33:24 INFO - 'TMOUT': '86400', 03:33:24 INFO - 'USER': 'cltbld', 03:33:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:24 INFO - '_': '/tools/buildbot/bin/python'} 03:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:24 INFO - Cleaning up... 03:33:25 INFO - Return code: 0 03:33:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:25 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')]} 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:25 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')]} 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:25 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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33:25 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 03:33:25 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 03:33:25 INFO - Using env: {'DISPLAY': ':0', 03:33:25 INFO - 'HOME': '/home/cltbld', 03:33:25 INFO - 'LANG': 'en_US.UTF-8', 03:33:25 INFO - 'LANGUAGE': 'en_US:en', 03:33:25 INFO - 'LOGNAME': 'cltbld', 03:33:25 INFO - 'MAIL': '/var/mail/cltbld', 03:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:25 INFO - 'MOZ_NO_REMOTE': '1', 03:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:25 INFO - 'NO_EM_RESTART': '1', 03:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:25 INFO - 'PWD': '/builds/slave/test', 03:33:25 INFO - 'SHELL': '/bin/bash', 03:33:25 INFO - 'SHLVL': '1', 03:33:25 INFO - 'TERM': 'linux', 03:33:25 INFO - 'TMOUT': '86400', 03:33:25 INFO - 'USER': 'cltbld', 03:33:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:25 INFO - '_': '/tools/buildbot/bin/python'} 03:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:27 INFO - Downloading docopt-0.6.1.tar.gz 03:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:27 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:27 INFO - Running setup.py install for blobuploader 03:33:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:28 INFO - Running setup.py install for requests 03:33:28 INFO - Running setup.py install for docopt 03:33:28 INFO - Successfully installed blobuploader requests docopt 03:33:28 INFO - Cleaning up... 03:33:28 INFO - Return code: 0 03:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:28 INFO - Using env: {'DISPLAY': ':0', 03:33:28 INFO - 'HOME': '/home/cltbld', 03:33:28 INFO - 'LANG': 'en_US.UTF-8', 03:33:28 INFO - 'LANGUAGE': 'en_US:en', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MAIL': '/var/mail/cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SHLVL': '1', 03:33:28 INFO - 'TERM': 'linux', 03:33:28 INFO - 'TMOUT': '86400', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - '_': '/tools/buildbot/bin/python'} 03:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:28 INFO - Running setup.py (path:/tmp/pip-fB96wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:28 INFO - Running setup.py (path:/tmp/pip-u7klpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:28 INFO - Running setup.py (path:/tmp/pip-aLH_C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:28 INFO - Running setup.py (path:/tmp/pip-9p05rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:29 INFO - Running setup.py (path:/tmp/pip-YZwJ6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:29 INFO - Running setup.py (path:/tmp/pip-E6DRW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:29 INFO - Running setup.py (path:/tmp/pip-4w2zaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:29 INFO - Running setup.py (path:/tmp/pip-swwYh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:29 INFO - Running setup.py (path:/tmp/pip-RgizLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:29 INFO - Running setup.py (path:/tmp/pip-PsOUzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:29 INFO - Running setup.py (path:/tmp/pip-3Tprva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:29 INFO - Running setup.py (path:/tmp/pip-OLz1MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:29 INFO - Running setup.py (path:/tmp/pip-PPSyTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:29 INFO - Running setup.py (path:/tmp/pip-DlGcFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:29 INFO - Running setup.py (path:/tmp/pip-gZ9AUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:29 INFO - Running setup.py (path:/tmp/pip-6x8C6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:29 INFO - Running setup.py (path:/tmp/pip-_4ASw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:29 INFO - Running setup.py install for manifestparser 03:33:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Running setup.py install for mozcrash 03:33:30 INFO - Running setup.py install for mozdebug 03:33:30 INFO - Running setup.py install for mozdevice 03:33:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Running setup.py install for mozfile 03:33:30 INFO - Running setup.py install for mozhttpd 03:33:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Running setup.py install for mozinfo 03:33:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Running setup.py install for mozInstall 03:33:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:30 INFO - Running setup.py install for mozleak 03:33:30 INFO - Running setup.py install for mozlog 03:33:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Running setup.py install for moznetwork 03:33:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Running setup.py install for mozprocess 03:33:31 INFO - Running setup.py install for mozprofile 03:33:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Running setup.py install for mozrunner 03:33:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Running setup.py install for mozscreenshot 03:33:31 INFO - Running setup.py install for moztest 03:33:31 INFO - Running setup.py install for mozversion 03:33:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:31 INFO - Cleaning up... 03:33:31 INFO - Return code: 0 03:33:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:32 INFO - Running setup.py (path:/tmp/pip-0dhR8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:32 INFO - Running setup.py (path:/tmp/pip-6RjBdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:32 INFO - Running setup.py (path:/tmp/pip-ceqepM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:32 INFO - Running setup.py (path:/tmp/pip-gBCpuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:32 INFO - Running setup.py (path:/tmp/pip-L1DqRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:32 INFO - Running setup.py (path:/tmp/pip-uliq2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:32 INFO - Running setup.py (path:/tmp/pip-MNVsi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:32 INFO - Running setup.py (path:/tmp/pip-C4esPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:32 INFO - Running setup.py (path:/tmp/pip-lc8oy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:32 INFO - Running setup.py (path:/tmp/pip-miiCC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:32 INFO - Running setup.py (path:/tmp/pip-1vBHQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:32 INFO - Running setup.py (path:/tmp/pip-FZDEPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:32 INFO - Running setup.py (path:/tmp/pip-8R6aZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33: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)) 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:32 INFO - Running setup.py (path:/tmp/pip-wyKtMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:33 INFO - Running setup.py (path:/tmp/pip-Mjgdth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:33 INFO - Running setup.py (path:/tmp/pip-USnWJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:33 INFO - Running setup.py (path:/tmp/pip-2_JJjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:35 INFO - Downloading blessings-1.6.tar.gz 03:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:35 INFO - Installing collected packages: blessings 03:33:35 INFO - Running setup.py install for blessings 03:33:35 INFO - Successfully installed blessings 03:33:35 INFO - Cleaning up... 03:33:35 INFO - Return code: 0 03:33:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:35 INFO - Reading from file tmpfile_stdout 03:33:35 INFO - Current package versions: 03:33:35 INFO - argparse == 1.2.1 03:33:35 INFO - blessings == 1.6 03:33:35 INFO - blobuploader == 1.2.4 03:33:35 INFO - docopt == 0.6.1 03:33:35 INFO - functools32 == 3.2.3-2 03:33:35 INFO - jsonschema == 2.5.1 03:33:35 INFO - manifestparser == 1.1 03:33:35 INFO - mozInstall == 1.12 03:33:35 INFO - mozcrash == 0.17 03:33:35 INFO - mozdebug == 0.1 03:33:35 INFO - mozdevice == 0.48 03:33:35 INFO - mozfile == 1.2 03:33:35 INFO - mozhttpd == 0.7 03:33:35 INFO - mozinfo == 0.9 03:33:35 INFO - mozleak == 0.1 03:33:35 INFO - mozlog == 3.4 03:33:35 INFO - moznetwork == 0.27 03:33:35 INFO - mozprocess == 0.23 03:33:35 INFO - mozprofile == 0.28 03:33:35 INFO - mozrunner == 6.12 03:33:35 INFO - mozscreenshot == 0.1 03:33:35 INFO - mozsystemmonitor == 0.3 03:33:35 INFO - moztest == 0.7 03:33:35 INFO - mozversion == 1.4 03:33:35 INFO - psutil == 3.1.1 03:33:35 INFO - requests == 1.2.3 03:33:35 INFO - wsgiref == 0.1.2 03:33:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33: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)) 03:33:35 INFO - Cleaning up... 03:33:35 INFO - Return code: 0 03:33:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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 0x7fa08b4faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', '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 03:33: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 03:33: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 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:36 INFO - Cleaning up... 03:33:36 INFO - Return code: 0 03:33:36 INFO - Running post-action listener: _resource_record_post_action 03:33:36 INFO - Running post-action listener: _start_resource_monitoring 03:33:36 INFO - Starting resource monitoring. 03:33:36 INFO - [mozharness: 2016-10-13 10:33:36.121924Z] Finished create-virtualenv step (success) 03:33:36 INFO - [mozharness: 2016-10-13 10:33:36.122386Z] Running install step. 03:33:36 INFO - Running pre-action listener: _resource_record_pre_action 03:33:36 INFO - Running main action method: install 03:33:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:36 INFO - Reading from file tmpfile_stdout 03:33:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:36 INFO - Reading from file tmpfile_stdout 03:33:36 INFO - Output received: 03:33:36 INFO - Usage: mozinstall [options] installer 03:33:36 INFO - Options: 03:33:36 INFO - -h, --help show this help message and exit 03:33:36 INFO - -d DEST, --destination=DEST 03:33:36 INFO - Directory to install application into. [default: 03:33:36 INFO - "/builds/slave/test"] 03:33:36 INFO - --app=APP Application being installed. [default: firefox] 03:33:36 INFO - mkdir: /builds/slave/test/build/application 03:33:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:52 INFO - Reading from file tmpfile_stdout 03:33:52 INFO - Output received: 03:33:52 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:52 INFO - Running post-action listener: _resource_record_post_action 03:33:52 INFO - [mozharness: 2016-10-13 10:33:52.595763Z] Finished install step (success) 03:33:52 INFO - [mozharness: 2016-10-13 10:33:52.596007Z] Running run-tests step. 03:33:52 INFO - Running pre-action listener: _resource_record_pre_action 03:33:52 INFO - Running main action method: run_tests 03:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:52 INFO - Python 2.7.3 03:33:52 INFO - Return code: 0 03:33:52 INFO - grabbing minidump binary from tooltool 03:33: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')]} 03:33: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 0x29d1f60>, '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 0x29d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33: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 03:33: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 03:33: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 03:33:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:52 INFO - Return code: 0 03:33:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:33:52 INFO - Using env: {'DISPLAY': ':0', 03:33:52 INFO - 'HOME': '/home/cltbld', 03:33:52 INFO - 'LANG': 'en_US.UTF-8', 03:33:52 INFO - 'LANGUAGE': 'en_US:en', 03:33:52 INFO - 'LOGNAME': 'cltbld', 03:33:52 INFO - 'MAIL': '/var/mail/cltbld', 03:33:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:52 INFO - 'MOZ_NO_REMOTE': '1', 03:33:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:52 INFO - 'NO_EM_RESTART': '1', 03:33:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:52 INFO - 'PWD': '/builds/slave/test', 03:33:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:52 INFO - 'SHELL': '/bin/bash', 03:33:52 INFO - 'SHLVL': '1', 03:33:52 INFO - 'TERM': 'linux', 03:33:52 INFO - 'TMOUT': '86400', 03:33:52 INFO - 'USER': 'cltbld', 03:33:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341', 03:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:52 INFO - '_': '/tools/buildbot/bin/python'} 03:33:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:33:52 INFO - mozversion application_buildid: 20161013023623 03:33:52 INFO - mozversion application_changeset: 536613038a4770545077bfd557b27aed5991c9a2 03:33:52 INFO - mozversion application_display_name: Nightly 03:33:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:52 INFO - mozversion application_name: Firefox 03:33:52 INFO - mozversion application_remotingname: firefox 03:33:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:33:52 INFO - mozversion application_vendor: Mozilla 03:33:52 INFO - mozversion application_version: 52.0a1 03:33:52 INFO - mozversion platform_buildid: 20161013023623 03:33:52 INFO - mozversion platform_changeset: 536613038a4770545077bfd557b27aed5991c9a2 03:33:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:33:52 INFO - mozversion platform_version: 52.0a1 03:33:52 INFO - using testdate: 1476354832 03:33:52 INFO - actual date: 1476354832 03:33:52 INFO - starting webserver on 'localhost:36957' 03:33:52 INFO - SUITE-START | Running 2 tests 03:33:52 INFO - TEST-START | dromaeo_css 03:33:52 INFO - operating with platform_type : linux_ 03:33:52 INFO - Initialising browser for dromaeo_css test... 03:33:52 INFO - TEST-INFO | started process 22723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbClwCS/profile http://localhost:36957/getInfo.html) 03:33:57 INFO - PROCESS | 22723 | __metrics Screen width/height:1600/1200 03:33:57 INFO - PROCESS | 22723 | colorDepth:24 03:33:57 INFO - PROCESS | 22723 | Browser inner width/height: 1024/697 03:33:57 INFO - PROCESS | 22723 | __metrics 03:33:58 INFO - PROCESS | 22723 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:33:58 INFO - PROCESS | 22723 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:33:59 INFO - TEST-INFO | 22723: exit 0 03:33:59 INFO - Browser initialized. 03:33:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:59 INFO - TEST-INFO | started process 22804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbClwCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:11 INFO - PROCESS | 22804 | RSS: Main: 175341568 03:34:11 INFO - PROCESS | 22804 | 03:35:02 INFO - PROCESS | 22804 | 1476354902665 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:37:16 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36957/tests/dromaeo/cssquery-ext.html) 03:37:19 INFO - PROCESS | 22804 | RSS: Main: 387334144 03:37:19 INFO - PROCESS | 22804 | 03:40:22 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-ext.html (next: http://localhost:36957/tests/dromaeo/cssquery-jquery.html) 03:40:22 INFO - PROCESS | 22804 | RSS: Main: 284884992 03:40:22 INFO - PROCESS | 22804 | 03:43:25 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36957/tests/dromaeo/cssquery-mootools.html) 03:43:25 INFO - PROCESS | 22804 | RSS: Main: 249675776 03:43:25 INFO - PROCESS | 22804 | 03:46:27 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36957/tests/dromaeo/cssquery-prototype.html) 03:46:28 INFO - PROCESS | 22804 | RSS: Main: 254857216 03:46:28 INFO - PROCESS | 22804 | 03:49:31 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36957/tests/dromaeo/cssquery-yui.html) 03:49:32 INFO - PROCESS | 22804 | RSS: Main: 219676672 03:49:32 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:36957/tests/dromaeo/cssquery-yui.html (next: http://localhost:36957/tests/dromaeo/cssquery-dojo.html) 03:52:35 INFO - PROCESS | 22804 | RSS: Main: 311750656 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | __start_tp_report 03:52:35 INFO - PROCESS | 22804 | _x_x_mozilla_page_load 03:52:35 INFO - PROCESS | 22804 | _x_x_mozilla_page_load_details 03:52:35 INFO - PROCESS | 22804 | |i|pagename|runs| 03:52:35 INFO - PROCESS | 22804 | |0;dojo.html;2596.740325967403;2609.7129315775273;2649.8807553660085;2654.177205066429;2660.694020187679;4575.290829921368;4647.883802904929;4679.953200467994;4683.203855344591;4711.128441238369;4680.321353403754;4690.507496712848;4698.201305778018;4729.597984171341;4782.0196859643775;4320.3735458358515;4403.493598236212;4446.622037126832;4450.5104438511735;4475.731456112628;4393;4482.686211965164;4486.327050942352;4486.955130448687;4502.234620114588;4153.979230103861;4420.778961051967;4434.84478043267;4455.198064348416;4520.960179158796;4175.331946888514;4243.066525364415;4321.935170972438;4373.190959672471;4390.363397307373;4333.696641235115;4334.523202447728;4338.1540599583095;4385.342198670193;4403.0533435311245;4718.0328032753205;4733.077049975256;4761.381020467352;4771.33201351811;4782.450018247911;4849.393825771778;4894.2658601210105;4896.902061958741;5032.0690672225755;5080.288759573663;5102.6428150029515;5113.744312784346;5124.4106927703415;5165.302684137669;5178.430372659004;4780.880477988043;4781.282807578891;4786.664933454625;4789.257665061921;4850.684705494132;4945.604351651859;5004.9499505005215;5236.24074509194;5237.580993520509;5303.840884773463;4815.085133824562;4852.927206091911;4857.101436234308;4858.80564777412;4862.732549709729;4945.159322915113;4946.332245146931;4947.6536642434685;4949.208126699711;4950.554450099508;4866.926996095061;4902.313676085351;4907.386576677915;4911.803527858917;4930.679505832181;4934.8026078957155;4965.528274813887;4969.304297398367;5026.447090820006;5029;4173.97913010433;4178.6657067434535;4179.832806687759;4229.175310814362;4229.323308270662;3671.94492082619;3679.5584529856055;3684.5578530575967;3694.094946738013;3761.586225515191;4435.600795928382;4439.489458712224;4441.133978874153;4442.111577684476;4447.3773671685985;5060.645754797129;5095.184770436712;5098.821541246039;5099.898002039939;5101.260317254051;4362.040351122748;4369.104333611602;4434.246178149722;4448.644108471314;4484.551544845489;4599.862004139881;4603.309503574424;4607.470140933769;4633.189191891405;4656.138614356355;4902.2156454967035;4905.828296009765;4906.681065730788;4910.042541704333;4954.504549545017;4939.703617782944;4971.602271818174;4978.576820970258;5177.948220517746;5232.319798426181;4788.497207793271;4790.5448982346625;4799.1601469743355;4800.183968725255;4803.759812009315;4927.211646136601;4966.528179822911;4968.950310496849;4969.751512424436;4974.801007959786;5043.36957880265;5050.065737838511;5050.77271522775;5054.595632349477;5058.721770302669;4814.133455977958;4908.779104940358;4919.114559379346;4920.5571498565305;4922.4339200992345;4949.82675606352;5000.574951129195;5031.6226283029655;5082.567981721595;5085.644004919768;4948.2824990375475;4950;4961.801527938842;4964.851054468371;5021.72380519075;5008.949910500848;5039.949600503948;5056.570191533614;5057.620678449204;5119.846404607868;4708.529147085264;4750.904981900412;4760.143174228534;4844.975775121243;4862.805487780449 03:52:35 INFO - PROCESS | 22804 | |1;ext.html;534.716600201893;538.9326334208224;548.1667864845434;555.9110542313231;558.4582954534101;39063.80468097659;40866;40987.79506102469;43739.34390984138;43956.560434395644;40792.38811417831;41228;41240.38139427911;41262.58737412625;41272.17455650885;7737.187595302496;7888.053433587977;7896.763097107096;7899.170587088331;7899.605019748989;7755.6509957051785;7839.96080019602;7843.078445780763;7849.764507064769;7850.528968261894;7867.921320786776;7888.7633370998965;7902.762917112495;7907.130215676271;7909.288164065233;7817.687292508293;7842.451028427984;7853.450258481908;7854.3716502679645;7854.410919181084;7672.194419585919;7744.419168562324;7745.7676269712;7746.728864489773;7751.573663448508;36362.45456318157;36746.44880326797;36759.26481470383;36762;36808.44787328192;3198.4562624353916;3199.936001279985;3216.742660587171;3538.150843797496;3632.164602141496;27985.440291194267;28603.427931441256;28842.855785721145;28991.855040724873;29786.851065744748;3480.6519348065244;3537.327907697555;3571.964280357189;3600.2840499967533;3635.0367152704553;175051.12474437675;176280;176394;243530.7823460889;244041;51795.741021295406;52164.47835521672;52178.47821521812;55699.44300557024;57403.71298143566;51994;52305.73847130816;52875.47124528782;52882;52888;15158.090514569161;15370.538883833502;15377.538673839803;15381.230938453033;15384.923075384775;11516.30902145874;11669.299842009506;11691;11698.47356868943;11698.649040528799;18473.7228941566;18587.535311617317;18665.520275134142;18738.1567829448;18797.718034229496;6953.235144134142;7195.208527062019;7282.817929551804;7327.670254838545;7332.230115837867;795.6379847169524;878.3719640457103;904.041715781274;951.509972364233;977.973128215371;27628.30929226745;27717.445651086866;28009.159725208276;28294;28454.857725711652;944.9811003780023;960.9471479068718;1003.1773945364731;1029.6756521695643;1058.878229003659;14570.125792452487;14911.776323355158;15007.849921500863;15203.820416473292;15298.923505382625;376442;377298;378004;378277;379400;48449.273260901115;48913.755431223326;48918.266226006635;48959.510404895496;49032.50967490351;1063.7181146996052;1114.7436089699252;1177.8468799056238;1222.205566381859;1226.1355744200318;26769.330766730207;29538;30214.244643884078;31903;32292.35415291728;48223.75888120677;48848.267275990176;48922.75538622284;48953.755231223615;49027.50972490372;340413;343142;343833;344015;344170;38478.6152138475;38522.56990446022;38633.32983366575;39211.6078839208;39241.411378829915;37915.62084379121;40793.79603101966;41627.1674566513;42301.67340796286;43437.782811085744;35760.28479430449;35853.462198066525;36094.639053610175;36466.27067458689;36524.452133218554;35774.284514310086;35807.28385432329;35991.820040900675;36365.81817090898;36701.44947825838;30466.543001854545;31252;32076.19809504781;35593;36339.63660363468;26172.8691356542;32964.50553241751;33012.66987330192;33022.83488582542;33175.83412082924;24403.38991525226;25135.74864251334;25159;25552.361190970376;25557 03:52:35 INFO - PROCESS | 22804 | |2;jquery.html;357.95704515458135;371.99256014879705;373.30565148823194;383.73330535277995;384.93648547989585;15431.768523472158;16639.916800415995;17356.351146641064;17442.91278543609;17462;16400.67198656026;17030.148492575383;17168.742468862976;17288.82711172888;17297.308107675708;4853.563179313861;5109.770060347293;5111.591072714193;5113.565346945496;5118.07874582575;3691.169486865461;3877.4377715231417;4980.078685443186;5579.13523403873;5854.356020837705;5935.436133567326;5939.406059394069;5956.195913551658;5964.2246507953905;5967.462928336449;5706.800261990831;5918.082697181922;5935.6438613682885;5943.940560594382;5946.048632218824;5091.592672586185;5208.322918020671;5245.31810864589;5252.3171987641745;5253.6322457428;20378.286759963477;20598.794012059836;20751.68872466914;20818.58362832735;20892.477688057766;1910.035432106777;1927.094265695121;1930.806919308072;1934.7388102606108;2042.6323261812868;12895.742085158337;13153.671158221025;13219.405126769318;13760.93119534396;14023.088499247517;1646.958826029347;1662.185529090749;1677.4883660483547;1704.4971733338696;1761.445144779403;72930;76895.99999999945;77681.61159194224;77784.61107694426;78032.21967780306;9708.854367184498;9714.562844672007;10132.946821271404;10245;10273.845892311621;13968.58094257174;13993.30033498321;13994.580162595139;13995;14001.5099471518;7247.891281630779;7305.853882922312;7341.632918354061;7500.137484189279;7596.392288617008;7050.682719277543;7060.293970603001;7167.319104685047;7258.49190556656;7282.162551306562;4292.248856450109;4349.217140914602;4358.869233922987;4472.284434490466;4476.440444944382;1613.790207273047;1687.9493615191564;1718.269735362491;1780.7863056433312;1885.886846789197;785.8918924316686;823.3454403749034;848.3806821020689;861.4874149880811;889.2796834564024;16172.191390430431;16568.83431165697;16612.335506579602;16639.41762038323;16963.74554381685;826.8139668574643;855.7133360324236;859.2352806002663;900.7703035725848;933.4306073295285;9239.260859131253;9274.237894799966;9938.217299156247;10227.181825453947;10244.334118282288;291586;296025;298085;396727;398617;78095.60952195202;81197.59401202956;81654;82396.58801706073;84436.57781711176;899.6716198587468;907.1019690506483;937.0208132501552;946.990530094704;947.1759569174724;15632.609184770472;15715.685686286439;16320.347186112898;16395.83604163943;16655.333786648884;25071.87464062668;35405;36071.81964090163;36815.63184368122;36987.81506092452;50976.49023509866;51897.48102518926;52241.7387913058;52618.47381526136;52795;7372.410207183305;7378.741744038933;7458.403327733877;7461.179270280156;7751;8312.584370781316;11580.88419115798;11610.187286890174;11673.474693638636;11835.11236657237;9369.156775890202;9605.279604029585;9641;9928.106470417697;10264.538095785856;9915.107640312406;9987.800243994934;10168.33905796121;10181.134603558781;10287.331323463952;10130.544125514221;10170.440625765654;10250.564920910929;10769.892301076889;10920.235583509078;7524.322810947041;7532.887006694795;7695.345895598937;7788.688452461838;7882.330001949669;9578.616855325708;9741.366811157252;10004.799904002024;10304;10340.431276279876 03:52:35 INFO - PROCESS | 22804 | |3;mootools.html;1390.0408717984592;1416.6741649420633;1494.7085318362917;1594.1152660273558;1637.4350848957113;6774.729010839561;7003.264657210996;7610.505317154381;8136.71521496747;8179.141190175028;7460.477766556343;7739.071311442634;7739.651715672794;7921.960390198041;7935.404844636647;2174.076017692478;2191.441182498461;2208.9226877059305;2213.1700612270397;2214.324630987548;1794.8564114870844;1853.5644123631002;2171.6959625652344;2188.5513469738744;2253.1663284584724;2121.596896589643;2189.3650841256094;2190.9342719718434;2203.327984964585;2203.713517242756;2169.349195241421;2184.1154332495366;2189.9233526826565;2204.261572373257;2206.5255969966533;2125.7555381131215;2126.138913739938;2132.264368792764;2132.9573408531896;2141.6038032963797;7696.538207707556;7746.651400686983;7760.573168475732;7764.340031097364;7772.028496437945;4610.400647915783;4681.765911704401;4739;4745.264484004984;4749.4775574686755;2963.06663401028;3031.4694928387444;3070.9078727638207;3097.0708787363924;3103.053568661557;961.697065424389;981.8085473332703;986.5842515989506;995.3381001633904;1003.7189586915675;10800.891991080067;10804.405757683324;10883.23817332787;10894.836577451266;10895.509702063426;4072.7963601819793;4403.3174857897075;4430.136123455895;4430.357598148251;4439.600435960779;9305.209057230077;9315.580798864068;9318.207952323994;9321.627134914663;9322;4769.046190761862;4769.236922092448;4769.332293478916;4797.808087676453;4809.519048095232;4241.554636763157;4261.97869010653;4304.5910638489295;4349.760763157993;4367.213901497761;3677.7609455385314;3703.5370578677666;3777.0934975606206;3813.961860381416;3823.1780167263614;1126.3467189030343;1171.7949358862336;1220.7741567809983;1224.2837939805313;1272.3256673962815;629.5026928726346;798.5129071266523;826.2274773087182;840.8948881389827;862.7584276402617;5192.584593232532;5386.13821788512;5520.420355862657;5535.750891209906;5537.612367134342;827.594478705442;857.2113655437013;873.3799002708148;873.4977388001797;879.824035192964;3674.210044840372;3794.3359912015285;3794.4498047782918;3794.715396345285;3849.9210426370005;9260.629574816932;9744.17174540172;9773.755656108655;9778.75553111178;9781.951090244504;9667;9679.854802177973;9683.757906052406;9699;9722.61109555624;7167.713291468387;7363.705451781869;7412.51818631798;7413.518121322205;7427.665755041036;5308.628396012242;5350.545203657733;5396.109641909041;5433.8369848904595;5685.744141513725;9004.864927025968;9028.774280643036;9093.863592046257;9128.178463938277;9173.908260917306;9049.140331668481;9105.135012173832;9141.954290228507;9244.214241789254;9245.907540924505;6778.796636100925;6934.341237582422;6935.687894044881;6940.652967351713;6944.861102778017;7414.851702966019;7469.7385591504035;7557.735479258199;7565.924340756522;7567.167611562613;6829.52193346461;6874.8625027500175;6977.476689248429;6978.953157026486;7065.540739851893;6644.568103073285;6718.563293385914;6801.8639627206185;6840.965795170992;6973.058637084132;6343.826392117473;6422.2614399344675;6460.224773027267;6464.353564643498;6484;4494.528074552125;4532.229520981376;4585.495595484427;4587.6788624795945;4654.2785868190485;4753.120672675566;4760.547747963938;4873.269009648581;4904.239842824368;5008.348914641073 03:52:35 INFO - PROCESS | 22804 | |4;prototype.html;302.96818834022423;303.12548298159817;308.47867104593234;310.4814959018439;313.6346156727413;4734.295653564718;4810.182269014267;4829.154897892863;4846.151923413402;4849.709017458955;4468;4554.066416384641;4609.884752881179;4714.646401519891;4734.597559207463;3795.4876091727538;3800.581935987046;3800.961990380102;3802.372608519591;3808.9428658570146;3791.488149099878;3793.905152371199;3794.203217324365;3794.924101517968;3807.3337165995977;3491.720662347019;3578.1949061461223;3672.8347224374966;3703.5926647678953;3781.9432708509394;3747.5315585551807;3754.8498060077563;3767.9811600942094;3769.3780526213277;3770.811459427045;3366.8653253869816;3390.440577304742;3391.6269210386836;3392.5759280089987;3395.643457436958;4462.107578484316;4606.282293446882;4701.318308845232;4702.131699663203;4704.835775543254;4271.295236286009;4272.87181384559;4278.2940814765525;4282.486101667789;4299.592228352101;4948.653594248404;4961.330220420233;4970.527799859007;4979.4355906707715;5026.095302845486;3654.4152935530456;3660.8535658573624;3675.8345874435713;3684.6868016218655;3699.8150092495266;4963.220596465991;5155.845324640267;5157.252198431206;5165.999999999963;5182.792688292464;3707.8331475083687;3745.6067112952746;3750.643688849555;3753.3806921857586;3765.6987441004653;3784.3377408953324;3787.299349620329;3794.6205379461835;3821.216650586623;3835.8082095895093;3994.540627827837;4184.970289409634;4309.827606895689;4311.547287534827;4317.784110794448;4914.582260507826;4937.703737775745;4940.752962351868;4949.282354058641;4977.626677999092;1259.4836117191908;1277.6486466221863;1279.3667134768164;1279.5457612547411;1287.362755436065;794.7178751543119;824.698984870518;835.3108685334623;841.8905542279465;846.5851732650957;4164.500259968762;4314.41755363022;4337.937205384701;4426.15902978433;4469.5306992765945;5065.645404821627;5082.796688132507;5083.161278389024;5087.64386492942;5101.413337466165;4348.195583817004;4428.269335559661;4444.688871779009;4450.329802118703;4481.1933851906315;2675.879585418661;2693.4108875763004;2715.131158029451;2716.7690746286785;2717.1033558925506;4839.879003024882;4852.0295940811975;4857.417109946829;4883.316335713003;4895.485973972753;5084.339035925306;5177.508136727005;5210.21846722987;5267.157254839208;5275.973620131952;4879.268109783561;4889.926651100308;4894.632902532324;4900.166971614834;4901.191303434894;5134.922976155435;5174.14626586609;5187.19598462239;5222.634415590872;5225.425203227566;4865.878353041202;5023.673461225008;5030.773615187252;5086.109930762176;5090.389153301479;4867.975660121677;4877.707337559757;4887.437944636412;4894;4897.632677549127;3659.9817000914827;3683.9079023024638;3687.778733276012;3693.7045036396485;3707.0917625182;4919.409670839379;5163.302954101148;5177;5183.170692689302;5219.425863154974;4982.227754698028;4984.277279794482;4991.575716064175;4996.375453068366;5018.197088465828;4977.352944117387;4998.625103117208;5015.799368025384;5018.723970181675;5022.547970682656;4832.903341933212;4914.70511769295;4923.975380123076;4984.975075124601;4988.600911927109;4779.641526885428;4905.313256144214;4914.729689867092;5034.899302013866;5058.215976523645;4876.975615121902;4882.4385195701525;4890.339804126397;4893.412790465025;4909.975450122726 03:52:35 INFO - PROCESS | 22804 | |5;yui.html;625.7934881489109;644.871025794841;664.3099716005001;679.3104998426597;696.6168607266003;13204.273764942924;13500.189988600667;13929.721405571896;13931.164130152185;14109.78835317471;14562.344694488747;14590.854091459083;14602;14626.707465850677;14667.706645867103;758.9051368578914;776.3556248313914;777.0325944199479;777.2732495117056;777.4324742937658;621.6549814852755;632.3170975346615;637.1175921348942;638.6998110887898;773.5165521549031;665.0523004718282;774.0711146624045;798.6525861250345;802.9437939344219;804.0030362350673;797.7327595255567;798.1659166171336;802.0535767794;802.3220378779922;802.7712102050888;577.1602318626431;577.2438106081047;577.5725962787549;577.6043410263941;577.8353169346758;10024.94987525065;10374.792504149875;12640.304783236918;13103.06907927618;13150.145240559334;11704;12277.263364198177;12607.495700171981;13052.412641431158;14002.299885005708;9888.25838062141;10140.290179687425;10178.083972442515;10265.486725663686;10317.638882639147;3132.8120312781307;3142.528620706912;3214.67853214679;3216.179874132105;3288.227266592373;65843;65926.67036664834;66329.66835165794;67063.66468167676;67244;9811.705648830546;9900.108990190918;9919.603215871428;9994.500274986221;10215.233857460571;18936.71594926077;19147.521311967314;19152;19157.425277241706;19166.137523811463;6157.907631385533;6244.500439964792;6308.810735677937;6459;6521.9673901630185;3534.2048039190977;3619.366610843092;3658.908527286786;3661.7253705972157;3681.37416639172;2873.252954231915;2961.0524632117517;2963.1851240908923;2965.7627389808763;2970.3465237647683;493.9975300123476;497.30625777040825;502.9396472423259;508.3213909430951;510.49971028392383;517.9119549676489;552.7871769368822;558.511302610216;588.8840646974046;620.3083561828619;7965.641546130438;8067.273945344829;8153.429259951747;8211.260986511243;8488.108748581433;575.829124201757;583.4836169989505;595.1935127901718;613.2426453330133;623.7473823101651;3996.4005399190355;4052.756834589934;4113.85601503946;4117.855875044359;4185.644220241314;73460.63269683617;100912.49543752382;101610.49194753979;103592.48203758933;105374;24299.757002430102;24890.253292401256;30321;85664;87362.57418119404;70914.64542677357;77571;78075.21924780794;78137.60931195307;78431;7512.549247044976;7920.5247685139075;7953.403494738033;8068.515889046676;8104.149064348394;45701.54298457106;46716;47809.321420910484;48221;48535.75732121317;62953.68523157355;67839.66080169567;68617;68768;70659.64670176616;10369.792604148026;10424;10462.215333850145;10531.78832445195;10674.679759607225;11253.831192532283;11271.661850144508;11862.644120676394;11874.940625296818;12127.818082728943;10474.842877356694;11309.434528273718;11309.71725706864;11429.657110286706;11796.941015295211;10548.156147508334;11030.393328367018;11197.496112674786;11369.943150284196;11475;9355.4386736796;9486.525673716149;9811.55847986828;10117.140043096419;10422.843657345298;8328.6668533258;8529.14708529142;8723.563821808757;8785.604647790993;9135.31485138604;8610.311175105851;8754.422616005442;9111.681091161778;9159.450432974043;9169.954150229207 03:52:35 INFO - PROCESS | 22804 | __end_tp_report 03:52:35 INFO - PROCESS | 22804 | __start_cc_report 03:52:35 INFO - PROCESS | 22804 | _x_x_mozilla_cycle_collect,2422 03:52:35 INFO - PROCESS | 22804 | __end_cc_report 03:52:35 INFO - PROCESS | 22804 | __startTimestamp1476355955619__endTimestamp 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | ------- Summary: start ------- 03:52:35 INFO - PROCESS | 22804 | Number of tests: 6 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | [#0] dojo.html Cycles:165 Average:4679.35 Median:4814.13 stddev:488.03 (10.1%) stddev-sans-first:461.37 03:52:35 INFO - PROCESS | 22804 | Values: 2596.7 2609.7 2649.9 2654.2 2660.7 4575.3 4647.9 4680.0 4683.2 4711.1 4680.3 4690.5 4698.2 4729.6 4782.0 4320.4 4403.5 4446.6 4450.5 4475.7 4393.0 4482.7 4486.3 4487.0 4502.2 4154.0 4420.8 4434.8 4455.2 4521.0 4175.3 4243.1 4321.9 4373.2 4390.4 4333.7 4334.5 4338.2 4385.3 4403.1 4718.0 4733.1 4761.4 4771.3 4782.5 4849.4 4894.3 4896.9 5032.1 5080.3 5102.6 5113.7 5124.4 5165.3 5178.4 4780.9 4781.3 4786.7 4789.3 4850.7 4945.6 5004.9 5236.2 5237.6 5303.8 4815.1 4852.9 4857.1 4858.8 4862.7 4945.2 4946.3 4947.7 4949.2 4950.6 4866.9 4902.3 4907.4 4911.8 4930.7 4934.8 4965.5 4969.3 5026.4 5029.0 4174.0 4178.7 4179.8 4229.2 4229.3 3671.9 3679.6 3684.6 3694.1 3761.6 4435.6 4439.5 4441.1 4442.1 4447.4 5060.6 5095.2 5098.8 5099.9 5101.3 4362.0 4369.1 4434.2 4448.6 4484.6 4599.9 4603.3 4607.5 4633.2 4656.1 4902.2 4905.8 4906.7 4910.0 4954.5 4939.7 4971.6 4978.6 5177.9 5232.3 4788.5 4790.5 4799.2 4800.2 4803.8 4927.2 4966.5 4969.0 4969.8 4974.8 5043.4 5050.1 5050.8 5054.6 5058.7 4814.1 4908.8 4919.1 4920.6 4922.4 4949.8 5000.6 5031.6 5082.6 5085.6 4948.3 4950.0 4961.8 4964.9 5021.7 5008.9 5039.9 5056.6 5057.6 5119.8 4708.5 4750.9 4760.1 4845.0 4862.8 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | [#1] ext.html Cycles:180 Average:47070.89 Median:36760.63 stddev:83691.69 (227.7%) stddev-sans-first:83853.53 03:52:35 INFO - PROCESS | 22804 | Values: 534.7 538.9 548.2 555.9 558.5 39063.8 40866.0 40987.8 43739.3 43956.6 40792.4 41228.0 41240.4 41262.6 41272.2 7737.2 7888.1 7896.8 7899.2 7899.6 7755.7 7840.0 7843.1 7849.8 7850.5 7867.9 7888.8 7902.8 7907.1 7909.3 7817.7 7842.5 7853.5 7854.4 7854.4 7672.2 7744.4 7745.8 7746.7 7751.6 36362.5 36746.4 36759.3 36762.0 36808.4 3198.5 3199.9 3216.7 3538.2 3632.2 27985.4 28603.4 28842.9 28991.9 29786.9 3480.7 3537.3 3572.0 3600.3 3635.0 175051.1 176280.0 176394.0 243530.8 244041.0 51795.7 52164.5 52178.5 55699.4 57403.7 51994.0 52305.7 52875.5 52882.0 52888.0 15158.1 15370.5 15377.5 15381.2 15384.9 11516.3 11669.3 11691.0 11698.5 11698.6 18473.7 18587.5 18665.5 18738.2 18797.7 6953.2 7195.2 7282.8 7327.7 7332.2 795.6 878.4 904.0 951.5 978.0 27628.3 27717.4 28009.2 28294.0 28454.9 945.0 960.9 1003.2 1029.7 1058.9 14570.1 14911.8 15007.8 15203.8 15298.9 376442.0 377298.0 378004.0 378277.0 379400.0 48449.3 48913.8 48918.3 48959.5 49032.5 1063.7 1114.7 1177.8 1222.2 1226.1 26769.3 29538.0 30214.2 31903.0 32292.4 48223.8 48848.3 48922.8 48953.8 49027.5 340413.0 343142.0 343833.0 344015.0 344170.0 38478.6 38522.6 38633.3 39211.6 39241.4 37915.6 40793.8 41627.2 42301.7 43437.8 35760.3 35853.5 36094.6 36466.3 36524.5 35774.3 35807.3 35991.8 36365.8 36701.4 30466.5 31252.0 32076.2 35593.0 36339.6 26172.9 32964.5 33012.7 33022.8 33175.8 24403.4 25135.7 25159.0 25552.4 25557.0 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | [#2] jquery.html Cycles:180 Average:23218.74 Median:4415.58 stddev:56830.97 (1287.1%) stddev-sans-first:56964.48 03:52:35 INFO - PROCESS | 22804 | Values: 358.0 372.0 373.3 383.7 384.9 15431.8 16639.9 17356.4 17442.9 17462.0 16400.7 17030.1 17168.7 17288.8 17297.3 4853.6 5109.8 5111.6 5113.6 5118.1 3691.2 3877.4 4980.1 5579.1 5854.4 5935.4 5939.4 5956.2 5964.2 5967.5 5706.8 5918.1 5935.6 5943.9 5946.0 5091.6 5208.3 5245.3 5252.3 5253.6 20378.3 20598.8 20751.7 20818.6 20892.5 1910.0 1927.1 1930.8 1934.7 2042.6 12895.7 13153.7 13219.4 13760.9 14023.1 1647.0 1662.2 1677.5 1704.5 1761.4 72930.0 76896.0 77681.6 77784.6 78032.2 9708.9 9714.6 10132.9 10245.0 10273.8 13968.6 13993.3 13994.6 13995.0 14001.5 7247.9 7305.9 7341.6 7500.1 7596.4 7050.7 7060.3 7167.3 7258.5 7282.2 4292.2 4349.2 4358.9 4472.3 4476.4 1613.8 1687.9 1718.3 1780.8 1885.9 785.9 823.3 848.4 861.5 889.3 16172.2 16568.8 16612.3 16639.4 16963.7 826.8 855.7 859.2 900.8 933.4 9239.3 9274.2 9938.2 10227.2 10244.3 291586.0 296025.0 298085.0 396727.0 398617.0 78095.6 81197.6 81654.0 82396.6 84436.6 899.7 907.1 937.0 947.0 947.2 15632.6 15715.7 16320.3 16395.8 16655.3 25071.9 35405.0 36071.8 36815.6 36987.8 50976.5 51897.5 52241.7 52618.5 52795.0 7372.4 7378.7 7458.4 7461.2 7751.0 8312.6 11580.9 11610.2 11673.5 11835.1 9369.2 9605.3 9641.0 9928.1 10264.5 9915.1 9987.8 10168.3 10181.1 10287.3 10130.5 10170.4 10250.6 10769.9 10920.2 7524.3 7532.9 7695.3 7788.7 7882.3 9578.6 9741.4 10004.8 10304.0 10340.4 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | [#3] mootools.html Cycles:180 Average:5220.16 Median:5414.97 stddev:2905.99 (53.7%) stddev-sans-first:2899.89 03:52:35 INFO - PROCESS | 22804 | Values: 1390.0 1416.7 1494.7 1594.1 1637.4 6774.7 7003.3 7610.5 8136.7 8179.1 7460.5 7739.1 7739.7 7922.0 7935.4 2174.1 2191.4 2208.9 2213.2 2214.3 1794.9 1853.6 2171.7 2188.6 2253.2 2121.6 2189.4 2190.9 2203.3 2203.7 2169.3 2184.1 2189.9 2204.3 2206.5 2125.8 2126.1 2132.3 2133.0 2141.6 7696.5 7746.7 7760.6 7764.3 7772.0 4610.4 4681.8 4739.0 4745.3 4749.5 2963.1 3031.5 3070.9 3097.1 3103.1 961.7 981.8 986.6 995.3 1003.7 10800.9 10804.4 10883.2 10894.8 10895.5 4072.8 4403.3 4430.1 4430.4 4439.6 9305.2 9315.6 9318.2 9321.6 9322.0 4769.0 4769.2 4769.3 4797.8 4809.5 4241.6 4262.0 4304.6 4349.8 4367.2 3677.8 3703.5 3777.1 3814.0 3823.2 1126.3 1171.8 1220.8 1224.3 1272.3 629.5 798.5 826.2 840.9 862.8 5192.6 5386.1 5520.4 5535.8 5537.6 827.6 857.2 873.4 873.5 879.8 3674.2 3794.3 3794.4 3794.7 3849.9 9260.6 9744.2 9773.8 9778.8 9782.0 9667.0 9679.9 9683.8 9699.0 9722.6 7167.7 7363.7 7412.5 7413.5 7427.7 5308.6 5350.5 5396.1 5433.8 5685.7 9004.9 9028.8 9093.9 9128.2 9173.9 9049.1 9105.1 9142.0 9244.2 9245.9 6778.8 6934.3 6935.7 6940.7 6944.9 7414.9 7469.7 7557.7 7565.9 7567.2 6829.5 6874.9 6977.5 6979.0 7065.5 6644.6 6718.6 6801.9 6841.0 6973.1 6343.8 6422.3 6460.2 6464.4 6484.0 4494.5 4532.2 4585.5 4587.7 4654.3 4753.1 4760.5 4873.3 4904.2 5008.3 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | [#4] prototype.html Cycles:180 Average:4162.25 Median:4757.12 stddev:1194.84 (25.1%) stddev-sans-first:1162.55 03:52:35 INFO - PROCESS | 22804 | Values: 303.0 303.1 308.5 310.5 313.6 4734.3 4810.2 4829.2 4846.2 4849.7 4468.0 4554.1 4609.9 4714.6 4734.6 3795.5 3800.6 3801.0 3802.4 3808.9 3791.5 3793.9 3794.2 3794.9 3807.3 3491.7 3578.2 3672.8 3703.6 3781.9 3747.5 3754.8 3768.0 3769.4 3770.8 3366.9 3390.4 3391.6 3392.6 3395.6 4462.1 4606.3 4701.3 4702.1 4704.8 4271.3 4272.9 4278.3 4282.5 4299.6 4948.7 4961.3 4970.5 4979.4 5026.1 3654.4 3660.9 3675.8 3684.7 3699.8 4963.2 5155.8 5157.3 5166.0 5182.8 3707.8 3745.6 3750.6 3753.4 3765.7 3784.3 3787.3 3794.6 3821.2 3835.8 3994.5 4185.0 4309.8 4311.5 4317.8 4914.6 4937.7 4940.8 4949.3 4977.6 1259.5 1277.6 1279.4 1279.5 1287.4 794.7 824.7 835.3 841.9 846.6 4164.5 4314.4 4337.9 4426.2 4469.5 5065.6 5082.8 5083.2 5087.6 5101.4 4348.2 4428.3 4444.7 4450.3 4481.2 2675.9 2693.4 2715.1 2716.8 2717.1 4839.9 4852.0 4857.4 4883.3 4895.5 5084.3 5177.5 5210.2 5267.2 5276.0 4879.3 4889.9 4894.6 4900.2 4901.2 5134.9 5174.1 5187.2 5222.6 5225.4 4865.9 5023.7 5030.8 5086.1 5090.4 4868.0 4877.7 4887.4 4894.0 4897.6 3660.0 3683.9 3687.8 3693.7 3707.1 4919.4 5163.3 5177.0 5183.2 5219.4 4982.2 4984.3 4991.6 4996.4 5018.2 4977.4 4998.6 5015.8 5018.7 5022.5 4832.9 4914.7 4924.0 4985.0 4988.6 4779.6 4905.3 4914.7 5034.9 5058.2 4877.0 4882.4 4890.3 4893.4 4910.0 03:52:35 INFO - PROCESS | 22804 | 03:52:35 INFO - PROCESS | 22804 | [#5] yui.html Cycles:180 Average:17005.78 Median:555.65 stddev:24762.40 (4456.5%) stddev-sans-first:24801.32 03:52:35 INFO - PROCESS | 22804 | Values: 625.8 644.9 664.3 679.3 696.6 13204.3 13500.2 13929.7 13931.2 14109.8 14562.3 14590.9 14602.0 14626.7 14667.7 758.9 776.4 777.0 777.3 777.4 621.7 632.3 637.1 638.7 773.5 665.1 774.1 798.7 802.9 804.0 797.7 798.2 802.1 802.3 802.8 577.2 577.2 577.6 577.6 577.8 10024.9 10374.8 12640.3 13103.1 13150.1 11704.0 12277.3 12607.5 13052.4 14002.3 9888.3 10140.3 10178.1 10265.5 10317.6 3132.8 3142.5 3214.7 3216.2 3288.2 65843.0 65926.7 66329.7 67063.7 67244.0 9811.7 9900.1 9919.6 9994.5 10215.2 18936.7 19147.5 19152.0 19157.4 19166.1 6157.9 6244.5 6308.8 6459.0 6522.0 3534.2 3619.4 3658.9 3661.7 3681.4 2873.3 2961.1 2963.2 2965.8 2970.3 494.0 497.3 502.9 508.3 510.5 517.9 552.8 558.5 588.9 620.3 7965.6 8067.3 8153.4 8211.3 8488.1 575.8 583.5 595.2 613.2 623.7 3996.4 4052.8 4113.9 4117.9 4185.6 73460.6 100912.5 101610.5 103592.5 105374.0 24299.8 24890.3 30321.0 85664.0 87362.6 70914.6 77571.0 78075.2 78137.6 78431.0 7512.5 7920.5 7953.4 8068.5 8104.1 45701.5 46716.0 47809.3 48221.0 48535.8 62953.7 67839.7 68617.0 68768.0 70659.6 10369.8 10424.0 10462.2 10531.8 10674.7 11253.8 11271.7 11862.6 11874.9 12127.8 10474.8 11309.4 11309.7 11429.7 11796.9 10548.2 11030.4 11197.5 11369.9 11475.0 9355.4 9486.5 9811.6 10117.1 10422.8 8328.7 8529.1 8723.6 8785.6 9135.3 8610.3 8754.4 9111.7 9159.5 9170.0 03:52:35 INFO - PROCESS | 22804 | -------- Summary: end -------- 03:52:35 INFO - PROCESS | 22804 | 03:52:36 INFO - TEST-INFO | 22804: exit 0 03:52:36 INFO - TEST-OK | dromaeo_css | took 1123804ms 03:52:36 INFO - TEST-START | kraken 03:52:36 INFO - operating with platform_type : linux_ 03:52:36 INFO - Initialising browser for kraken test... 03:52:36 INFO - TEST-INFO | started process 23112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mGBDN/profile http://localhost:36957/getInfo.html) 03:52:40 INFO - PROCESS | 23112 | __metrics Screen width/height:1600/1200 03:52:40 INFO - PROCESS | 23112 | colorDepth:24 03:52:40 INFO - PROCESS | 23112 | Browser inner width/height: 1024/697 03:52:40 INFO - PROCESS | 23112 | __metrics 03:52:41 INFO - PROCESS | 23112 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:52:41 INFO - PROCESS | 23112 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:42 INFO - PROCESS | 23112 | console.error: PushService: 03:52:42 INFO - PROCESS | 23112 | stateChangeProcessEnqueue: Error transitioning state 03:52:42 INFO - PROCESS | 23112 | UnknownError 03:52:43 INFO - TEST-INFO | 23112: exit 0 03:52:43 INFO - Browser initialized. 03:52:43 INFO - Running cycle 1/1 for kraken test... 03:52:43 INFO - TEST-INFO | started process 23190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mGBDN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:55 INFO - PROCESS | 23190 | RSS: Main: 175370240 03:52:55 INFO - PROCESS | 23190 | 03:52:58 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:59 INFO - PROCESS | 23190 | RSS: Main: 234057728 03:52:59 INFO - PROCESS | 23190 | 03:53:01 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-dft) 03:53:02 INFO - PROCESS | 23190 | RSS: Main: 218701824 03:53:02 INFO - PROCESS | 23190 | 03:53:05 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-fft) 03:53:06 INFO - PROCESS | 23190 | RSS: Main: 301293568 03:53:06 INFO - PROCESS | 23190 | 03:53:08 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36957/tests/kraken/driver.html?testName=audio-oscillator) 03:53:09 INFO - PROCESS | 23190 | RSS: Main: 211865600 03:53:09 INFO - PROCESS | 23190 | 03:53:11 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:11 INFO - PROCESS | 23190 | RSS: Main: 214671360 03:53:11 INFO - PROCESS | 23190 | 03:53:15 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36957/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:15 INFO - PROCESS | 23190 | RSS: Main: 250273792 03:53:15 INFO - PROCESS | 23190 | 03:53:19 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36957/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:19 INFO - PROCESS | 23190 | RSS: Main: 249696256 03:53:19 INFO - PROCESS | 23190 | 03:53:22 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36957/tests/kraken/driver.html?testName=json-parse-financial) 03:53:23 INFO - PROCESS | 23190 | RSS: Main: 248889344 03:53:23 INFO - PROCESS | 23190 | 03:53:24 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:25 INFO - PROCESS | 23190 | RSS: Main: 211509248 03:53:25 INFO - PROCESS | 23190 | 03:53:27 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:28 INFO - PROCESS | 23190 | RSS: Main: 219516928 03:53:28 INFO - PROCESS | 23190 | 03:53:30 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:30 INFO - PROCESS | 23190 | RSS: Main: 227495936 03:53:30 INFO - PROCESS | 23190 | 03:53:33 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:34 INFO - PROCESS | 23190 | RSS: Main: 236167168 03:53:34 INFO - PROCESS | 23190 | 03:53:37 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:38 INFO - PROCESS | 23190 | RSS: Main: 233607168 03:53:38 INFO - PROCESS | 23190 | 03:53:39 INFO - PROCESS | 23190 | Cycle 1(1): loaded http://localhost:36957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36957/tests/kraken/driver.html?testName=ai-astar) 03:53:40 INFO - PROCESS | 23190 | RSS: Main: 284131328 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | __start_tp_report 03:53:40 INFO - PROCESS | 23190 | _x_x_mozilla_page_load 03:53:40 INFO - PROCESS | 23190 | _x_x_mozilla_page_load_details 03:53:40 INFO - PROCESS | 23190 | |i|pagename|runs| 03:53:40 INFO - PROCESS | 23190 | |0;ai-astar;114;115;114;115;115;115;115;114;114;115 03:53:40 INFO - PROCESS | 23190 | |1;audio-beat-detection;156;126;128;166;127;127;130;130;164;126 03:53:40 INFO - PROCESS | 23190 | |2;audio-dft;160;162;159;163;161;161;161;162;158;159 03:53:40 INFO - PROCESS | 23190 | |3;audio-fft;76;76;75;111;78;77;78;77;101;76 03:53:40 INFO - PROCESS | 23190 | |4;audio-oscillator;84;84;124;84;84;83;124;83;82;108 03:53:40 INFO - PROCESS | 23190 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;118;117;117 03:53:40 INFO - PROCESS | 23190 | |6;imaging-darkroom;146;146;147;146;146;147;146;146;145;146 03:53:40 INFO - PROCESS | 23190 | |7;imaging-desaturate;95;96;96;96;95;95;95;96;96;95 03:53:40 INFO - PROCESS | 23190 | |8;json-parse-financial;66;64;64;63;65;64;66;69;65;66 03:53:40 INFO - PROCESS | 23190 | |9;json-stringify-tinderbox;67;67;66;66;66;67;66;67;67;67 03:53:40 INFO - PROCESS | 23190 | |10;stanford-crypto-aes;90;83;90;83;91;84;82;87;83;82 03:53:40 INFO - PROCESS | 23190 | |11;stanford-crypto-ccm;136;142;144;138;150;140;143;151;181;138 03:53:40 INFO - PROCESS | 23190 | |12;stanford-crypto-pbkdf2;187;184;188;186;177;187;180;178;183;179 03:53:40 INFO - PROCESS | 23190 | |13;stanford-crypto-sha256-iterative;70;70;72;70;76;71;71;72;71;70 03:53:40 INFO - PROCESS | 23190 | __end_tp_report 03:53:40 INFO - PROCESS | 23190 | __start_cc_report 03:53:40 INFO - PROCESS | 23190 | _x_x_mozilla_cycle_collect,1985 03:53:40 INFO - PROCESS | 23190 | __end_cc_report 03:53:40 INFO - PROCESS | 23190 | __startTimestamp1476356020230__endTimestamp 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | ------- Summary: start ------- 03:53:40 INFO - PROCESS | 23190 | Number of tests: 14 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:53:40 INFO - PROCESS | 23190 | Values: 114.0 115.0 114.0 115.0 115.0 115.0 115.0 114.0 114.0 115.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:130.00 stddev:16.81 (12.9%) stddev-sans-first:16.52 03:53:40 INFO - PROCESS | 23190 | Values: 156.0 126.0 128.0 166.0 127.0 127.0 130.0 130.0 164.0 126.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 03:53:40 INFO - PROCESS | 23190 | Values: 160.0 162.0 159.0 163.0 161.0 161.0 161.0 162.0 158.0 159.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.50 stddev:12.64 (16.5%) stddev-sans-first:13.19 03:53:40 INFO - PROCESS | 23190 | Values: 76.0 76.0 75.0 111.0 78.0 77.0 78.0 77.0 101.0 76.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:83.50 stddev:17.58 (21.1%) stddev-sans-first:18.27 03:53:40 INFO - PROCESS | 23190 | Values: 84.0 84.0 124.0 84.0 84.0 83.0 124.0 83.0 82.0 108.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:53:40 INFO - PROCESS | 23190 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:53:40 INFO - PROCESS | 23190 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:53:40 INFO - PROCESS | 23190 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:1.69 (2.6%) stddev-sans-first:1.76 03:53:40 INFO - PROCESS | 23190 | Values: 66.0 64.0 64.0 63.0 65.0 64.0 66.0 69.0 65.0 66.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:53:40 INFO - PROCESS | 23190 | Values: 67.0 67.0 66.0 66.0 66.0 67.0 66.0 67.0 67.0 67.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:3.63 (4.2%) stddev-sans-first:3.46 03:53:40 INFO - PROCESS | 23190 | Values: 90.0 83.0 90.0 83.0 91.0 84.0 82.0 87.0 83.0 82.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:143.50 stddev:13.16 (9.2%) stddev-sans-first:13.42 03:53:40 INFO - PROCESS | 23190 | Values: 136.0 142.0 144.0 138.0 150.0 140.0 143.0 151.0 181.0 138.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:185.00 stddev:4.12 (2.2%) stddev-sans-first:4.10 03:53:40 INFO - PROCESS | 23190 | Values: 187.0 184.0 188.0 186.0 177.0 187.0 180.0 178.0 183.0 179.0 03:53:40 INFO - PROCESS | 23190 | 03:53:40 INFO - PROCESS | 23190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:1.83 (2.6%) stddev-sans-first:1.88 03:53:40 INFO - PROCESS | 23190 | Values: 70.0 70.0 72.0 70.0 76.0 71.0 71.0 72.0 71.0 70.0 03:53:40 INFO - PROCESS | 23190 | -------- Summary: end -------- 03:53:40 INFO - PROCESS | 23190 | 03:53:41 INFO - TEST-INFO | 23190: exit 0 03:53:41 INFO - TEST-OK | kraken | took 64859ms 03:53:41 INFO - SUITE-END | took 1188s 03:53:41 INFO - Completed test suite (00:19:49) 03:53:41 INFO - javascript benchmark 03:53:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.740325967403, 2609.7129315775273, 2649.8807553660085, 2654.177205066429, 2660.694020187679, 4575.290829921368, 4647.883802904929, 4679.953200467994, 4683.203855344591, 4711.128441238369, 4680.321353403754, 4690.507496712848, 4698.201305778018, 4729.597984171341, 4782.0196859643775, 4320.3735458358515, 4403.493598236212, 4446.622037126832, 4450.5104438511735, 4475.731456112628, 4393.0, 4482.686211965164, 4486.327050942352, 4486.955130448687, 4502.234620114588, 4153.979230103861, 4420.778961051967, 4434.84478043267, 4455.198064348416, 4520.960179158796, 4175.331946888514, 4243.066525364415, 4321.935170972438, 4373.190959672471, 4390.363397307373, 4333.696641235115, 4334.523202447728, 4338.1540599583095, 4385.342198670193, 4403.0533435311245, 4718.0328032753205, 4733.077049975256, 4761.381020467352, 4771.33201351811, 4782.450018247911, 4849.393825771778, 4894.2658601210105, 4896.902061958741, 5032.0690672225755, 5080.288759573663, 5102.6428150029515, 5113.744312784346, 5124.4106927703415, 5165.302684137669, 5178.430372659004, 4780.880477988043, 4781.282807578891, 4786.664933454625, 4789.257665061921, 4850.684705494132, 4945.604351651859, 5004.9499505005215, 5236.24074509194, 5237.580993520509, 5303.840884773463, 4815.085133824562, 4852.927206091911, 4857.101436234308, 4858.80564777412, 4862.732549709729, 4945.159322915113, 4946.332245146931, 4947.6536642434685, 4949.208126699711, 4950.554450099508, 4866.926996095061, 4902.313676085351, 4907.386576677915, 4911.803527858917, 4930.679505832181, 4934.8026078957155, 4965.528274813887, 4969.304297398367, 5026.447090820006, 5029.0, 4173.97913010433, 4178.6657067434535, 4179.832806687759, 4229.175310814362, 4229.323308270662, 3671.94492082619, 3679.5584529856055, 3684.5578530575967, 3694.094946738013, 3761.586225515191, 4435.600795928382, 4439.489458712224, 4441.133978874153, 4442.111577684476, 4447.3773671685985, 5060.645754797129, 5095.184770436712, 5098.821541246039, 5099.898002039939, 5101.260317254051, 4362.040351122748, 4369.104333611602, 4434.246178149722, 4448.644108471314, 4484.551544845489, 4599.862004139881, 4603.309503574424, 4607.470140933769, 4633.189191891405, 4656.138614356355, 4902.2156454967035, 4905.828296009765, 4906.681065730788, 4910.042541704333, 4954.504549545017, 4939.703617782944, 4971.602271818174, 4978.576820970258, 5177.948220517746, 5232.319798426181, 4788.497207793271, 4790.5448982346625, 4799.1601469743355, 4800.183968725255, 4803.759812009315, 4927.211646136601, 4966.528179822911, 4968.950310496849, 4969.751512424436, 4974.801007959786, 5043.36957880265, 5050.065737838511, 5050.77271522775, 5054.595632349477, 5058.721770302669, 4814.133455977958, 4908.779104940358, 4919.114559379346, 4920.5571498565305, 4922.4339200992345, 4949.82675606352, 5000.574951129195, 5031.6226283029655, 5082.567981721595, 5085.644004919768, 4948.2824990375475, 4950.0, 4961.801527938842, 4964.851054468371, 5021.72380519075, 5008.949910500848, 5039.949600503948, 5056.570191533614, 5057.620678449204, 5119.846404607868, 4708.529147085264, 4750.904981900412, 4760.143174228534, 4844.975775121243, 4862.805487780449], "value": 4648.141040150727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.716600201893, 538.9326334208224, 548.1667864845434, 555.9110542313231, 558.4582954534101, 39063.80468097659, 40866.0, 40987.79506102469, 43739.34390984138, 43956.560434395644, 40792.38811417831, 41228.0, 41240.38139427911, 41262.58737412625, 41272.17455650885, 7737.187595302496, 7888.053433587977, 7896.763097107096, 7899.170587088331, 7899.605019748989, 7755.6509957051785, 7839.96080019602, 7843.078445780763, 7849.764507064769, 7850.528968261894, 7867.921320786776, 7888.7633370998965, 7902.762917112495, 7907.130215676271, 7909.288164065233, 7817.687292508293, 7842.451028427984, 7853.450258481908, 7854.3716502679645, 7854.410919181084, 7672.194419585919, 7744.419168562324, 7745.7676269712, 7746.728864489773, 7751.573663448508, 36362.45456318157, 36746.44880326797, 36759.26481470383, 36762.0, 36808.44787328192, 3198.4562624353916, 3199.936001279985, 3216.742660587171, 3538.150843797496, 3632.164602141496, 27985.440291194267, 28603.427931441256, 28842.855785721145, 28991.855040724873, 29786.851065744748, 3480.6519348065244, 3537.327907697555, 3571.964280357189, 3600.2840499967533, 3635.0367152704553, 175051.12474437675, 176280.0, 176394.0, 243530.7823460889, 244041.0, 51795.741021295406, 52164.47835521672, 52178.47821521812, 55699.44300557024, 57403.71298143566, 51994.0, 52305.73847130816, 52875.47124528782, 52882.0, 52888.0, 15158.090514569161, 15370.538883833502, 15377.538673839803, 15381.230938453033, 15384.923075384775, 11516.30902145874, 11669.299842009506, 11691.0, 11698.47356868943, 11698.649040528799, 18473.7228941566, 18587.535311617317, 18665.520275134142, 18738.1567829448, 18797.718034229496, 6953.235144134142, 7195.208527062019, 7282.817929551804, 7327.670254838545, 7332.230115837867, 795.6379847169524, 878.3719640457103, 904.041715781274, 951.509972364233, 977.973128215371, 27628.30929226745, 27717.445651086866, 28009.159725208276, 28294.0, 28454.857725711652, 944.9811003780023, 960.9471479068718, 1003.1773945364731, 1029.6756521695643, 1058.878229003659, 14570.125792452487, 14911.776323355158, 15007.849921500863, 15203.820416473292, 15298.923505382625, 376442.0, 377298.0, 378004.0, 378277.0, 379400.0, 48449.273260901115, 48913.755431223326, 48918.266226006635, 48959.510404895496, 49032.50967490351, 1063.7181146996052, 1114.7436089699252, 1177.8468799056238, 1222.205566381859, 1226.1355744200318, 26769.330766730207, 29538.0, 30214.244643884078, 31903.0, 32292.35415291728, 48223.75888120677, 48848.267275990176, 48922.75538622284, 48953.755231223615, 49027.50972490372, 340413.0, 343142.0, 343833.0, 344015.0, 344170.0, 38478.6152138475, 38522.56990446022, 38633.32983366575, 39211.6078839208, 39241.411378829915, 37915.62084379121, 40793.79603101966, 41627.1674566513, 42301.67340796286, 43437.782811085744, 35760.28479430449, 35853.462198066525, 36094.639053610175, 36466.27067458689, 36524.452133218554, 35774.284514310086, 35807.28385432329, 35991.820040900675, 36365.81817090898, 36701.44947825838, 30466.543001854545, 31252.0, 32076.19809504781, 35593.0, 36339.63660363468, 26172.8691356542, 32964.50553241751, 33012.66987330192, 33022.83488582542, 33175.83412082924, 24403.38991525226, 25135.74864251334, 25159.0, 25552.361190970376, 25557.0], "value": 17831.029220485183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.95704515458135, 371.99256014879705, 373.30565148823194, 383.73330535277995, 384.93648547989585, 15431.768523472158, 16639.916800415995, 17356.351146641064, 17442.91278543609, 17462.0, 16400.67198656026, 17030.148492575383, 17168.742468862976, 17288.82711172888, 17297.308107675708, 4853.563179313861, 5109.770060347293, 5111.591072714193, 5113.565346945496, 5118.07874582575, 3691.169486865461, 3877.4377715231417, 4980.078685443186, 5579.13523403873, 5854.356020837705, 5935.436133567326, 5939.406059394069, 5956.195913551658, 5964.2246507953905, 5967.462928336449, 5706.800261990831, 5918.082697181922, 5935.6438613682885, 5943.940560594382, 5946.048632218824, 5091.592672586185, 5208.322918020671, 5245.31810864589, 5252.3171987641745, 5253.6322457428, 20378.286759963477, 20598.794012059836, 20751.68872466914, 20818.58362832735, 20892.477688057766, 1910.035432106777, 1927.094265695121, 1930.806919308072, 1934.7388102606108, 2042.6323261812868, 12895.742085158337, 13153.671158221025, 13219.405126769318, 13760.93119534396, 14023.088499247517, 1646.958826029347, 1662.185529090749, 1677.4883660483547, 1704.4971733338696, 1761.445144779403, 72930.0, 76895.99999999945, 77681.61159194224, 77784.61107694426, 78032.21967780306, 9708.854367184498, 9714.562844672007, 10132.946821271404, 10245.0, 10273.845892311621, 13968.58094257174, 13993.30033498321, 13994.580162595139, 13995.0, 14001.5099471518, 7247.891281630779, 7305.853882922312, 7341.632918354061, 7500.137484189279, 7596.392288617008, 7050.682719277543, 7060.293970603001, 7167.319104685047, 7258.49190556656, 7282.162551306562, 4292.248856450109, 4349.217140914602, 4358.869233922987, 4472.284434490466, 4476.440444944382, 1613.790207273047, 1687.9493615191564, 1718.269735362491, 1780.7863056433312, 1885.886846789197, 785.8918924316686, 823.3454403749034, 848.3806821020689, 861.4874149880811, 889.2796834564024, 16172.191390430431, 16568.83431165697, 16612.335506579602, 16639.41762038323, 16963.74554381685, 826.8139668574643, 855.7133360324236, 859.2352806002663, 900.7703035725848, 933.4306073295285, 9239.260859131253, 9274.237894799966, 9938.217299156247, 10227.181825453947, 10244.334118282288, 291586.0, 296025.0, 298085.0, 396727.0, 398617.0, 78095.60952195202, 81197.59401202956, 81654.0, 82396.58801706073, 84436.57781711176, 899.6716198587468, 907.1019690506483, 937.0208132501552, 946.990530094704, 947.1759569174724, 15632.609184770472, 15715.685686286439, 16320.347186112898, 16395.83604163943, 16655.333786648884, 25071.87464062668, 35405.0, 36071.81964090163, 36815.63184368122, 36987.81506092452, 50976.49023509866, 51897.48102518926, 52241.7387913058, 52618.47381526136, 52795.0, 7372.410207183305, 7378.741744038933, 7458.403327733877, 7461.179270280156, 7751.0, 8312.584370781316, 11580.88419115798, 11610.187286890174, 11673.474693638636, 11835.11236657237, 9369.156775890202, 9605.279604029585, 9641.0, 9928.106470417697, 10264.538095785856, 9915.107640312406, 9987.800243994934, 10168.33905796121, 10181.134603558781, 10287.331323463952, 10130.544125514221, 10170.440625765654, 10250.564920910929, 10769.892301076889, 10920.235583509078, 7524.322810947041, 7532.887006694795, 7695.345895598937, 7788.688452461838, 7882.330001949669, 9578.616855325708, 9741.366811157252, 10004.799904002024, 10304.0, 10340.431276279876], "value": 8272.358152867728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.0408717984592, 1416.6741649420633, 1494.7085318362917, 1594.1152660273558, 1637.4350848957113, 6774.729010839561, 7003.264657210996, 7610.505317154381, 8136.71521496747, 8179.141190175028, 7460.477766556343, 7739.071311442634, 7739.651715672794, 7921.960390198041, 7935.404844636647, 2174.076017692478, 2191.441182498461, 2208.9226877059305, 2213.1700612270397, 2214.324630987548, 1794.8564114870844, 1853.5644123631002, 2171.6959625652344, 2188.5513469738744, 2253.1663284584724, 2121.596896589643, 2189.3650841256094, 2190.9342719718434, 2203.327984964585, 2203.713517242756, 2169.349195241421, 2184.1154332495366, 2189.9233526826565, 2204.261572373257, 2206.5255969966533, 2125.7555381131215, 2126.138913739938, 2132.264368792764, 2132.9573408531896, 2141.6038032963797, 7696.538207707556, 7746.651400686983, 7760.573168475732, 7764.340031097364, 7772.028496437945, 4610.400647915783, 4681.765911704401, 4739.0, 4745.264484004984, 4749.4775574686755, 2963.06663401028, 3031.4694928387444, 3070.9078727638207, 3097.0708787363924, 3103.053568661557, 961.697065424389, 981.8085473332703, 986.5842515989506, 995.3381001633904, 1003.7189586915675, 10800.891991080067, 10804.405757683324, 10883.23817332787, 10894.836577451266, 10895.509702063426, 4072.7963601819793, 4403.3174857897075, 4430.136123455895, 4430.357598148251, 4439.600435960779, 9305.209057230077, 9315.580798864068, 9318.207952323994, 9321.627134914663, 9322.0, 4769.046190761862, 4769.236922092448, 4769.332293478916, 4797.808087676453, 4809.519048095232, 4241.554636763157, 4261.97869010653, 4304.5910638489295, 4349.760763157993, 4367.213901497761, 3677.7609455385314, 3703.5370578677666, 3777.0934975606206, 3813.961860381416, 3823.1780167263614, 1126.3467189030343, 1171.7949358862336, 1220.7741567809983, 1224.2837939805313, 1272.3256673962815, 629.5026928726346, 798.5129071266523, 826.2274773087182, 840.8948881389827, 862.7584276402617, 5192.584593232532, 5386.13821788512, 5520.420355862657, 5535.750891209906, 5537.612367134342, 827.594478705442, 857.2113655437013, 873.3799002708148, 873.4977388001797, 879.824035192964, 3674.210044840372, 3794.3359912015285, 3794.4498047782918, 3794.715396345285, 3849.9210426370005, 9260.629574816932, 9744.17174540172, 9773.755656108655, 9778.75553111178, 9781.951090244504, 9667.0, 9679.854802177973, 9683.757906052406, 9699.0, 9722.61109555624, 7167.713291468387, 7363.705451781869, 7412.51818631798, 7413.518121322205, 7427.665755041036, 5308.628396012242, 5350.545203657733, 5396.109641909041, 5433.8369848904595, 5685.744141513725, 9004.864927025968, 9028.774280643036, 9093.863592046257, 9128.178463938277, 9173.908260917306, 9049.140331668481, 9105.135012173832, 9141.954290228507, 9244.214241789254, 9245.907540924505, 6778.796636100925, 6934.341237582422, 6935.687894044881, 6940.652967351713, 6944.861102778017, 7414.851702966019, 7469.7385591504035, 7557.735479258199, 7565.924340756522, 7567.167611562613, 6829.52193346461, 6874.8625027500175, 6977.476689248429, 6978.953157026486, 7065.540739851893, 6644.568103073285, 6718.563293385914, 6801.8639627206185, 6840.965795170992, 6973.058637084132, 6343.826392117473, 6422.2614399344675, 6460.224773027267, 6464.353564643498, 6484.0, 4494.528074552125, 4532.229520981376, 4585.495595484427, 4587.6788624795945, 4654.2785868190485, 4753.120672675566, 4760.547747963938, 4873.269009648581, 4904.239842824368, 5008.348914641073], "value": 4202.909785779479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.96818834022423, 303.12548298159817, 308.47867104593234, 310.4814959018439, 313.6346156727413, 4734.295653564718, 4810.182269014267, 4829.154897892863, 4846.151923413402, 4849.709017458955, 4468.0, 4554.066416384641, 4609.884752881179, 4714.646401519891, 4734.597559207463, 3795.4876091727538, 3800.581935987046, 3800.961990380102, 3802.372608519591, 3808.9428658570146, 3791.488149099878, 3793.905152371199, 3794.203217324365, 3794.924101517968, 3807.3337165995977, 3491.720662347019, 3578.1949061461223, 3672.8347224374966, 3703.5926647678953, 3781.9432708509394, 3747.5315585551807, 3754.8498060077563, 3767.9811600942094, 3769.3780526213277, 3770.811459427045, 3366.8653253869816, 3390.440577304742, 3391.6269210386836, 3392.5759280089987, 3395.643457436958, 4462.107578484316, 4606.282293446882, 4701.318308845232, 4702.131699663203, 4704.835775543254, 4271.295236286009, 4272.87181384559, 4278.2940814765525, 4282.486101667789, 4299.592228352101, 4948.653594248404, 4961.330220420233, 4970.527799859007, 4979.4355906707715, 5026.095302845486, 3654.4152935530456, 3660.8535658573624, 3675.8345874435713, 3684.6868016218655, 3699.8150092495266, 4963.220596465991, 5155.845324640267, 5157.252198431206, 5165.999999999963, 5182.792688292464, 3707.8331475083687, 3745.6067112952746, 3750.643688849555, 3753.3806921857586, 3765.6987441004653, 3784.3377408953324, 3787.299349620329, 3794.6205379461835, 3821.216650586623, 3835.8082095895093, 3994.540627827837, 4184.970289409634, 4309.827606895689, 4311.547287534827, 4317.784110794448, 4914.582260507826, 4937.703737775745, 4940.752962351868, 4949.282354058641, 4977.626677999092, 1259.4836117191908, 1277.6486466221863, 1279.3667134768164, 1279.5457612547411, 1287.362755436065, 794.7178751543119, 824.698984870518, 835.3108685334623, 841.8905542279465, 846.5851732650957, 4164.500259968762, 4314.41755363022, 4337.937205384701, 4426.15902978433, 4469.5306992765945, 5065.645404821627, 5082.796688132507, 5083.161278389024, 5087.64386492942, 5101.413337466165, 4348.195583817004, 4428.269335559661, 4444.688871779009, 4450.329802118703, 4481.1933851906315, 2675.879585418661, 2693.4108875763004, 2715.131158029451, 2716.7690746286785, 2717.1033558925506, 4839.879003024882, 4852.0295940811975, 4857.417109946829, 4883.316335713003, 4895.485973972753, 5084.339035925306, 5177.508136727005, 5210.21846722987, 5267.157254839208, 5275.973620131952, 4879.268109783561, 4889.926651100308, 4894.632902532324, 4900.166971614834, 4901.191303434894, 5134.922976155435, 5174.14626586609, 5187.19598462239, 5222.634415590872, 5225.425203227566, 4865.878353041202, 5023.673461225008, 5030.773615187252, 5086.109930762176, 5090.389153301479, 4867.975660121677, 4877.707337559757, 4887.437944636412, 4894.0, 4897.632677549127, 3659.9817000914827, 3683.9079023024638, 3687.778733276012, 3693.7045036396485, 3707.0917625182, 4919.409670839379, 5163.302954101148, 5177.0, 5183.170692689302, 5219.425863154974, 4982.227754698028, 4984.277279794482, 4991.575716064175, 4996.375453068366, 5018.197088465828, 4977.352944117387, 4998.625103117208, 5015.799368025384, 5018.723970181675, 5022.547970682656, 4832.903341933212, 4914.70511769295, 4923.975380123076, 4984.975075124601, 4988.600911927109, 4779.641526885428, 4905.313256144214, 4914.729689867092, 5034.899302013866, 5058.215976523645, 4876.975615121902, 4882.4385195701525, 4890.339804126397, 4893.412790465025, 4909.975450122726], "value": 3782.7215039487837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.7934881489109, 644.871025794841, 664.3099716005001, 679.3104998426597, 696.6168607266003, 13204.273764942924, 13500.189988600667, 13929.721405571896, 13931.164130152185, 14109.78835317471, 14562.344694488747, 14590.854091459083, 14602.0, 14626.707465850677, 14667.706645867103, 758.9051368578914, 776.3556248313914, 777.0325944199479, 777.2732495117056, 777.4324742937658, 621.6549814852755, 632.3170975346615, 637.1175921348942, 638.6998110887898, 773.5165521549031, 665.0523004718282, 774.0711146624045, 798.6525861250345, 802.9437939344219, 804.0030362350673, 797.7327595255567, 798.1659166171336, 802.0535767794, 802.3220378779922, 802.7712102050888, 577.1602318626431, 577.2438106081047, 577.5725962787549, 577.6043410263941, 577.8353169346758, 10024.94987525065, 10374.792504149875, 12640.304783236918, 13103.06907927618, 13150.145240559334, 11704.0, 12277.263364198177, 12607.495700171981, 13052.412641431158, 14002.299885005708, 9888.25838062141, 10140.290179687425, 10178.083972442515, 10265.486725663686, 10317.638882639147, 3132.8120312781307, 3142.528620706912, 3214.67853214679, 3216.179874132105, 3288.227266592373, 65843.0, 65926.67036664834, 66329.66835165794, 67063.66468167676, 67244.0, 9811.705648830546, 9900.108990190918, 9919.603215871428, 9994.500274986221, 10215.233857460571, 18936.71594926077, 19147.521311967314, 19152.0, 19157.425277241706, 19166.137523811463, 6157.907631385533, 6244.500439964792, 6308.810735677937, 6459.0, 6521.9673901630185, 3534.2048039190977, 3619.366610843092, 3658.908527286786, 3661.7253705972157, 3681.37416639172, 2873.252954231915, 2961.0524632117517, 2963.1851240908923, 2965.7627389808763, 2970.3465237647683, 493.9975300123476, 497.30625777040825, 502.9396472423259, 508.3213909430951, 510.49971028392383, 517.9119549676489, 552.7871769368822, 558.511302610216, 588.8840646974046, 620.3083561828619, 7965.641546130438, 8067.273945344829, 8153.429259951747, 8211.260986511243, 8488.108748581433, 575.829124201757, 583.4836169989505, 595.1935127901718, 613.2426453330133, 623.7473823101651, 3996.4005399190355, 4052.756834589934, 4113.85601503946, 4117.855875044359, 4185.644220241314, 73460.63269683617, 100912.49543752382, 101610.49194753979, 103592.48203758933, 105374.0, 24299.757002430102, 24890.253292401256, 30321.0, 85664.0, 87362.57418119404, 70914.64542677357, 77571.0, 78075.21924780794, 78137.60931195307, 78431.0, 7512.549247044976, 7920.5247685139075, 7953.403494738033, 8068.515889046676, 8104.149064348394, 45701.54298457106, 46716.0, 47809.321420910484, 48221.0, 48535.75732121317, 62953.68523157355, 67839.66080169567, 68617.0, 68768.0, 70659.64670176616, 10369.792604148026, 10424.0, 10462.215333850145, 10531.78832445195, 10674.679759607225, 11253.831192532283, 11271.661850144508, 11862.644120676394, 11874.940625296818, 12127.818082728943, 10474.842877356694, 11309.434528273718, 11309.71725706864, 11429.657110286706, 11796.941015295211, 10548.156147508334, 11030.393328367018, 11197.496112674786, 11369.943150284196, 11475.0, 9355.4386736796, 9486.525673716149, 9811.55847986828, 10117.140043096419, 10422.843657345298, 8328.6668533258, 8529.14708529142, 8723.563821808757, 8785.604647790993, 9135.31485138604, 8610.311175105851, 8754.422616005442, 9111.681091161778, 9159.450432974043, 9169.954150229207], "value": 6317.519559665561, "unit": "score"}], "name": "dromaeo_css", "value": 6402.349400098515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 128.0, 166.0, 127.0, 127.0, 130.0, 130.0, 164.0, 126.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 159.0, 163.0, 161.0, 161.0, 161.0, 162.0, 158.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 111.0, 78.0, 77.0, 78.0, 77.0, 101.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 84.0, 84.0, 83.0, 124.0, 83.0, 82.0, 108.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 65.0, 64.0, 66.0, 69.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 90.0, 83.0, 91.0, 84.0, 82.0, 87.0, 83.0, 82.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 144.0, 138.0, 150.0, 140.0, 143.0, 151.0, 181.0, 138.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 188.0, 186.0, 177.0, 187.0, 180.0, 178.0, 183.0, 179.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 72.0, 70.0, 76.0, 71.0, 71.0, 72.0, 71.0, 70.0], "value": 71.3, "unit": "score"}], "name": "kraken", "value": 1566.5, "alertThreshold": 2.0}]} 03:53:41 INFO - Return code: 0 03:53:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:42 INFO - # TBPL SUCCESS # 03:53:42 INFO - Running post-action listener: _resource_record_post_action 03:53:42 INFO - [mozharness: 2016-10-13 10:53:42.036638Z] Finished run-tests step (success) 03:53:42 INFO - Running post-run listener: _resource_record_post_run 03:53:42 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392220672; Read time: 208; Write time: 306012 03:53:42 INFO - TinderboxPrint: CPU usage
13.0% 03:53:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 03:53:42 INFO - TinderboxPrint: I/O write bytes / time
392,220,672 / 306,012 03:53:42 INFO - TinderboxPrint: CPU idle
8,363.2 (87.0%) 03:53:42 INFO - TinderboxPrint: CPU user
1,204.0 (12.5%) 03:53:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99905536; Read time: 0; Write time: 104624 03:53:42 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292315136; Read time: 200; Write time: 201388 03:53:42 INFO - Running post-run listener: _upload_blobber_files 03:53:42 INFO - Blob upload gear active. 03:53:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:42 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 03:53:42 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:42 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:53:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:43 INFO - (blobuploader) - INFO - Done attempting. 03:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:48 INFO - (blobuploader) - INFO - Done attempting. 03:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:49 INFO - (blobuploader) - INFO - Done attempting. 03:53:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:49 INFO - Return code: 0 03:53:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84866b15d5ba68d66eadd2b9250c5eea18daa600718a324b3a8705568400370fa8e0ae9013f4428a07425100f5582b2cfce4122d29d00660c26ca7d636fe2659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79e4d18b51cae2a31691a24f7196bb20b275d000bd9d78f41f6e4c449548e2c955649d41cf21a8d5133e1f7e946ab7d47f5e2b51c8ca800936283c2e4f4cd2de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1adad9ef0ee653c75521dacaeed414a45619ee26462ea32e030c052656d9e3b9e7ed9b576a6e2ca58f9546b1fc0f47e176a501c593fd33507c4e0bca1a14eca6"} 03:53:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:49 INFO - Contents: 03:53:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84866b15d5ba68d66eadd2b9250c5eea18daa600718a324b3a8705568400370fa8e0ae9013f4428a07425100f5582b2cfce4122d29d00660c26ca7d636fe2659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79e4d18b51cae2a31691a24f7196bb20b275d000bd9d78f41f6e4c449548e2c955649d41cf21a8d5133e1f7e946ab7d47f5e2b51c8ca800936283c2e4f4cd2de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1adad9ef0ee653c75521dacaeed414a45619ee26462ea32e030c052656d9e3b9e7ed9b576a6e2ca58f9546b1fc0f47e176a501c593fd33507c4e0bca1a14eca6"} 03:53:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:49 INFO - Copying logs to upload dir... 03:53:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.502208 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-13 03:53:49.535405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 03:53:49.539241) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84866b15d5ba68d66eadd2b9250c5eea18daa600718a324b3a8705568400370fa8e0ae9013f4428a07425100f5582b2cfce4122d29d00660c26ca7d636fe2659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79e4d18b51cae2a31691a24f7196bb20b275d000bd9d78f41f6e4c449548e2c955649d41cf21a8d5133e1f7e946ab7d47f5e2b51c8ca800936283c2e4f4cd2de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1adad9ef0ee653c75521dacaeed414a45619ee26462ea32e030c052656d9e3b9e7ed9b576a6e2ca58f9546b1fc0f47e176a501c593fd33507c4e0bca1a14eca6"} build_url:https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/Br5QWsjISe-dIiD_LjYJ_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84866b15d5ba68d66eadd2b9250c5eea18daa600718a324b3a8705568400370fa8e0ae9013f4428a07425100f5582b2cfce4122d29d00660c26ca7d636fe2659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79e4d18b51cae2a31691a24f7196bb20b275d000bd9d78f41f6e4c449548e2c955649d41cf21a8d5133e1f7e946ab7d47f5e2b51c8ca800936283c2e4f4cd2de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1adad9ef0ee653c75521dacaeed414a45619ee26462ea32e030c052656d9e3b9e7ed9b576a6e2ca58f9546b1fc0f47e176a501c593fd33507c4e0bca1a14eca6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 03:53:49.564721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:53:49.565187) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1476354777.63744-1426222341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:53:49.649501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 03:53:49.649815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 03:53:49.650086) ========= ========= Total master_lag: 0.32 =========