builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1487768551.36 results: success (0) buildid: 20170222031725 builduid: c922183177f54f509ee48ed29afa7edb revision: c8cefb50d5a80b546777cc712d4de17ca92154f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.359880) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.360645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.361210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.381109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.381432) ========= 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=920470bf432669ad7e3a5387000001ca-1487768551.361-957529201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-22 05:02:31-- 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% 50.4M=0s 2017-02-22 05:02:31 (50.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.475675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.476073) ========= 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=920470bf432669ad7e3a5387000001ca-1487768551.361-957529201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020374 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:31.527534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 05:02:31.528091) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c8cefb50d5a80b546777cc712d4de17ca92154f3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c8cefb50d5a80b546777cc712d4de17ca92154f3 --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=920470bf432669ad7e3a5387000001ca-1487768551.361-957529201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-22 05:02:31,795 truncating revision to first 12 chars 2017-02-22 05:02:31,796 Setting DEBUG logging. 2017-02-22 05:02:31,796 attempt 1/10 2017-02-22 05:02:31,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c8cefb50d5a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 05:02:33,056 unpacking tar archive at: mozilla-beta-c8cefb50d5a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 05:02:33.093502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:33.093901) ========= script_repo_revision: c8cefb50d5a80b546777cc712d4de17ca92154f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:33.094318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:33.094638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 05:02:33.105210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-22 05:02:33.105524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=920470bf432669ad7e3a5387000001ca-1487768551.361-957529201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:02:33 INFO - MultiFileLogger online at 20170222 05:02:33 in /builds/slave/test 05:02:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:02:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:33 INFO - {'append_to_log': False, 05:02:33 INFO - 'base_work_dir': '/builds/slave/test', 05:02:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:02:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:33 INFO - 'branch': 'Mozilla-Beta', 05:02:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:33 INFO - 'config_files': ('talos/linux_config.py',), 05:02:33 INFO - 'default_actions': ('clobber', 05:02:33 INFO - 'read-buildbot-config', 05:02:33 INFO - 'download-and-extract', 05:02:33 INFO - 'populate-webroot', 05:02:33 INFO - 'create-virtualenv', 05:02:33 INFO - 'install', 05:02:33 INFO - 'run-tests'), 05:02:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:33 INFO - 'download_minidump_stackwalk': True, 05:02:33 INFO - 'download_symbols': 'ondemand', 05:02:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:33 INFO - 'installer_path': 'installer.exe', 05:02:33 INFO - 'log_level': 'info', 05:02:33 INFO - 'log_name': 'talos', 05:02:33 INFO - 'log_to_console': True, 05:02:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:02:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:02:33 INFO - 'opt_config_files': (), 05:02:33 INFO - 'pip_index': False, 05:02:33 INFO - 'sps_profile': False, 05:02:33 INFO - 'sps_profile_interval': 0, 05:02:33 INFO - 'suite': 'dromaeojs', 05:02:33 INFO - 'system_bits': '32', 05:02:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:33 INFO - 'title': 'talos-linux64-ix-053', 05:02:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:33 INFO - 'use_talos_json': True, 05:02:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:33 INFO - 'work_dir': 'build'} 05:02:33 INFO - [mozharness: 2017-02-22 13:02:33.469638Z] Running clobber step. 05:02:33 INFO - Running pre-action listener: _resource_record_pre_action 05:02:33 INFO - Running main action method: clobber 05:02:33 INFO - rmtree: /builds/slave/test/build 05:02:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:34 INFO - Running post-action listener: _resource_record_post_action 05:02:34 INFO - [mozharness: 2017-02-22 13:02:34.448890Z] Finished clobber step (success) 05:02:34 INFO - [mozharness: 2017-02-22 13:02:34.448989Z] Running read-buildbot-config step. 05:02:34 INFO - Running pre-action listener: _resource_record_pre_action 05:02:34 INFO - Running main action method: read_buildbot_config 05:02:34 INFO - Using buildbot properties: 05:02:34 INFO - { 05:02:34 INFO - "project": "", 05:02:34 INFO - "product": "firefox", 05:02:34 INFO - "script_repo_revision": "production", 05:02:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:02:34 INFO - "repository": "", 05:02:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:02:34 INFO - "buildid": "20170222031725", 05:02:34 INFO - "pgo_build": "True", 05:02:34 INFO - "basedir": "/builds/slave/test", 05:02:34 INFO - "buildnumber": 149, 05:02:34 INFO - "slavename": "talos-linux64-ix-053", 05:02:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:02:34 INFO - "platform": "ubuntu64_hw", 05:02:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:02:34 INFO - "branch": "mozilla-beta", 05:02:34 INFO - "repo_path": "releases/mozilla-beta", 05:02:34 INFO - "revision": "c8cefb50d5a80b546777cc712d4de17ca92154f3", 05:02:34 INFO - "stage_platform": "linux64-pgo", 05:02:34 INFO - "builduid": "c922183177f54f509ee48ed29afa7edb", 05:02:34 INFO - "slavebuilddir": "test" 05:02:34 INFO - } 05:02:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 05:02:34 INFO - Running post-action listener: _resource_record_post_action 05:02:34 INFO - [mozharness: 2017-02-22 13:02:34.451459Z] Finished read-buildbot-config step (success) 05:02:34 INFO - [mozharness: 2017-02-22 13:02:34.451547Z] Running download-and-extract step. 05:02:34 INFO - Running pre-action listener: _resource_record_pre_action 05:02:34 INFO - Running main action method: download_and_extract 05:02:34 INFO - mkdir: /builds/slave/test/build/tests 05:02:34 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')]} 05:02:34 INFO - trying https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:02:34 INFO - Downloading https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:02:35 INFO - Downloaded 1327 bytes. 05:02:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:02:35 INFO - Using the following test package requirements: 05:02:35 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:02:35 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:35 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 05:02:35 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'jsshell-linux-x86_64.zip'], 05:02:35 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:35 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:02:35 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 05:02:35 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 05:02:35 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:35 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:35 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:02:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:35 INFO - Fetch https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:02:35 INFO - Http code: 200 05:02:35 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 05:02:35 INFO - x-amz-cf-id: PakddsVbe1WXLcjs_9Cxfb75nwmN7ZzrKt2cFLCPBBbQHRB2EmEBrg== 05:02:35 INFO - x-amz-version-id: 0WSph1e0JMN_m0rAaChjwft6cMnf4jJt 05:02:35 INFO - Expected file size: 21963432 05:02:35 INFO - Obtained file size: 21963432 05:02:39 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:02:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:02:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:02:40 INFO - Http code: 200 05:02:40 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 05:02:40 INFO - x-amz-cf-id: EJ2k74oOb0yY0j5n-zZxuLrI8VkihKtElceUaiQp4EntqBj7ae1opg== 05:02:40 INFO - x-amz-version-id: 0WSph1e0JMN_m0rAaChjwft6cMnf4jJt 05:02:40 INFO - Expected file size: 21963432 05:02:40 INFO - Obtained file size: 21963432 05:02:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 05:02:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:02:45 INFO - Fetch https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 05:02:45 INFO - Http code: 200 05:02:45 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 05:02:45 INFO - x-amz-cf-id: DqhPSujAczlZg0b5FJ4d17vVKlLWHk3YQYdAM0ZzmXcql9pZuP33qQ== 05:02:45 INFO - x-amz-version-id: bQtM0MhPbncDKfjHbUbuP3xSLM10fdmJ 05:02:45 INFO - Expected file size: 14403005 05:02:45 INFO - Obtained file size: 14403005 05:02:46 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')]} 05:02:46 INFO - trying https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:46 INFO - Downloading https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:02:47 INFO - Downloaded 57791141 bytes. 05:02:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:47 INFO - mkdir: /builds/slave/test/properties 05:02:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:47 INFO - Contents: 05:02:47 INFO - build_url:https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:47 INFO - Running post-action listener: _resource_record_post_action 05:02:47 INFO - Running post-action listener: set_extra_try_arguments 05:02:47 INFO - [mozharness: 2017-02-22 13:02:47.942500Z] Finished download-and-extract step (success) 05:02:47 INFO - [mozharness: 2017-02-22 13:02:47.942726Z] Running populate-webroot step. 05:02:47 INFO - Running pre-action listener: _resource_record_pre_action 05:02:47 INFO - Running main action method: populate_webroot 05:02:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:47 INFO - '--tppagecycles', 05:02:47 INFO - '7'], 05:02:47 INFO - 'tests': ['tsvgm']}}, 05:02:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['damp', 'tps']}, 05:02:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'tests': ['damp', 'tps']}, 05:02:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['dromaeo_dom']}, 05:02:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['basic_compositor_video']}, 05:02:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:02:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['a11yr', 05:02:47 INFO - 'ts_paint', 05:02:47 INFO - 'tpaint', 05:02:47 INFO - 'sessionrestore', 05:02:47 INFO - 'sessionrestore_no_auto_restore', 05:02:47 INFO - 'tabpaint']}, 05:02:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:47 INFO - 'ts_paint', 05:02:47 INFO - 'tpaint', 05:02:47 INFO - 'sessionrestore', 05:02:47 INFO - 'sessionrestore_no_auto_restore', 05:02:47 INFO - 'tabpaint']}, 05:02:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:47 INFO - 'ts_paint', 05:02:47 INFO - 'tpaint', 05:02:47 INFO - 'sessionrestore', 05:02:47 INFO - 'sessionrestore_no_auto_restore', 05:02:47 INFO - 'tabpaint']}, 05:02:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:47 INFO - 'ts_paint', 05:02:47 INFO - 'tpaint', 05:02:47 INFO - 'sessionrestore', 05:02:47 INFO - 'sessionrestore_no_auto_restore', 05:02:47 INFO - 'tabpaint']}, 05:02:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['a11yr', 05:02:47 INFO - 'ts_paint', 05:02:47 INFO - 'tpaint', 05:02:47 INFO - 'sessionrestore', 05:02:47 INFO - 'sessionrestore_no_auto_restore', 05:02:47 INFO - 'tabpaint']}, 05:02:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['a11yr', 05:02:47 INFO - 'ts_paint', 05:02:47 INFO - 'tpaint', 05:02:47 INFO - 'sessionrestore', 05:02:47 INFO - 'sessionrestore_no_auto_restore', 05:02:47 INFO - 'tabpaint']}, 05:02:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['tsvgx', 05:02:47 INFO - 'tsvgr_opacity', 05:02:47 INFO - 'tart', 05:02:47 INFO - 'tscrollx', 05:02:47 INFO - 'cart']}, 05:02:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:47 INFO - 'tsvgr_opacity', 05:02:47 INFO - 'tart', 05:02:47 INFO - 'tscrollx', 05:02:47 INFO - 'cart']}, 05:02:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'talos_options': ['--disable-e10s'], 05:02:47 INFO - 'tests': ['tp5o']}, 05:02:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'tests': ['tp5o']}, 05:02:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'talos_options': ['--disable-e10s', 05:02:47 INFO - '--xperf_path', 05:02:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:47 INFO - 'tests': ['tp5n']}, 05:02:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:47 INFO - 'talos_options': ['--xperf_path', 05:02:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:47 INFO - 'tests': ['tp5n']}}, 05:02:47 INFO - 'talos.zip': {'path': '', 05:02:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:47 INFO - Running post-action listener: _resource_record_post_action 05:02:47 INFO - [mozharness: 2017-02-22 13:02:47.960237Z] Finished populate-webroot step (success) 05:02:47 INFO - [mozharness: 2017-02-22 13:02:47.960325Z] Running create-virtualenv step. 05:02:47 INFO - Running pre-action listener: _resource_record_pre_action 05:02:47 INFO - Running main action method: create_virtualenv 05:02:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:47 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 05:02:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:48 INFO - Using real prefix '/usr' 05:02:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:50 INFO - Installing pip.................done. 05:02:50 INFO - Return code: 0 05:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:02:50 INFO - Reading from file tmpfile_stdout 05:02:50 INFO - Output received: 05:02:50 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) 05:02:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:50 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')]} 05:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 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')]} 05:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:02:50 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 05:02:50 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 05:02:50 INFO - Using env: {'DISPLAY': ':0', 05:02:50 INFO - 'HOME': '/home/cltbld', 05:02:50 INFO - 'LANG': 'en_US.UTF-8', 05:02:50 INFO - 'LANGUAGE': 'en_US:en', 05:02:50 INFO - 'LOGNAME': 'cltbld', 05:02:50 INFO - 'MAIL': '/var/mail/cltbld', 05:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:50 INFO - 'MOZ_NO_REMOTE': '1', 05:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:50 INFO - 'NO_EM_RESTART': '1', 05:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:50 INFO - 'PWD': '/builds/slave/test', 05:02:50 INFO - 'SHELL': '/bin/bash', 05:02:50 INFO - 'SHLVL': '1', 05:02:50 INFO - 'TERM': 'linux', 05:02:50 INFO - 'TMOUT': '86400', 05:02:50 INFO - 'USER': 'cltbld', 05:02:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:50 INFO - '_': '/tools/buildbot/bin/python'} 05:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:50 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 05:02:50 INFO - Cleaning up... 05:02:50 INFO - Return code: 0 05:02:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:50 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')]} 05:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 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')]} 05:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:51 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:02:51 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 05:02:51 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 05:02:51 INFO - Using env: {'DISPLAY': ':0', 05:02:51 INFO - 'HOME': '/home/cltbld', 05:02:51 INFO - 'LANG': 'en_US.UTF-8', 05:02:51 INFO - 'LANGUAGE': 'en_US:en', 05:02:51 INFO - 'LOGNAME': 'cltbld', 05:02:51 INFO - 'MAIL': '/var/mail/cltbld', 05:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:51 INFO - 'MOZ_NO_REMOTE': '1', 05:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:51 INFO - 'NO_EM_RESTART': '1', 05:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:51 INFO - 'PWD': '/builds/slave/test', 05:02:51 INFO - 'SHELL': '/bin/bash', 05:02:51 INFO - 'SHLVL': '1', 05:02:51 INFO - 'TERM': 'linux', 05:02:51 INFO - 'TMOUT': '86400', 05:02:51 INFO - 'USER': 'cltbld', 05:02:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:51 INFO - '_': '/tools/buildbot/bin/python'} 05:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:51 INFO - Downloading/unpacking psutil>=3.1.1 05:02:51 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 05:02:51 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 05:02:51 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 05:02:51 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 05:02:51 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 05:02:51 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 05:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:53 INFO - Installing collected packages: psutil 05:02:53 INFO - Running setup.py install for psutil 05:02:53 INFO - building 'psutil._psutil_linux' extension 05:02:53 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 05:02:53 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 05:02:53 INFO - building 'psutil._psutil_posix' extension 05:02:53 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 05:02:53 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 05:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:53 INFO - Successfully installed psutil 05:02:53 INFO - Cleaning up... 05:02:53 INFO - Return code: 0 05:02:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:53 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')]} 05:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:53 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')]} 05:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:53 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:02:53 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 05:02:53 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 05:02:53 INFO - Using env: {'DISPLAY': ':0', 05:02:53 INFO - 'HOME': '/home/cltbld', 05:02:53 INFO - 'LANG': 'en_US.UTF-8', 05:02:53 INFO - 'LANGUAGE': 'en_US:en', 05:02:53 INFO - 'LOGNAME': 'cltbld', 05:02:53 INFO - 'MAIL': '/var/mail/cltbld', 05:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:53 INFO - 'MOZ_NO_REMOTE': '1', 05:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:53 INFO - 'NO_EM_RESTART': '1', 05:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:53 INFO - 'PWD': '/builds/slave/test', 05:02:53 INFO - 'SHELL': '/bin/bash', 05:02:53 INFO - 'SHLVL': '1', 05:02:53 INFO - 'TERM': 'linux', 05:02:53 INFO - 'TMOUT': '86400', 05:02:53 INFO - 'USER': 'cltbld', 05:02:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:53 INFO - '_': '/tools/buildbot/bin/python'} 05:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:54 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 05:02:54 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 05:02:54 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 05:02:54 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 05:02:54 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 05:02:54 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 05:02:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:56 INFO - Installing collected packages: mozsystemmonitor 05:02:56 INFO - Running setup.py install for mozsystemmonitor 05:02:56 INFO - Successfully installed mozsystemmonitor 05:02:56 INFO - Cleaning up... 05:02:56 INFO - Return code: 0 05:02:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02:56 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')]} 05:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:56 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')]} 05:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:56 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:02:56 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 05:02:56 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 05:02:56 INFO - Using env: {'DISPLAY': ':0', 05:02:56 INFO - 'HOME': '/home/cltbld', 05:02:56 INFO - 'LANG': 'en_US.UTF-8', 05:02:56 INFO - 'LANGUAGE': 'en_US:en', 05:02:56 INFO - 'LOGNAME': 'cltbld', 05:02:56 INFO - 'MAIL': '/var/mail/cltbld', 05:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:56 INFO - 'MOZ_NO_REMOTE': '1', 05:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:56 INFO - 'NO_EM_RESTART': '1', 05:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:56 INFO - 'PWD': '/builds/slave/test', 05:02:56 INFO - 'SHELL': '/bin/bash', 05:02:56 INFO - 'SHLVL': '1', 05:02:56 INFO - 'TERM': 'linux', 05:02:56 INFO - 'TMOUT': '86400', 05:02:56 INFO - 'USER': 'cltbld', 05:02:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:56 INFO - '_': '/tools/buildbot/bin/python'} 05:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:56 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 05:02:56 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 05:02:56 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 05:02:56 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 05:02:56 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 05:02:56 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 05:02:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:58 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 05:02:58 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 05:02:58 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 05:02:58 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 05:02:58 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 05:02:58 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 05:02:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:58 INFO - warning: no files found matching '*.txt' 05:02:58 INFO - no previously-included directories found matching 'build' 05:02:58 INFO - no previously-included directories found matching 'dist' 05:02:58 INFO - no previously-included directories found matching '.git*' 05:02:58 INFO - Installing collected packages: jsonschema, functools32 05:02:58 INFO - Running setup.py install for functools32 05:02:58 INFO - warning: no files found matching '*.txt' 05:02:58 INFO - no previously-included directories found matching 'build' 05:02:58 INFO - no previously-included directories found matching 'dist' 05:02:58 INFO - no previously-included directories found matching '.git*' 05:02:59 INFO - Successfully installed jsonschema functools32 05:02:59 INFO - Cleaning up... 05:02:59 INFO - Return code: 0 05:02:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:59 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:02:59 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 05:02:59 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 05:02:59 INFO - Using env: {'DISPLAY': ':0', 05:02:59 INFO - 'HOME': '/home/cltbld', 05:02:59 INFO - 'LANG': 'en_US.UTF-8', 05:02:59 INFO - 'LANGUAGE': 'en_US:en', 05:02:59 INFO - 'LOGNAME': 'cltbld', 05:02:59 INFO - 'MAIL': '/var/mail/cltbld', 05:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:59 INFO - 'MOZ_NO_REMOTE': '1', 05:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:59 INFO - 'NO_EM_RESTART': '1', 05:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:59 INFO - 'PWD': '/builds/slave/test', 05:02:59 INFO - 'SHELL': '/bin/bash', 05:02:59 INFO - 'SHLVL': '1', 05:02:59 INFO - 'TERM': 'linux', 05:02:59 INFO - 'TMOUT': '86400', 05:02:59 INFO - 'USER': 'cltbld', 05:02:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:59 INFO - '_': '/tools/buildbot/bin/python'} 05:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:59 INFO - Cleaning up... 05:02:59 INFO - Return code: 0 05:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:59 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:02:59 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 05:02:59 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 05:02:59 INFO - Using env: {'DISPLAY': ':0', 05:02:59 INFO - 'HOME': '/home/cltbld', 05:02:59 INFO - 'LANG': 'en_US.UTF-8', 05:02:59 INFO - 'LANGUAGE': 'en_US:en', 05:02:59 INFO - 'LOGNAME': 'cltbld', 05:02:59 INFO - 'MAIL': '/var/mail/cltbld', 05:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:59 INFO - 'MOZ_NO_REMOTE': '1', 05:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:59 INFO - 'NO_EM_RESTART': '1', 05:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:59 INFO - 'PWD': '/builds/slave/test', 05:02:59 INFO - 'SHELL': '/bin/bash', 05:02:59 INFO - 'SHLVL': '1', 05:02:59 INFO - 'TERM': 'linux', 05:02:59 INFO - 'TMOUT': '86400', 05:02:59 INFO - 'USER': 'cltbld', 05:02:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:59 INFO - '_': '/tools/buildbot/bin/python'} 05:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:59 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 05:02:59 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 05:02:59 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 05:02:59 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 05:02:59 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 05:02:59 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 05:03:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 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 05:03:01 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 05:03:02 INFO - Downloading docopt-0.6.1.tar.gz 05:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:02 INFO - Running setup.py install for blobuploader 05:03:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:02 INFO - Running setup.py install for requests 05:03:02 INFO - Running setup.py install for docopt 05:03:02 INFO - Successfully installed blobuploader requests docopt 05:03:02 INFO - Cleaning up... 05:03:02 INFO - Return code: 0 05:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:02 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')]} 05:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:02 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')]} 05:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:02 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:03:02 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 05:03:02 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 05:03:02 INFO - Using env: {'DISPLAY': ':0', 05:03:02 INFO - 'HOME': '/home/cltbld', 05:03:02 INFO - 'LANG': 'en_US.UTF-8', 05:03:02 INFO - 'LANGUAGE': 'en_US:en', 05:03:02 INFO - 'LOGNAME': 'cltbld', 05:03:02 INFO - 'MAIL': '/var/mail/cltbld', 05:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:02 INFO - 'MOZ_NO_REMOTE': '1', 05:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:02 INFO - 'NO_EM_RESTART': '1', 05:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:02 INFO - 'PWD': '/builds/slave/test', 05:03:02 INFO - 'SHELL': '/bin/bash', 05:03:02 INFO - 'SHLVL': '1', 05:03:02 INFO - 'TERM': 'linux', 05:03:02 INFO - 'TMOUT': '86400', 05:03:02 INFO - 'USER': 'cltbld', 05:03:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:02 INFO - '_': '/tools/buildbot/bin/python'} 05:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:03 INFO - Running setup.py (path:/tmp/pip-YJehlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:03 INFO - Running setup.py (path:/tmp/pip-FFZt0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:03 INFO - Running setup.py (path:/tmp/pip-sIL80R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:03 INFO - Running setup.py (path:/tmp/pip-MAREgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:03 INFO - Running setup.py (path:/tmp/pip-OpAk_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:03 INFO - Running setup.py (path:/tmp/pip-2T7Ayr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:03 INFO - Running setup.py (path:/tmp/pip-1Gk5pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:03 INFO - Running setup.py (path:/tmp/pip-QLS_2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:03 INFO - Running setup.py (path:/tmp/pip-1yetTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:03 INFO - Running setup.py (path:/tmp/pip-Nrd7ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:03 INFO - Running setup.py (path:/tmp/pip-DY7Pf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:03 INFO - Running setup.py (path:/tmp/pip-M6tODR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:03 INFO - Running setup.py (path:/tmp/pip-N9t1rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:04 INFO - Running setup.py (path:/tmp/pip-sIPRvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:04 INFO - Running setup.py (path:/tmp/pip-Jua8LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:04 INFO - Running setup.py (path:/tmp/pip-GaFjMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:04 INFO - Running setup.py (path:/tmp/pip-Jhtg18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:04 INFO - Running setup.py install for manifestparser 05:03:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozcrash 05:03:04 INFO - Running setup.py install for mozdebug 05:03:04 INFO - Running setup.py install for mozdevice 05:03:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozfile 05:03:04 INFO - Running setup.py install for mozhttpd 05:03:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozinfo 05:03:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozInstall 05:03:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozleak 05:03:05 INFO - Running setup.py install for mozlog 05:03:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for moznetwork 05:03:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozprocess 05:03:05 INFO - Running setup.py install for mozprofile 05:03:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozrunner 05:03:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozscreenshot 05:03:05 INFO - Running setup.py install for moztest 05:03:06 INFO - Running setup.py install for mozversion 05:03:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:06 INFO - Cleaning up... 05:03:06 INFO - Return code: 0 05:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:06 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')]} 05:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:06 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')]} 05:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:06 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:03:06 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 05:03:06 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 05:03:06 INFO - Using env: {'DISPLAY': ':0', 05:03:06 INFO - 'HOME': '/home/cltbld', 05:03:06 INFO - 'LANG': 'en_US.UTF-8', 05:03:06 INFO - 'LANGUAGE': 'en_US:en', 05:03:06 INFO - 'LOGNAME': 'cltbld', 05:03:06 INFO - 'MAIL': '/var/mail/cltbld', 05:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:06 INFO - 'MOZ_NO_REMOTE': '1', 05:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:06 INFO - 'NO_EM_RESTART': '1', 05:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:06 INFO - 'PWD': '/builds/slave/test', 05:03:06 INFO - 'SHELL': '/bin/bash', 05:03:06 INFO - 'SHLVL': '1', 05:03:06 INFO - 'TERM': 'linux', 05:03:06 INFO - 'TMOUT': '86400', 05:03:06 INFO - 'USER': 'cltbld', 05:03:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:06 INFO - '_': '/tools/buildbot/bin/python'} 05:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:06 INFO - Running setup.py (path:/tmp/pip-ri_Klg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:06 INFO - Running setup.py (path:/tmp/pip-tnU4UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:06 INFO - Running setup.py (path:/tmp/pip-oV7JDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:06 INFO - Running setup.py (path:/tmp/pip-d2lyjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:06 INFO - Running setup.py (path:/tmp/pip-zcifZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:06 INFO - Running setup.py (path:/tmp/pip-RAjANA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:06 INFO - Running setup.py (path:/tmp/pip-gZ0SZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:06 INFO - Running setup.py (path:/tmp/pip-AGHYnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:06 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:06 INFO - Running setup.py (path:/tmp/pip-sWCrc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:07 INFO - Running setup.py (path:/tmp/pip-qs_Br3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:07 INFO - Running setup.py (path:/tmp/pip-nTSaXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:07 INFO - Running setup.py (path:/tmp/pip-KrAoOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:07 INFO - Running setup.py (path:/tmp/pip-VEaS71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:07 INFO - Running setup.py (path:/tmp/pip-TkPRrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:07 INFO - Running setup.py (path:/tmp/pip-L6OV_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:07 INFO - Running setup.py (path:/tmp/pip-uzQUQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:07 INFO - Running setup.py (path:/tmp/pip-v0t9Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:07 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)) 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:07 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)) 05:03:07 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)) 05:03:07 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)) 05:03:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:09 INFO - Downloading blessings-1.6.tar.gz 05:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:09 INFO - Installing collected packages: blessings 05:03:09 INFO - Running setup.py install for blessings 05:03:09 INFO - Successfully installed blessings 05:03:09 INFO - Cleaning up... 05:03:09 INFO - Return code: 0 05:03:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:10 INFO - Reading from file tmpfile_stdout 05:03:10 INFO - Current package versions: 05:03:10 INFO - argparse == 1.2.1 05:03:10 INFO - blessings == 1.6 05:03:10 INFO - blobuploader == 1.2.4 05:03:10 INFO - docopt == 0.6.1 05:03:10 INFO - functools32 == 3.2.3-2 05:03:10 INFO - jsonschema == 2.5.1 05:03:10 INFO - manifestparser == 1.1 05:03:10 INFO - mozInstall == 1.12 05:03:10 INFO - mozcrash == 1.0 05:03:10 INFO - mozdebug == 0.1 05:03:10 INFO - mozdevice == 0.48 05:03:10 INFO - mozfile == 1.2 05:03:10 INFO - mozhttpd == 0.7 05:03:10 INFO - mozinfo == 0.9 05:03:10 INFO - mozleak == 0.1 05:03:10 INFO - mozlog == 3.4 05:03:10 INFO - moznetwork == 0.27 05:03:10 INFO - mozprocess == 0.23 05:03:10 INFO - mozprofile == 0.28 05:03:10 INFO - mozrunner == 6.13 05:03:10 INFO - mozscreenshot == 0.1 05:03:10 INFO - mozsystemmonitor == 0.3 05:03:10 INFO - moztest == 0.8 05:03:10 INFO - mozversion == 1.4 05:03:10 INFO - psutil == 3.1.1 05:03:10 INFO - requests == 1.2.3 05:03:10 INFO - wsgiref == 0.1.2 05:03:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:10 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')]} 05:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:10 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')]} 05:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:10 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:03:10 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 05:03:10 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 05:03:10 INFO - Using env: {'DISPLAY': ':0', 05:03:10 INFO - 'HOME': '/home/cltbld', 05:03:10 INFO - 'LANG': 'en_US.UTF-8', 05:03:10 INFO - 'LANGUAGE': 'en_US:en', 05:03:10 INFO - 'LOGNAME': 'cltbld', 05:03:10 INFO - 'MAIL': '/var/mail/cltbld', 05:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:10 INFO - 'MOZ_NO_REMOTE': '1', 05:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:10 INFO - 'NO_EM_RESTART': '1', 05:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:10 INFO - 'PWD': '/builds/slave/test', 05:03:10 INFO - 'SHELL': '/bin/bash', 05:03:10 INFO - 'SHLVL': '1', 05:03:10 INFO - 'TERM': 'linux', 05:03:10 INFO - 'TMOUT': '86400', 05:03:10 INFO - 'USER': 'cltbld', 05:03:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:10 INFO - '_': '/tools/buildbot/bin/python'} 05:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 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)) 05:03:10 INFO - Cleaning up... 05:03:10 INFO - Return code: 0 05:03:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:10 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')]} 05:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:10 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')]} 05:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:10 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 0x7f77c8d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, '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': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', '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 05:03:10 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 05:03:10 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 05:03:10 INFO - Using env: {'DISPLAY': ':0', 05:03:10 INFO - 'HOME': '/home/cltbld', 05:03:10 INFO - 'LANG': 'en_US.UTF-8', 05:03:10 INFO - 'LANGUAGE': 'en_US:en', 05:03:10 INFO - 'LOGNAME': 'cltbld', 05:03:10 INFO - 'MAIL': '/var/mail/cltbld', 05:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:10 INFO - 'MOZ_NO_REMOTE': '1', 05:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:10 INFO - 'NO_EM_RESTART': '1', 05:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:10 INFO - 'PWD': '/builds/slave/test', 05:03:10 INFO - 'SHELL': '/bin/bash', 05:03:10 INFO - 'SHLVL': '1', 05:03:10 INFO - 'TERM': 'linux', 05:03:10 INFO - 'TMOUT': '86400', 05:03:10 INFO - 'USER': 'cltbld', 05:03:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:10 INFO - '_': '/tools/buildbot/bin/python'} 05:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:03:10 INFO - Cleaning up... 05:03:10 INFO - Return code: 0 05:03:10 INFO - Running post-action listener: _resource_record_post_action 05:03:10 INFO - Running post-action listener: _start_resource_monitoring 05:03:10 INFO - Starting resource monitoring. 05:03:10 INFO - [mozharness: 2017-02-22 13:03:10.599508Z] Finished create-virtualenv step (success) 05:03:10 INFO - [mozharness: 2017-02-22 13:03:10.599965Z] Running install step. 05:03:10 INFO - Running pre-action listener: _resource_record_pre_action 05:03:10 INFO - Running main action method: install 05:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:10 INFO - Reading from file tmpfile_stdout 05:03:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:10 INFO - Reading from file tmpfile_stdout 05:03:10 INFO - Output received: 05:03:10 INFO - Usage: mozinstall [options] installer 05:03:10 INFO - Options: 05:03:10 INFO - -h, --help show this help message and exit 05:03:10 INFO - -d DEST, --destination=DEST 05:03:10 INFO - Directory to install application into. [default: 05:03:10 INFO - "/builds/slave/test"] 05:03:10 INFO - --app=APP Application being installed. [default: firefox] 05:03:10 INFO - mkdir: /builds/slave/test/build/application 05:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:03:24 INFO - Reading from file tmpfile_stdout 05:03:24 INFO - Output received: 05:03:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:03:24 INFO - Running post-action listener: _resource_record_post_action 05:03:24 INFO - [mozharness: 2017-02-22 13:03:24.523361Z] Finished install step (success) 05:03:24 INFO - [mozharness: 2017-02-22 13:03:24.523605Z] Running run-tests step. 05:03:24 INFO - Running pre-action listener: _resource_record_pre_action 05:03:24 INFO - Running main action method: run_tests 05:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:03:24 INFO - Python 2.7.3 05:03:24 INFO - Return code: 0 05:03:24 INFO - grabbing minidump binary from tooltool 05:03: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')]} 05:03:24 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 0x210cf60>, '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 0x210dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:03:24 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 05:03:24 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 05:03:24 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 05:03:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:24 INFO - Return code: 0 05:03:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:03:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:03:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:03:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:03:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:03:24 INFO - Using env: {'DISPLAY': ':0', 05:03:24 INFO - 'HOME': '/home/cltbld', 05:03:24 INFO - 'LANG': 'en_US.UTF-8', 05:03:24 INFO - 'LANGUAGE': 'en_US:en', 05:03:24 INFO - 'LOGNAME': 'cltbld', 05:03:24 INFO - 'MAIL': '/var/mail/cltbld', 05:03:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:03:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:24 INFO - 'MOZ_NO_REMOTE': '1', 05:03:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:24 INFO - 'NO_EM_RESTART': '1', 05:03:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:24 INFO - 'PWD': '/builds/slave/test', 05:03:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:03:24 INFO - 'SHELL': '/bin/bash', 05:03:24 INFO - 'SHLVL': '1', 05:03:24 INFO - 'TERM': 'linux', 05:03:24 INFO - 'TMOUT': '86400', 05:03:24 INFO - 'USER': 'cltbld', 05:03:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1487768551.361-957529201', 05:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:24 INFO - '_': '/tools/buildbot/bin/python'} 05:03:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:03:24 INFO - mozversion application_buildid: 20170222031725 05:03:24 INFO - mozversion application_changeset: c8cefb50d5a80b546777cc712d4de17ca92154f3 05:03:24 INFO - mozversion application_display_name: Firefox 05:03:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:24 INFO - mozversion application_name: Firefox 05:03:24 INFO - mozversion application_remotingname: firefox 05:03:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:03:24 INFO - mozversion application_vendor: Mozilla 05:03:24 INFO - mozversion application_version: 52.0 05:03:24 INFO - mozversion platform_buildid: 20170222031725 05:03:24 INFO - mozversion platform_changeset: c8cefb50d5a80b546777cc712d4de17ca92154f3 05:03:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:03:24 INFO - mozversion platform_version: 52.0 05:03:24 INFO - using testdate: 1487768604 05:03:24 INFO - actual date: 1487768604 05:03:24 INFO - starting webserver on 'localhost:46205' 05:03:24 INFO - SUITE-START | Running 2 tests 05:03:24 INFO - TEST-START | dromaeo_css 05:03:24 INFO - operating with platform_type : linux_ 05:03:24 INFO - Initialising browser for dromaeo_css test... 05:03:24 INFO - TEST-INFO | started process 23114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpALNUu6/profile http://localhost:46205/getInfo.html) 05:03:29 INFO - PROCESS | 23114 | __metrics Screen width/height:1600/1200 05:03:29 INFO - PROCESS | 23114 | colorDepth:24 05:03:29 INFO - PROCESS | 23114 | Browser inner width/height: 1024/697 05:03:29 INFO - PROCESS | 23114 | __metrics 05:03:30 INFO - PROCESS | 23114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:03:30 INFO - PROCESS | 23114 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:31 INFO - TEST-INFO | 23114: exit 0 05:03:31 INFO - Browser initialized. 05:03:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:31 INFO - TEST-INFO | started process 23205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpALNUu6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:42 INFO - PROCESS | 23205 | RSS: Main: 142352384 05:03:42 INFO - PROCESS | 23205 | 05:06:44 INFO - PROCESS | 23205 | Cycle 1(1): loaded http://localhost:46205/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46205/tests/dromaeo/cssquery-ext.html) 05:06:45 INFO - PROCESS | 23205 | RSS: Main: 233082880 05:06:45 INFO - PROCESS | 23205 | 05:09:47 INFO - PROCESS | 23205 | Cycle 1(1): loaded http://localhost:46205/tests/dromaeo/cssquery-ext.html (next: http://localhost:46205/tests/dromaeo/cssquery-jquery.html) 05:09:48 INFO - PROCESS | 23205 | RSS: Main: 238108672 05:09:48 INFO - PROCESS | 23205 | 05:12:50 INFO - PROCESS | 23205 | Cycle 1(1): loaded http://localhost:46205/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46205/tests/dromaeo/cssquery-mootools.html) 05:12:50 INFO - PROCESS | 23205 | RSS: Main: 175968256 05:12:50 INFO - PROCESS | 23205 | 05:15:52 INFO - PROCESS | 23205 | Cycle 1(1): loaded http://localhost:46205/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46205/tests/dromaeo/cssquery-prototype.html) 05:15:53 INFO - PROCESS | 23205 | RSS: Main: 196820992 05:15:53 INFO - PROCESS | 23205 | 05:18:55 INFO - PROCESS | 23205 | Cycle 1(1): loaded http://localhost:46205/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46205/tests/dromaeo/cssquery-yui.html) 05:18:56 INFO - PROCESS | 23205 | RSS: Main: 176365568 05:18:56 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | Cycle 1(1): loaded http://localhost:46205/tests/dromaeo/cssquery-yui.html (next: http://localhost:46205/tests/dromaeo/cssquery-dojo.html) 05:21:59 INFO - PROCESS | 23205 | RSS: Main: 258572288 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | __start_tp_report 05:21:59 INFO - PROCESS | 23205 | _x_x_mozilla_page_load 05:21:59 INFO - PROCESS | 23205 | _x_x_mozilla_page_load_details 05:21:59 INFO - PROCESS | 23205 | |i|pagename|runs| 05:21:59 INFO - PROCESS | 23205 | |0;dojo.html;3230.4831227003683;3251.0246925922215;3273.4926086456594;3290.720288775454;3291.2923721399893;5529.281193444852;5617.747201375938;5632.521235694966;5642.605017648766;5650.773969041244;5629.268195134637;5706.77172913084;5714.114312281603;5714.171445140462;5745.856353591163;5142.177251639729;5163.793448262065;5192.376914770214;5205.6616319939085;5240.135377662681;5017.573506251954;5258.947410525884;5259.921101183485;5265.842024739264;5277.393099793515;5005.17414626588;5080.720560369178;5102.897942041157;5121.743912804345;5125.103106956286;5137.537621614054;5169.974150129244;5173;5232.973835130838;5246.055709972204;5094.439611642716;5125.282460455539;5197.58419326453;5213.973930130363;5240.737963101829;5401.756920938567;5487.368952570466;5498.147787093007;5540.695261760601;5540.806071787509;6001.5198784097165;6019.067044608093;6019.578629495937;6027.547933904931;6028.6985650717725;6054.727537260834;6062.969685151546;6065.454109130155;6071.908921366183;6079.513638908877;5488.835334939959;5524.696141712204;5585.329760428734;5644.266245388073;5700.800471983461;6207.410296021871;6210.596311239755;6218.81343559694;6220.813375598739;6223.315435302113;5973.163757074013;5979.4618484336615;5985.401459854067;5985.9401405986255;6016.127661489059;5708.657480551097;5801.8549536261935;5935.52515798735;6001.5198784097165;6046.304674962347;5995.46040856325;6006.609570377911;6012.278526576839;6015.54883383748;6019.819405417845;6043.063325184604;6050.183225264533;6051.0923361496125;6055.969720151371;6076.908846367308;4492.05666809967;4501.7974191161475;4607.608353289941;4674.74288914113;4680.251159814414;4099.1801639672185;4147.294959856831;4166.645835103989;4172.186423647359;4186.392973018896;5794.130880367894;5802.303723553201;5804.796832110856;5804.912926306109;5805.042168042226;5830.300363956352;6026.367231440723;6092.360302168208;6092.72582733778;6099.2985806632805;5601.943980560142;5662.178984047372;5726.570507211975;5731.828045158652;5820.272465941757;5243.449437809051;5251.107311756934;5257.553107985787;5261.184516399964;5264.184051472028;6035.939640603538;6210.9068363974575;6253.74985000604;6270.278917924497;6288.151099601495;5882.441168089024;5976.850578735392;6044.123602077586;6054.7275372607455;6119.84700382494;6280.434760871543;6300.117983482408;6331.27190373113;6333.96833015832;6338.683065846597;5964.045752679551;5966.016613214765;5966.254218222723;5970.223870896755;5980;5760.135979603093;5777.422257774189;5977.820665380045;6000.309964353981;6104.053871649901;5976.103584462366;5976.850578735566;5984.431479009661;5997.160397544434;6017.097435384728;5943.583949123693;5951.1073338999495;5952.494038006645;5954.07711804671;5957.314908785372;5653.943460565506;5707.286589176353;5724.398938111605;5864.706764661835;5913.793017244376;5846.1815345852465;5928.4960778334325;5934.258217722785;5937.851553711192;5943.346231914573;5770.567207459373;5777.0179069557435;5777.566682498746;5781.595288329777;5807.216025836458 05:21:59 INFO - PROCESS | 23205 | |1;ext.html;592.4904582059428;621.6145989486517;650.0671536345343;653.4347789162376;667.8797816393053;34255.31489370214;44814.551854481484;46072;46146;46179;46974;47330.526694733046;47390.76304618472;47447.52552474474;47587.76206118965;8419.158084191593;9004.594793234304;9145.176934075931;9156;9160.221381182608;8376.204260595234;10690.251682382237;10900.727481812939;10954.726131846688;11181.888181118207;10529.736756581071;10563.788724225511;10571.947140264288;10615.203859710515;10668.573257069707;10887.455627218607;10934.234603577752;10950.452477376179;10954.34273943558;10958.726031849188;10783.676489705322;10854.45727713611;10855.185861060452;10856.457177141112;10860.619878304222;43540.3468947966;43836.780816095714;43876.56123438757;43938;43982.78008609937;3525.5769307682986;3807.505024346817;4062.106336605942;4284.271673815459;4397.252467080604;33741.493877591856;33795;33936.66063339385;34177.316453670785;35567.4664880027;4589.58693717567;4661.86014419568;4670;4695.88260293492;4773.665843390964;326665;326932.36533817416;328230;328607;330069;38391.23217535634;63328.68335658292;63640.045399319046;63667.68166159139;63710.68144659247;39100.41349379761;40826.32563069338;41028.179436411105;41046.79476602598;41170.1765964679;15882.76175857363;16177.272022759003;16180.838191618168;16191.595210119842;16225.59436014109;12172.756544869053;12471.064670149775;12961.740765184644;13099.083064185606;13360.465581376831;9370.812583748288;9450.291228157916;9569.234461243223;9604.135627793532;9662.903370966342;3523.894283171509;3618.873339433107;3667.651573100551;3669.7798132112157;3717.237966216919;1051.7423231308226;1076.359566058194;1173.5540494611994;1189.4944648524342;1197.4675851900515;32409.51385729216;32722.83638581792;32958.50562241568;33030.669693302756;33397.83301083479;1169.1465230381698;1188.518649946773;1195.3246415775059;1195.4992967651078;1219.5121951219405;16702.58243543921;17728.37950671746;17738.171649774282;17827.643447130984;17943.641127177383;483232;548240;549500;551245;555546;60200;60648.696756515936;60979;65294;65733.34266657368;1441.08491108145;1453.6729235922044;1481;1506.6610012747262;1515.2196618741357;33014.66985330116;34417.65582344145;34730.305393891475;34785.13037174091;34789;57217;57756.4224357751;57816;57921.420785793285;57974.13038804506;337968;338454;338791;339479;339651;38736.6126338733;40603;42855.571444286405;43329.56670433255;48215.75892120657;50723.23915141202;51174.74412627913;51218.23172652339;51499;51619.741901290254;42083.7895810519;42973.35539966966;42984.570154299305;44082.33876491791;45043.549564503934;40814.38778418267;43815.78092109519;46448;46775.53224467712;47633;42787.7860610695;43400;43628.56371436245;43899.34150987674;44071.118577628906;36709;38787.224255514164;39116.804415977735;39213.41179882361;39308.6069139305;28702.85648571744;28741.28146796263;28798.424031519673;29051.56422653704;29210.561841572817 05:21:59 INFO - PROCESS | 23205 | |2;jquery.html;396.64103985892757;396.726258881372;426.0775421213074;434.86519179054494;444.768720265462;18273.908630456845;19327.23648611886;19559.315423960164;19707;19761.604767904635;19123.71314430285;19696.409107726755;19964.800351996477;20252.696209556867;20477.692834607493;5523;5954.612950158247;5976.910346344808;5985.940140598604;5987.910181347262;5732.942670573303;5815.534757219412;5845.386234445365;5949.464548190662;5952.494038006775;5729.0833466645345;5759.107338362561;5767.971160144193;5770.798022069229;5773.884522309551;5644.57665675074;5720.6281591696825;5760.596758226926;5763.308402991626;5768.3654797972185;5174.974125129388;5177.068127737006;5177.094008548526;5179.715115668637;5180.766865491062;22122;22952.885235573714;23039;23157.421064473354;23682.289531314087;2188.9014994325294;2339.9181028664084;2382.213869423086;2466.149178533421;2677.852718100504;10283.680893783694;10333.689989300334;10352.275340726152;10840.186985976083;11020.338779673246;1951.5511432370633;1983.841292696581;2008.4878356019267;2013.2047841102683;2046.2019812273224;85551.5722421384;85941;86001.56999215027;86200.99999999937;86644.56677716572;11515.481803318871;11542.422878856023;11643.650690479299;11672.649820505398;11830.52677892892;17009.149542522824;17023;17034.31862725502;17038.829611703724;17054.488365349058;8072;8182.7545173644885;8221.10721021042;8222.917770822216;8409.579521023925;7781.727639532703;7815.726449574351;7951.165127661628;8003.5197888126895;8028.638711258008;4696.647751418657;4857.222844344888;4941;5076.466970967996;5101.2603172539775;2042.377074992112;2127.606392817334;2136.1135128921633;2153.644648632958;2175.8585691929975;763.5266134996338;906.9773255668529;914.5564401265381;955.6273053509137;1024.5082360467018;18954.715679264547;18963.620727585647;19250.903745481184;19332.71000934959;19793.30723424702;1025.1747343388645;1027.1885210683627;1028.4343611014062;1035;1045.8483519889573;10329.225308101923;11125.888741112647;11163.162762792823;11180.44097795107;11180.832287515694;448346;458330;460764;462982;471151;89182;89523.55238223767;89597.55201224082;89616.55191724;90245.54877225703;979.250873082107;994.6866736977829;1020.4438580973388;1028.6502589119734;1029.6036026129993;16261.674766504368;16339.428120015742;16999.7450038252;17152.313907443564;17205.311787528357;40061.799691002525;40220;40833;40933.79533102315;41919;53951.460485394644;54026.72986635042;56991.715041424526;57223.713881430325;57434.7128264356;7856.764297071097;7921.247481489249;7965.681372745025;8035.316998054997;8333.499990000619;7577.469577129768;10373.948130259301;11294.60468883585;12653.430595623035;12801.29592872401;10867.239293249713;11159;11173.441327933733;11617.186796924134;11939.820902686293;10851.240413171003;11088.168387370819;11175.664730058112;11305.15211359135;11825.40872956366;11632.825507617223;11646.417679116179;11663.825042624198;11847.585334513595;11908.761824763284;7875.369970402468;7956.5226086435;8143.877841832259;8235.13531079228;8252.21603947624;10611.204159688208;11303.886961130283;11563;11640.476178571815;11969 05:21:59 INFO - PROCESS | 23205 | |3;mootools.html;1525.3059857764722;1533.5169421632186;1718.93124275029;1800.8739388242827;1855.7773067231935;8406.411551191419;8947.686830960918;8955.462672239662;8956.865647015291;8962.686305979292;7658.808529786744;7847.646855891484;7851.371890248781;8045.436819422628;8796.516191609458;2373.501564671417;2458.0536493450063;2464.125235541375;2474.987625061872;2475.665785119013;2417.1419146203107;2436.1717016214484;2466.2477944227003;2498.362917456046;2503.7371076037025;2401.891914863835;2416.7099948006176;2423.2730180945646;2423.866687332196;2441.2066078524463;2410.252821625293;2414.420539070628;2422.467057247403;2425.842320249178;2434.573949558829;2412.553677569655;2441.145599040339;2442.5237078769646;2443.6334549817493;2453.4970331082086;8628.137186281385;8838.955805220998;8899.688510902088;8904.020557738644;8906.421082629673;5300.973495132538;5432.158015507603;5435.972820135874;5446.645968012067;5446.754896029649;3239.1902024493875;3395.864165433404;3636.8545258189906;3637.2179981303884;3653.0502069461863;1129.6215767717742;1141.2296699727733;1148.5233628044434;1156.5373850459798;1216.4769149265812;12014.639560813102;12029.157958942878;12039.699007524794;12051.517939282507;12058.45736941831;4751.408278226763;4824.0834241494;4830.95169048305;4922;4933.876653083702;10177.592896284214;10218.846717299246;10233.283670143019;10246.743831404125;10254.077133058061;5529.834104976857;5530.391656917735;5537.750801213955;5548.250986116904;5550.5282051026115;4968.378952630921;4989.002199560103;5016.372953380827;5108.335916330853;5126.2054381570915;3937;3978.8806335809973;4062.1266427718183;4074.0629655179473;4097.815598298083;1292.3538230884558;1300.4603089717662;1331.0765943211966;1349.0556610372778;1356.5319964612193;902.278177458031;973.6202880876464;1001.2890847498212;1003.7841863999275;1013.3210748798323;5869.589128761031;5878.441548052928;5985.820425387245;6023.518118550505;6070.3929607038945;484.30502229301067;486.8052778888473;487.5611949245636;1020.5457223456544;1128.1144301723273;4204.978975105105;4324.610785029363;4370.650347972155;4374.12517496502;4395.648348132142;10662.73343166427;10781.946090269656;10940.234183607072;10984.945075274572;10985.505652245669;10105.747356316004;10842.512086956105;10859.891401086046;10878.564857405616;10903.454827258605;7951.880721789178;8267.173282671685;8291.58542072894;8297.58512074394;8315.29320007794;6170.56806023592;6196.256449226122;6228.781992630236;6419.069234960811;6439.517036222208;9840.901590984286;9861.852072219066;9923.702288931343;9943.900560994298;10003.249756268164;8921.553922303989;9599.520023998632;10022.599096036369;10265.692029239135;10303.330283531546;7236.6019868907715;7585.848283034198;7733.574653394117;7795.64919578609;8013.198680132174;8496.617652205789;8509.829803403773;8574.742757717278;8582.613782379933;8592;7217.783466496014;7261.709531618676;7316.487845850952;7376.852462950818;7597.6201189941385;7110.25342339047;7147;7195.928040719735;7211.1707153678;7302.56184628924;7023.824404389931;7042.894356584758;7050.753223637148;7118.9644051779405;7127.717010938081;4997.700137991732;5001.199808030698;5031.3207716959205;5077.035363280965;5135.3324067870935;5079.136546786981;5180.7150606717;5235.3717553893775;5241.746049198881;5303.098473259478 05:21:59 INFO - PROCESS | 23205 | |4;prototype.html;313.8870006797554;328.25813661125846;328.6155198417851;334.9715274201693;342.47772147475104;5388.78444862206;5404.567634589233;5407.188262103704;5437.592180586457;5439.824070371853;5076.593872490201;5193.558547523456;5210.9478905210935;5289.878971406869;5390.4879036491475;4217.810198541058;4227.8308867645255;4234.174336004465;4250.851220207301;4255.978565144374;4247.426597409341;4250.808713607879;4269.50900646425;4283.693473490584;4285.614294713475;3986.800659967005;4157.792110394484;4164.916701665965;4181.832726690929;4186.455760751113;4141.772202528859;4156.168766246763;4158.293090174662;4160.7517744676625;4187.706860519765;3688.3729765939856;3691.6492933171576;3694.371956767356;3700.833462494194;3704.0924973381425;5003.874903127415;5209.947900520984;5276.7889284428575;5297.046531624306;5297.152455607084;4706.364640773486;4719.952800471986;4727.267273572602;4745.810167593292;4746.715197088151;5536.529395001429;5548.389677135512;5569.136783798518;5590.496855283044;5598.496135347838;3882.320593896057;3933.724639275252;3966.206758648253;3986.5814089520472;4008.158286759784;5757.769689212427;5784.855378615526;5791.754772723884;5823.272090988627;5832.2418085649015;4122.299209134454;4139.855105071369;4148.688848336386;4177.665786737054;4183.832646694159;4112.773797441169;4176.498820141603;4212.326027835532;4227.809748561261;4231.87304380869;4702.224133018082;4729.148753224453;4748.358971538867;4798.3042458843975;4806.567408933143;5605.7106865420365;5622.887542249132;5641;5659.292588426447;5661.801836935688;1289.471316760124;1307.5031488034676;1362.8773410393112;1392.9303534823218;1401.7126489069717;949.4161090929028;950.235060776068;959.9712008639752;962.1581116523042;977.2621670638622;5241.606879484054;5253.028189784825;5259.132243179833;5285.814996475105;5291.867703307448;5512.366077901012;5541.919325731525;5544.972275138599;5548.278723765885;5550.972245138829;4970.3538539990295;5228.55557277628;5240.244518086408;5268.078086334876;5287.841364759063;2939.4562006028955;2957.269997051706;2969.8515074246634;2970.2425881400536;2976.479116154664;5683.232763576864;5713.200151978726;5736.017271019046;5741.478508195331;5764.942350576441;5586.608937374344;5644.5484361251;5848.567101060183;5853.297604287428;5866.472017518358;5999.760009599567;6003.279606447254;6021.488173505301;6030.819075427744;6031.60794548353;5613.270274864405;5757.2728181544535;5811.82564523065;5823.213866128019;5829.94170058294;5714.971425142848;5742.454466825645;5751.827445176651;5754;5764.221830053057;5957.523398128226;5963.165156878127;5989.436285410174;5990.760369585168;6000.919834429845;3928.7053470990363;4040.9795102448775;4114.218298523271;4142.5857414258335;4149.128682976488;5548.278723765885;5723.713814309352;5741.598088133791;5747.13218204077;5764.19301297827;5523.232565578976;5578.386377498391;5677.971610141923;5685.573581981451;5694;5600.215969764317;5649.661020338793;5652.463016013472;5652.519535839499;5666.631668941505;5345.358556973188;5566.944330556643;5607.943920560905;5617.971910140586;5619.381867994435;5686.545076393962;5688.084392232033;5693.772249110155;5695.715214239354;5706.9714651426475;5459.317585301837;5563.582731295088;5584.916226256691;5593.468620481048;5600.971995139998 05:21:59 INFO - PROCESS | 23205 | |5;yui.html;802.6227672993691;815.4617952151581;821.7206149909026;829.2205326992627;836.8451836410264;13655.726885462285;14306.999999999987;14309.570712878603;14326.426942922271;14400.351984160712;14448.349824257908;14601.707965840676;14605.123692578427;14619.561413157595;14623.341949612266;720.6792977125182;739.9852002959965;845.2899564365931;863.5725315968589;867.8437881181385;865.4807115730574;868.1405408645427;868.4658934755112;868.8088620503479;868.8870446841902;900.6172376739892;904.6607522179182;904.7873749668822;904.9773755656129;905.1536813079758;907.4872696926216;907.4963395315597;907.9455232686026;908.0601577367426;908.3777612335538;668.0146783494356;668.5019660353069;668.7625892808031;669.1167658690531;669.1234482827512;14525.418983240657;14572.927135364362;14577.708445831024;14587;14599.78100328496;14193;15133.243337833064;15226.695466090616;15367.538973830802;15739.685206295924;11415.885841141566;11435.256708313933;11444.48499817502;11590.76818463626;11708;3760.2291530236234;3806.5725352992627;3826.9617303827163;3827.4641550182996;3872.4191371294532;59925;60599.39400605982;61027;61295.08057379143;61542.69228653873;10898.72753181161;11033.172512061628;11044.226904116635;11132.833007504894;11176.329420234812;19023.048847557842;19176.712349314494;20535.4866128348;21982.89008554947;22427.327180184293;7853.41099417546;7970.1631328709655;7981.72063977758;8146.389020823462;8189.209312552104;4718.7168769873915;4753.667243293005;4773.522647735199;4826.975865120652;4863.562279394871;3395.0833275015607;3472.2708231271213;3492.022233774547;3648.671619554253;3799.240151969562;673.0678010954765;674.8549061951704;680.9761658342034;696.665600511747;697.7836870570139;708.3589351636776;741.1180694973073;767.4167632599265;771.7761849063709;786.5595266650694;8365.24712775841;8973.461592304351;9056.184943355129;9113.726588202364;9310.208632266333;711.2673945835797;718;724.1382754522102;736.8268456912622;744.4863044499278;4077.612626800449;4098.938515922264;4463.843765468193;4501.797419116082;4508.616767574793;76174.61912690512;84171.5791421039;85669.14330856736;87336.56331718301;87442;72298;72359;72948.63525682337;74908;75654;61320.38679613147;63119;64019.6799016002;65611.67194163999;68130.3186968134;8463.957680211559;8804.47173169612;8942.396370796827;9092.454452732858;9118.22495087925;33485;34609.65390346165;42605.78697106495;44203.778981104886;45522.54477455183;60852.69573652103;61021.69489152526;61627.38372616217;63211.57518973812;64915.67542162259;10323.535440905327;10798.298110622783;11152.498137583665;11435.142364322543;11460.426978651201;12557.372131393577;12573.622791316275;12705.237685738884;12820.551280705131;13168.407421665856;12195.51217951272;12414.379281036092;12902.483900644245;12909;13734.93132534331;12226.14416990802;12337.814932776195;12377.195482293622;12654.620361389174;12764.48942042345;11719;12568.120231584067;12755;12779.80830287565;13413.463461461823;9884.802303954024;10081.747956301151;10287.84568231492;10454.268201225841;10580.41807700584;10529.473526323807;10740.593270953552;10951.671449856518;11100.666979990614;11327.490262938352 05:21:59 INFO - PROCESS | 23205 | __end_tp_report 05:21:59 INFO - PROCESS | 23205 | __start_cc_report 05:21:59 INFO - PROCESS | 23205 | _x_x_mozilla_cycle_collect,925 05:21:59 INFO - PROCESS | 23205 | __end_cc_report 05:21:59 INFO - PROCESS | 23205 | __startTimestamp1487769719306__endTimestamp 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | ------- Summary: start ------- 05:21:59 INFO - PROCESS | 23205 | Number of tests: 6 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | [#0] dojo.html Cycles:165 Average:5611.29 Median:5804.80 stddev:631.85 (10.9%) stddev-sans-first:605.56 05:21:59 INFO - PROCESS | 23205 | Values: 3230.5 3251.0 3273.5 3290.7 3291.3 5529.3 5617.7 5632.5 5642.6 5650.8 5629.3 5706.8 5714.1 5714.2 5745.9 5142.2 5163.8 5192.4 5205.7 5240.1 5017.6 5258.9 5259.9 5265.8 5277.4 5005.2 5080.7 5102.9 5121.7 5125.1 5137.5 5170.0 5173.0 5233.0 5246.1 5094.4 5125.3 5197.6 5214.0 5240.7 5401.8 5487.4 5498.1 5540.7 5540.8 6001.5 6019.1 6019.6 6027.5 6028.7 6054.7 6063.0 6065.5 6071.9 6079.5 5488.8 5524.7 5585.3 5644.3 5700.8 6207.4 6210.6 6218.8 6220.8 6223.3 5973.2 5979.5 5985.4 5985.9 6016.1 5708.7 5801.9 5935.5 6001.5 6046.3 5995.5 6006.6 6012.3 6015.5 6019.8 6043.1 6050.2 6051.1 6056.0 6076.9 4492.1 4501.8 4607.6 4674.7 4680.3 4099.2 4147.3 4166.6 4172.2 4186.4 5794.1 5802.3 5804.8 5804.9 5805.0 5830.3 6026.4 6092.4 6092.7 6099.3 5601.9 5662.2 5726.6 5731.8 5820.3 5243.4 5251.1 5257.6 5261.2 5264.2 6035.9 6210.9 6253.7 6270.3 6288.2 5882.4 5976.9 6044.1 6054.7 6119.8 6280.4 6300.1 6331.3 6334.0 6338.7 5964.0 5966.0 5966.3 5970.2 5980.0 5760.1 5777.4 5977.8 6000.3 6104.1 5976.1 5976.9 5984.4 5997.2 6017.1 5943.6 5951.1 5952.5 5954.1 5957.3 5653.9 5707.3 5724.4 5864.7 5913.8 5846.2 5928.5 5934.3 5937.9 5943.3 5770.6 5777.0 5777.6 5781.6 5807.2 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | [#1] ext.html Cycles:180 Average:57733.45 Median:38943.82 stddev:109363.81 (280.8%) stddev-sans-first:109586.46 05:21:59 INFO - PROCESS | 23205 | Values: 592.5 621.6 650.1 653.4 667.9 34255.3 44814.6 46072.0 46146.0 46179.0 46974.0 47330.5 47390.8 47447.5 47587.8 8419.2 9004.6 9145.2 9156.0 9160.2 8376.2 10690.3 10900.7 10954.7 11181.9 10529.7 10563.8 10571.9 10615.2 10668.6 10887.5 10934.2 10950.5 10954.3 10958.7 10783.7 10854.5 10855.2 10856.5 10860.6 43540.3 43836.8 43876.6 43938.0 43982.8 3525.6 3807.5 4062.1 4284.3 4397.3 33741.5 33795.0 33936.7 34177.3 35567.5 4589.6 4661.9 4670.0 4695.9 4773.7 326665.0 326932.4 328230.0 328607.0 330069.0 38391.2 63328.7 63640.0 63667.7 63710.7 39100.4 40826.3 41028.2 41046.8 41170.2 15882.8 16177.3 16180.8 16191.6 16225.6 12172.8 12471.1 12961.7 13099.1 13360.5 9370.8 9450.3 9569.2 9604.1 9662.9 3523.9 3618.9 3667.7 3669.8 3717.2 1051.7 1076.4 1173.6 1189.5 1197.5 32409.5 32722.8 32958.5 33030.7 33397.8 1169.1 1188.5 1195.3 1195.5 1219.5 16702.6 17728.4 17738.2 17827.6 17943.6 483232.0 548240.0 549500.0 551245.0 555546.0 60200.0 60648.7 60979.0 65294.0 65733.3 1441.1 1453.7 1481.0 1506.7 1515.2 33014.7 34417.7 34730.3 34785.1 34789.0 57217.0 57756.4 57816.0 57921.4 57974.1 337968.0 338454.0 338791.0 339479.0 339651.0 38736.6 40603.0 42855.6 43329.6 48215.8 50723.2 51174.7 51218.2 51499.0 51619.7 42083.8 42973.4 42984.6 44082.3 45043.5 40814.4 43815.8 46448.0 46775.5 47633.0 42787.8 43400.0 43628.6 43899.3 44071.1 36709.0 38787.2 39116.8 39213.4 39308.6 28702.9 28741.3 28798.4 29051.6 29210.6 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | [#2] jquery.html Cycles:180 Average:28151.51 Median:2424.18 stddev:76108.59 (3139.6%) stddev-sans-first:76293.56 05:21:59 INFO - PROCESS | 23205 | Values: 396.6 396.7 426.1 434.9 444.8 18273.9 19327.2 19559.3 19707.0 19761.6 19123.7 19696.4 19964.8 20252.7 20477.7 5523.0 5954.6 5976.9 5985.9 5987.9 5732.9 5815.5 5845.4 5949.5 5952.5 5729.1 5759.1 5768.0 5770.8 5773.9 5644.6 5720.6 5760.6 5763.3 5768.4 5175.0 5177.1 5177.1 5179.7 5180.8 22122.0 22952.9 23039.0 23157.4 23682.3 2188.9 2339.9 2382.2 2466.1 2677.9 10283.7 10333.7 10352.3 10840.2 11020.3 1951.6 1983.8 2008.5 2013.2 2046.2 85551.6 85941.0 86001.6 86201.0 86644.6 11515.5 11542.4 11643.7 11672.6 11830.5 17009.1 17023.0 17034.3 17038.8 17054.5 8072.0 8182.8 8221.1 8222.9 8409.6 7781.7 7815.7 7951.2 8003.5 8028.6 4696.6 4857.2 4941.0 5076.5 5101.3 2042.4 2127.6 2136.1 2153.6 2175.9 763.5 907.0 914.6 955.6 1024.5 18954.7 18963.6 19250.9 19332.7 19793.3 1025.2 1027.2 1028.4 1035.0 1045.8 10329.2 11125.9 11163.2 11180.4 11180.8 448346.0 458330.0 460764.0 462982.0 471151.0 89182.0 89523.6 89597.6 89616.6 90245.5 979.3 994.7 1020.4 1028.7 1029.6 16261.7 16339.4 16999.7 17152.3 17205.3 40061.8 40220.0 40833.0 40933.8 41919.0 53951.5 54026.7 56991.7 57223.7 57434.7 7856.8 7921.2 7965.7 8035.3 8333.5 7577.5 10373.9 11294.6 12653.4 12801.3 10867.2 11159.0 11173.4 11617.2 11939.8 10851.2 11088.2 11175.7 11305.2 11825.4 11632.8 11646.4 11663.8 11847.6 11908.8 7875.4 7956.5 8143.9 8235.1 8252.2 10611.2 11303.9 11563.0 11640.5 11969.0 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | [#3] mootools.html Cycles:180 Average:5796.77 Median:4927.94 stddev:3198.49 (64.9%) stddev-sans-first:3191.36 05:21:59 INFO - PROCESS | 23205 | Values: 1525.3 1533.5 1718.9 1800.9 1855.8 8406.4 8947.7 8955.5 8956.9 8962.7 7658.8 7847.6 7851.4 8045.4 8796.5 2373.5 2458.1 2464.1 2475.0 2475.7 2417.1 2436.2 2466.2 2498.4 2503.7 2401.9 2416.7 2423.3 2423.9 2441.2 2410.3 2414.4 2422.5 2425.8 2434.6 2412.6 2441.1 2442.5 2443.6 2453.5 8628.1 8839.0 8899.7 8904.0 8906.4 5301.0 5432.2 5436.0 5446.6 5446.8 3239.2 3395.9 3636.9 3637.2 3653.1 1129.6 1141.2 1148.5 1156.5 1216.5 12014.6 12029.2 12039.7 12051.5 12058.5 4751.4 4824.1 4831.0 4922.0 4933.9 10177.6 10218.8 10233.3 10246.7 10254.1 5529.8 5530.4 5537.8 5548.3 5550.5 4968.4 4989.0 5016.4 5108.3 5126.2 3937.0 3978.9 4062.1 4074.1 4097.8 1292.4 1300.5 1331.1 1349.1 1356.5 902.3 973.6 1001.3 1003.8 1013.3 5869.6 5878.4 5985.8 6023.5 6070.4 484.3 486.8 487.6 1020.5 1128.1 4205.0 4324.6 4370.7 4374.1 4395.6 10662.7 10781.9 10940.2 10984.9 10985.5 10105.7 10842.5 10859.9 10878.6 10903.5 7951.9 8267.2 8291.6 8297.6 8315.3 6170.6 6196.3 6228.8 6419.1 6439.5 9840.9 9861.9 9923.7 9943.9 10003.2 8921.6 9599.5 10022.6 10265.7 10303.3 7236.6 7585.8 7733.6 7795.6 8013.2 8496.6 8509.8 8574.7 8582.6 8592.0 7217.8 7261.7 7316.5 7376.9 7597.6 7110.3 7147.0 7195.9 7211.2 7302.6 7023.8 7042.9 7050.8 7119.0 7127.7 4997.7 5001.2 5031.3 5077.0 5135.3 5079.1 5180.7 5235.4 5241.7 5303.1 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | [#4] prototype.html Cycles:180 Average:4711.76 Median:5389.64 stddev:1389.70 (25.8%) stddev-sans-first:1353.82 05:21:59 INFO - PROCESS | 23205 | Values: 313.9 328.3 328.6 335.0 342.5 5388.8 5404.6 5407.2 5437.6 5439.8 5076.6 5193.6 5210.9 5289.9 5390.5 4217.8 4227.8 4234.2 4250.9 4256.0 4247.4 4250.8 4269.5 4283.7 4285.6 3986.8 4157.8 4164.9 4181.8 4186.5 4141.8 4156.2 4158.3 4160.8 4187.7 3688.4 3691.6 3694.4 3700.8 3704.1 5003.9 5209.9 5276.8 5297.0 5297.2 4706.4 4720.0 4727.3 4745.8 4746.7 5536.5 5548.4 5569.1 5590.5 5598.5 3882.3 3933.7 3966.2 3986.6 4008.2 5757.8 5784.9 5791.8 5823.3 5832.2 4122.3 4139.9 4148.7 4177.7 4183.8 4112.8 4176.5 4212.3 4227.8 4231.9 4702.2 4729.1 4748.4 4798.3 4806.6 5605.7 5622.9 5641.0 5659.3 5661.8 1289.5 1307.5 1362.9 1392.9 1401.7 949.4 950.2 960.0 962.2 977.3 5241.6 5253.0 5259.1 5285.8 5291.9 5512.4 5541.9 5545.0 5548.3 5551.0 4970.4 5228.6 5240.2 5268.1 5287.8 2939.5 2957.3 2969.9 2970.2 2976.5 5683.2 5713.2 5736.0 5741.5 5764.9 5586.6 5644.5 5848.6 5853.3 5866.5 5999.8 6003.3 6021.5 6030.8 6031.6 5613.3 5757.3 5811.8 5823.2 5829.9 5715.0 5742.5 5751.8 5754.0 5764.2 5957.5 5963.2 5989.4 5990.8 6000.9 3928.7 4041.0 4114.2 4142.6 4149.1 5548.3 5723.7 5741.6 5747.1 5764.2 5523.2 5578.4 5678.0 5685.6 5694.0 5600.2 5649.7 5652.5 5652.5 5666.6 5345.4 5566.9 5607.9 5618.0 5619.4 5686.5 5688.1 5693.8 5695.7 5707.0 5459.3 5563.6 5584.9 5593.5 5601.0 05:21:59 INFO - PROCESS | 23205 | 05:21:59 INFO - PROCESS | 23205 | [#5] yui.html Cycles:180 Average:17212.93 Median:4763.59 stddev:22465.65 (471.6%) stddev-sans-first:22494.88 05:21:59 INFO - PROCESS | 23205 | Values: 802.6 815.5 821.7 829.2 836.8 13655.7 14307.0 14309.6 14326.4 14400.4 14448.3 14601.7 14605.1 14619.6 14623.3 720.7 740.0 845.3 863.6 867.8 865.5 868.1 868.5 868.8 868.9 900.6 904.7 904.8 905.0 905.2 907.5 907.5 907.9 908.1 908.4 668.0 668.5 668.8 669.1 669.1 14525.4 14572.9 14577.7 14587.0 14599.8 14193.0 15133.2 15226.7 15367.5 15739.7 11415.9 11435.3 11444.5 11590.8 11708.0 3760.2 3806.6 3827.0 3827.5 3872.4 59925.0 60599.4 61027.0 61295.1 61542.7 10898.7 11033.2 11044.2 11132.8 11176.3 19023.0 19176.7 20535.5 21982.9 22427.3 7853.4 7970.2 7981.7 8146.4 8189.2 4718.7 4753.7 4773.5 4827.0 4863.6 3395.1 3472.3 3492.0 3648.7 3799.2 673.1 674.9 681.0 696.7 697.8 708.4 741.1 767.4 771.8 786.6 8365.2 8973.5 9056.2 9113.7 9310.2 711.3 718.0 724.1 736.8 744.5 4077.6 4098.9 4463.8 4501.8 4508.6 76174.6 84171.6 85669.1 87336.6 87442.0 72298.0 72359.0 72948.6 74908.0 75654.0 61320.4 63119.0 64019.7 65611.7 68130.3 8464.0 8804.5 8942.4 9092.5 9118.2 33485.0 34609.7 42605.8 44203.8 45522.5 60852.7 61021.7 61627.4 63211.6 64915.7 10323.5 10798.3 11152.5 11435.1 11460.4 12557.4 12573.6 12705.2 12820.6 13168.4 12195.5 12414.4 12902.5 12909.0 13734.9 12226.1 12337.8 12377.2 12654.6 12764.5 11719.0 12568.1 12755.0 12779.8 13413.5 9884.8 10081.7 10287.8 10454.3 10580.4 10529.5 10740.6 10951.7 11100.7 11327.5 05:21:59 INFO - PROCESS | 23205 | -------- Summary: end -------- 05:21:59 INFO - PROCESS | 23205 | 05:22:00 INFO - TEST-INFO | 23205: exit 0 05:22:00 INFO - TEST-OK | dromaeo_css | took 1115256ms 05:22:00 INFO - TEST-START | kraken 05:22:00 INFO - operating with platform_type : linux_ 05:22:00 INFO - Initialising browser for kraken test... 05:22:00 INFO - TEST-INFO | started process 23517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvk92M/profile http://localhost:46205/getInfo.html) 05:22:04 INFO - PROCESS | 23517 | __metrics Screen width/height:1600/1200 05:22:04 INFO - PROCESS | 23517 | colorDepth:24 05:22:04 INFO - PROCESS | 23517 | Browser inner width/height: 1024/697 05:22:04 INFO - PROCESS | 23517 | __metrics 05:22:05 INFO - PROCESS | 23517 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:22:05 INFO - PROCESS | 23517 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:05 INFO - PROCESS | 23517 | console.error: PushService: 05:22:05 INFO - PROCESS | 23517 | stateChangeProcessEnqueue: Error transitioning state 05:22:05 INFO - PROCESS | 23517 | UnknownError 05:22:06 INFO - TEST-INFO | 23517: exit 0 05:22:06 INFO - Browser initialized. 05:22:06 INFO - Running cycle 1/1 for kraken test... 05:22:06 INFO - TEST-INFO | started process 23607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvk92M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:17 INFO - PROCESS | 23607 | RSS: Main: 142241792 05:22:17 INFO - PROCESS | 23607 | 05:22:20 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46205/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:21 INFO - PROCESS | 23607 | RSS: Main: 184082432 05:22:21 INFO - PROCESS | 23607 | 05:22:23 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46205/tests/kraken/driver.html?testName=audio-dft) 05:22:24 INFO - PROCESS | 23607 | RSS: Main: 173694976 05:22:24 INFO - PROCESS | 23607 | 05:22:27 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46205/tests/kraken/driver.html?testName=audio-fft) 05:22:27 INFO - PROCESS | 23607 | RSS: Main: 265551872 05:22:27 INFO - PROCESS | 23607 | 05:22:29 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46205/tests/kraken/driver.html?testName=audio-oscillator) 05:22:30 INFO - PROCESS | 23607 | RSS: Main: 172113920 05:22:30 INFO - PROCESS | 23607 | 05:22:32 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46205/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:33 INFO - PROCESS | 23607 | RSS: Main: 174387200 05:22:33 INFO - PROCESS | 23607 | 05:22:35 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46205/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:36 INFO - PROCESS | 23607 | RSS: Main: 212283392 05:22:36 INFO - PROCESS | 23607 | 05:22:39 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46205/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:40 INFO - PROCESS | 23607 | RSS: Main: 211394560 05:22:40 INFO - PROCESS | 23607 | 05:22:43 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46205/tests/kraken/driver.html?testName=json-parse-financial) 05:22:43 INFO - PROCESS | 23607 | RSS: Main: 210227200 05:22:43 INFO - PROCESS | 23607 | 05:22:45 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46205/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:45 INFO - PROCESS | 23607 | RSS: Main: 172118016 05:22:45 INFO - PROCESS | 23607 | 05:22:47 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:48 INFO - PROCESS | 23607 | RSS: Main: 179560448 05:22:48 INFO - PROCESS | 23607 | 05:22:49 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:50 INFO - PROCESS | 23607 | RSS: Main: 189370368 05:22:50 INFO - PROCESS | 23607 | 05:22:53 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:53 INFO - PROCESS | 23607 | RSS: Main: 197492736 05:22:53 INFO - PROCESS | 23607 | 05:22:56 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:57 INFO - PROCESS | 23607 | RSS: Main: 193208320 05:22:57 INFO - PROCESS | 23607 | 05:22:58 INFO - PROCESS | 23607 | Cycle 1(1): loaded http://localhost:46205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46205/tests/kraken/driver.html?testName=ai-astar) 05:22:59 INFO - PROCESS | 23607 | RSS: Main: 245329920 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | __start_tp_report 05:22:59 INFO - PROCESS | 23607 | _x_x_mozilla_page_load 05:22:59 INFO - PROCESS | 23607 | _x_x_mozilla_page_load_details 05:22:59 INFO - PROCESS | 23607 | |i|pagename|runs| 05:22:59 INFO - PROCESS | 23607 | |0;ai-astar;101;110;109;110;111;110;111;110;110;109 05:22:59 INFO - PROCESS | 23607 | |1;audio-beat-detection;142;121;116;156;125;119;118;117;144;118 05:22:59 INFO - PROCESS | 23607 | |2;audio-dft;160;160;162;162;160;160;160;162;159;159 05:22:59 INFO - PROCESS | 23607 | |3;audio-fft;74;75;74;113;75;75;75;75;108;75 05:22:59 INFO - PROCESS | 23607 | |4;audio-oscillator;81;82;106;82;81;82;100;82;83;111 05:22:59 INFO - PROCESS | 23607 | |5;imaging-gaussian-blur;117;117;117;117;118;116;117;117;117;116 05:22:59 INFO - PROCESS | 23607 | |6;imaging-darkroom;146;146;146;145;146;145;145;146;146;145 05:22:59 INFO - PROCESS | 23607 | |7;imaging-desaturate;84;84;84;85;84;84;84;85;84;84 05:22:59 INFO - PROCESS | 23607 | |8;json-parse-financial;50;50;48;49;49;50;50;50;49;50 05:22:59 INFO - PROCESS | 23607 | |9;json-stringify-tinderbox;59;57;58;57;59;59;58;59;58;59 05:22:59 INFO - PROCESS | 23607 | |10;stanford-crypto-aes;76;74;73;75;76;74;75;78;75;73 05:22:59 INFO - PROCESS | 23607 | |11;stanford-crypto-ccm;126;124;123;127;122;121;121;120;168;128 05:22:59 INFO - PROCESS | 23607 | |12;stanford-crypto-pbkdf2;155;155;155;161;158;154;153;158;155;165 05:22:59 INFO - PROCESS | 23607 | |13;stanford-crypto-sha256-iterative;64;64;70;62;62;68;62;61;62;60 05:22:59 INFO - PROCESS | 23607 | __end_tp_report 05:22:59 INFO - PROCESS | 23607 | __start_cc_report 05:22:59 INFO - PROCESS | 23607 | _x_x_mozilla_cycle_collect,1599 05:22:59 INFO - PROCESS | 23607 | __end_cc_report 05:22:59 INFO - PROCESS | 23607 | __startTimestamp1487769779007__endTimestamp 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | ------- Summary: start ------- 05:22:59 INFO - PROCESS | 23607 | Number of tests: 14 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.92 (2.7%) stddev-sans-first:0.71 05:22:59 INFO - PROCESS | 23607 | Values: 101.0 110.0 109.0 110.0 111.0 110.0 111.0 110.0 110.0 109.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:123.00 stddev:14.29 (11.6%) stddev-sans-first:14.18 05:22:59 INFO - PROCESS | 23607 | Values: 142.0 121.0 116.0 156.0 125.0 119.0 118.0 117.0 144.0 118.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 05:22:59 INFO - PROCESS | 23607 | Values: 160.0 160.0 162.0 162.0 160.0 160.0 160.0 162.0 159.0 159.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:15.13 (20.2%) stddev-sans-first:15.77 05:22:59 INFO - PROCESS | 23607 | Values: 74.0 75.0 74.0 113.0 75.0 75.0 75.0 75.0 108.0 75.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:11.80 (14.4%) stddev-sans-first:12.16 05:22:59 INFO - PROCESS | 23607 | Values: 81.0 82.0 106.0 82.0 81.0 82.0 100.0 82.0 83.0 111.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:22:59 INFO - PROCESS | 23607 | Values: 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 116.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:22:59 INFO - PROCESS | 23607 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 05:22:59 INFO - PROCESS | 23607 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:50.00 stddev:0.71 (1.4%) stddev-sans-first:0.73 05:22:59 INFO - PROCESS | 23607 | Values: 50.0 50.0 48.0 49.0 49.0 50.0 50.0 50.0 49.0 50.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 05:22:59 INFO - PROCESS | 23607 | Values: 59.0 57.0 58.0 57.0 59.0 59.0 58.0 59.0 58.0 59.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.52 (2.0%) stddev-sans-first:1.56 05:22:59 INFO - PROCESS | 23607 | Values: 76.0 74.0 73.0 75.0 76.0 74.0 75.0 78.0 75.0 73.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.00 stddev:14.31 (11.5%) stddev-sans-first:15.16 05:22:59 INFO - PROCESS | 23607 | Values: 126.0 124.0 123.0 127.0 122.0 121.0 121.0 120.0 168.0 128.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:156.50 stddev:3.70 (2.4%) stddev-sans-first:3.86 05:22:59 INFO - PROCESS | 23607 | Values: 155.0 155.0 155.0 161.0 158.0 154.0 153.0 158.0 155.0 165.0 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - PROCESS | 23607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:3.17 (5.0%) stddev-sans-first:3.36 05:22:59 INFO - PROCESS | 23607 | Values: 64.0 64.0 70.0 62.0 62.0 68.0 62.0 61.0 62.0 60.0 05:22:59 INFO - PROCESS | 23607 | -------- Summary: end -------- 05:22:59 INFO - PROCESS | 23607 | 05:22:59 INFO - TEST-INFO | 23607: exit 0 05:23:00 INFO - TEST-OK | kraken | took 59984ms 05:23:00 INFO - SUITE-END | took 1175s 05:23:00 INFO - Completed test suite (00:19:35) 05:23:00 INFO - javascript benchmark 05:23:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.4831227003683, 3251.0246925922215, 3273.4926086456594, 3290.720288775454, 3291.2923721399893, 5529.281193444852, 5617.747201375938, 5632.521235694966, 5642.605017648766, 5650.773969041244, 5629.268195134637, 5706.77172913084, 5714.114312281603, 5714.171445140462, 5745.856353591163, 5142.177251639729, 5163.793448262065, 5192.376914770214, 5205.6616319939085, 5240.135377662681, 5017.573506251954, 5258.947410525884, 5259.921101183485, 5265.842024739264, 5277.393099793515, 5005.17414626588, 5080.720560369178, 5102.897942041157, 5121.743912804345, 5125.103106956286, 5137.537621614054, 5169.974150129244, 5173.0, 5232.973835130838, 5246.055709972204, 5094.439611642716, 5125.282460455539, 5197.58419326453, 5213.973930130363, 5240.737963101829, 5401.756920938567, 5487.368952570466, 5498.147787093007, 5540.695261760601, 5540.806071787509, 6001.5198784097165, 6019.067044608093, 6019.578629495937, 6027.547933904931, 6028.6985650717725, 6054.727537260834, 6062.969685151546, 6065.454109130155, 6071.908921366183, 6079.513638908877, 5488.835334939959, 5524.696141712204, 5585.329760428734, 5644.266245388073, 5700.800471983461, 6207.410296021871, 6210.596311239755, 6218.81343559694, 6220.813375598739, 6223.315435302113, 5973.163757074013, 5979.4618484336615, 5985.401459854067, 5985.9401405986255, 6016.127661489059, 5708.657480551097, 5801.8549536261935, 5935.52515798735, 6001.5198784097165, 6046.304674962347, 5995.46040856325, 6006.609570377911, 6012.278526576839, 6015.54883383748, 6019.819405417845, 6043.063325184604, 6050.183225264533, 6051.0923361496125, 6055.969720151371, 6076.908846367308, 4492.05666809967, 4501.7974191161475, 4607.608353289941, 4674.74288914113, 4680.251159814414, 4099.1801639672185, 4147.294959856831, 4166.645835103989, 4172.186423647359, 4186.392973018896, 5794.130880367894, 5802.303723553201, 5804.796832110856, 5804.912926306109, 5805.042168042226, 5830.300363956352, 6026.367231440723, 6092.360302168208, 6092.72582733778, 6099.2985806632805, 5601.943980560142, 5662.178984047372, 5726.570507211975, 5731.828045158652, 5820.272465941757, 5243.449437809051, 5251.107311756934, 5257.553107985787, 5261.184516399964, 5264.184051472028, 6035.939640603538, 6210.9068363974575, 6253.74985000604, 6270.278917924497, 6288.151099601495, 5882.441168089024, 5976.850578735392, 6044.123602077586, 6054.7275372607455, 6119.84700382494, 6280.434760871543, 6300.117983482408, 6331.27190373113, 6333.96833015832, 6338.683065846597, 5964.045752679551, 5966.016613214765, 5966.254218222723, 5970.223870896755, 5980.0, 5760.135979603093, 5777.422257774189, 5977.820665380045, 6000.309964353981, 6104.053871649901, 5976.103584462366, 5976.850578735566, 5984.431479009661, 5997.160397544434, 6017.097435384728, 5943.583949123693, 5951.1073338999495, 5952.494038006645, 5954.07711804671, 5957.314908785372, 5653.943460565506, 5707.286589176353, 5724.398938111605, 5864.706764661835, 5913.793017244376, 5846.1815345852465, 5928.4960778334325, 5934.258217722785, 5937.851553711192, 5943.346231914573, 5770.567207459373, 5777.0179069557435, 5777.566682498746, 5781.595288329777, 5807.216025836458], "value": 5568.986392448522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4904582059428, 621.6145989486517, 650.0671536345343, 653.4347789162376, 667.8797816393053, 34255.31489370214, 44814.551854481484, 46072.0, 46146.0, 46179.0, 46974.0, 47330.526694733046, 47390.76304618472, 47447.52552474474, 47587.76206118965, 8419.158084191593, 9004.594793234304, 9145.176934075931, 9156.0, 9160.221381182608, 8376.204260595234, 10690.251682382237, 10900.727481812939, 10954.726131846688, 11181.888181118207, 10529.736756581071, 10563.788724225511, 10571.947140264288, 10615.203859710515, 10668.573257069707, 10887.455627218607, 10934.234603577752, 10950.452477376179, 10954.34273943558, 10958.726031849188, 10783.676489705322, 10854.45727713611, 10855.185861060452, 10856.457177141112, 10860.619878304222, 43540.3468947966, 43836.780816095714, 43876.56123438757, 43938.0, 43982.78008609937, 3525.5769307682986, 3807.505024346817, 4062.106336605942, 4284.271673815459, 4397.252467080604, 33741.493877591856, 33795.0, 33936.66063339385, 34177.316453670785, 35567.4664880027, 4589.58693717567, 4661.86014419568, 4670.0, 4695.88260293492, 4773.665843390964, 326665.0, 326932.36533817416, 328230.0, 328607.0, 330069.0, 38391.23217535634, 63328.68335658292, 63640.045399319046, 63667.68166159139, 63710.68144659247, 39100.41349379761, 40826.32563069338, 41028.179436411105, 41046.79476602598, 41170.1765964679, 15882.76175857363, 16177.272022759003, 16180.838191618168, 16191.595210119842, 16225.59436014109, 12172.756544869053, 12471.064670149775, 12961.740765184644, 13099.083064185606, 13360.465581376831, 9370.812583748288, 9450.291228157916, 9569.234461243223, 9604.135627793532, 9662.903370966342, 3523.894283171509, 3618.873339433107, 3667.651573100551, 3669.7798132112157, 3717.237966216919, 1051.7423231308226, 1076.359566058194, 1173.5540494611994, 1189.4944648524342, 1197.4675851900515, 32409.51385729216, 32722.83638581792, 32958.50562241568, 33030.669693302756, 33397.83301083479, 1169.1465230381698, 1188.518649946773, 1195.3246415775059, 1195.4992967651078, 1219.5121951219405, 16702.58243543921, 17728.37950671746, 17738.171649774282, 17827.643447130984, 17943.641127177383, 483232.0, 548240.0, 549500.0, 551245.0, 555546.0, 60200.0, 60648.696756515936, 60979.0, 65294.0, 65733.34266657368, 1441.08491108145, 1453.6729235922044, 1481.0, 1506.6610012747262, 1515.2196618741357, 33014.66985330116, 34417.65582344145, 34730.305393891475, 34785.13037174091, 34789.0, 57217.0, 57756.4224357751, 57816.0, 57921.420785793285, 57974.13038804506, 337968.0, 338454.0, 338791.0, 339479.0, 339651.0, 38736.6126338733, 40603.0, 42855.571444286405, 43329.56670433255, 48215.75892120657, 50723.23915141202, 51174.74412627913, 51218.23172652339, 51499.0, 51619.741901290254, 42083.7895810519, 42973.35539966966, 42984.570154299305, 44082.33876491791, 45043.549564503934, 40814.38778418267, 43815.78092109519, 46448.0, 46775.53224467712, 47633.0, 42787.7860610695, 43400.0, 43628.56371436245, 43899.34150987674, 44071.118577628906, 36709.0, 38787.224255514164, 39116.804415977735, 39213.41179882361, 39308.6069139305, 28702.85648571744, 28741.28146796263, 28798.424031519673, 29051.56422653704, 29210.561841572817], "value": 20374.152363079997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.64103985892757, 396.726258881372, 426.0775421213074, 434.86519179054494, 444.768720265462, 18273.908630456845, 19327.23648611886, 19559.315423960164, 19707.0, 19761.604767904635, 19123.71314430285, 19696.409107726755, 19964.800351996477, 20252.696209556867, 20477.692834607493, 5523.0, 5954.612950158247, 5976.910346344808, 5985.940140598604, 5987.910181347262, 5732.942670573303, 5815.534757219412, 5845.386234445365, 5949.464548190662, 5952.494038006775, 5729.0833466645345, 5759.107338362561, 5767.971160144193, 5770.798022069229, 5773.884522309551, 5644.57665675074, 5720.6281591696825, 5760.596758226926, 5763.308402991626, 5768.3654797972185, 5174.974125129388, 5177.068127737006, 5177.094008548526, 5179.715115668637, 5180.766865491062, 22122.0, 22952.885235573714, 23039.0, 23157.421064473354, 23682.289531314087, 2188.9014994325294, 2339.9181028664084, 2382.213869423086, 2466.149178533421, 2677.852718100504, 10283.680893783694, 10333.689989300334, 10352.275340726152, 10840.186985976083, 11020.338779673246, 1951.5511432370633, 1983.841292696581, 2008.4878356019267, 2013.2047841102683, 2046.2019812273224, 85551.5722421384, 85941.0, 86001.56999215027, 86200.99999999937, 86644.56677716572, 11515.481803318871, 11542.422878856023, 11643.650690479299, 11672.649820505398, 11830.52677892892, 17009.149542522824, 17023.0, 17034.31862725502, 17038.829611703724, 17054.488365349058, 8072.0, 8182.7545173644885, 8221.10721021042, 8222.917770822216, 8409.579521023925, 7781.727639532703, 7815.726449574351, 7951.165127661628, 8003.5197888126895, 8028.638711258008, 4696.647751418657, 4857.222844344888, 4941.0, 5076.466970967996, 5101.2603172539775, 2042.377074992112, 2127.606392817334, 2136.1135128921633, 2153.644648632958, 2175.8585691929975, 763.5266134996338, 906.9773255668529, 914.5564401265381, 955.6273053509137, 1024.5082360467018, 18954.715679264547, 18963.620727585647, 19250.903745481184, 19332.71000934959, 19793.30723424702, 1025.1747343388645, 1027.1885210683627, 1028.4343611014062, 1035.0, 1045.8483519889573, 10329.225308101923, 11125.888741112647, 11163.162762792823, 11180.44097795107, 11180.832287515694, 448346.0, 458330.0, 460764.0, 462982.0, 471151.0, 89182.0, 89523.55238223767, 89597.55201224082, 89616.55191724, 90245.54877225703, 979.250873082107, 994.6866736977829, 1020.4438580973388, 1028.6502589119734, 1029.6036026129993, 16261.674766504368, 16339.428120015742, 16999.7450038252, 17152.313907443564, 17205.311787528357, 40061.799691002525, 40220.0, 40833.0, 40933.79533102315, 41919.0, 53951.460485394644, 54026.72986635042, 56991.715041424526, 57223.713881430325, 57434.7128264356, 7856.764297071097, 7921.247481489249, 7965.681372745025, 8035.316998054997, 8333.499990000619, 7577.469577129768, 10373.948130259301, 11294.60468883585, 12653.430595623035, 12801.29592872401, 10867.239293249713, 11159.0, 11173.441327933733, 11617.186796924134, 11939.820902686293, 10851.240413171003, 11088.168387370819, 11175.664730058112, 11305.15211359135, 11825.40872956366, 11632.825507617223, 11646.417679116179, 11663.825042624198, 11847.585334513595, 11908.761824763284, 7875.369970402468, 7956.5226086435, 8143.877841832259, 8235.13531079228, 8252.21603947624, 10611.204159688208, 11303.886961130283, 11563.0, 11640.476178571815, 11969.0], "value": 9204.988679315835, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.3059857764722, 1533.5169421632186, 1718.93124275029, 1800.8739388242827, 1855.7773067231935, 8406.411551191419, 8947.686830960918, 8955.462672239662, 8956.865647015291, 8962.686305979292, 7658.808529786744, 7847.646855891484, 7851.371890248781, 8045.436819422628, 8796.516191609458, 2373.501564671417, 2458.0536493450063, 2464.125235541375, 2474.987625061872, 2475.665785119013, 2417.1419146203107, 2436.1717016214484, 2466.2477944227003, 2498.362917456046, 2503.7371076037025, 2401.891914863835, 2416.7099948006176, 2423.2730180945646, 2423.866687332196, 2441.2066078524463, 2410.252821625293, 2414.420539070628, 2422.467057247403, 2425.842320249178, 2434.573949558829, 2412.553677569655, 2441.145599040339, 2442.5237078769646, 2443.6334549817493, 2453.4970331082086, 8628.137186281385, 8838.955805220998, 8899.688510902088, 8904.020557738644, 8906.421082629673, 5300.973495132538, 5432.158015507603, 5435.972820135874, 5446.645968012067, 5446.754896029649, 3239.1902024493875, 3395.864165433404, 3636.8545258189906, 3637.2179981303884, 3653.0502069461863, 1129.6215767717742, 1141.2296699727733, 1148.5233628044434, 1156.5373850459798, 1216.4769149265812, 12014.639560813102, 12029.157958942878, 12039.699007524794, 12051.517939282507, 12058.45736941831, 4751.408278226763, 4824.0834241494, 4830.95169048305, 4922.0, 4933.876653083702, 10177.592896284214, 10218.846717299246, 10233.283670143019, 10246.743831404125, 10254.077133058061, 5529.834104976857, 5530.391656917735, 5537.750801213955, 5548.250986116904, 5550.5282051026115, 4968.378952630921, 4989.002199560103, 5016.372953380827, 5108.335916330853, 5126.2054381570915, 3937.0, 3978.8806335809973, 4062.1266427718183, 4074.0629655179473, 4097.815598298083, 1292.3538230884558, 1300.4603089717662, 1331.0765943211966, 1349.0556610372778, 1356.5319964612193, 902.278177458031, 973.6202880876464, 1001.2890847498212, 1003.7841863999275, 1013.3210748798323, 5869.589128761031, 5878.441548052928, 5985.820425387245, 6023.518118550505, 6070.3929607038945, 484.30502229301067, 486.8052778888473, 487.5611949245636, 1020.5457223456544, 1128.1144301723273, 4204.978975105105, 4324.610785029363, 4370.650347972155, 4374.12517496502, 4395.648348132142, 10662.73343166427, 10781.946090269656, 10940.234183607072, 10984.945075274572, 10985.505652245669, 10105.747356316004, 10842.512086956105, 10859.891401086046, 10878.564857405616, 10903.454827258605, 7951.880721789178, 8267.173282671685, 8291.58542072894, 8297.58512074394, 8315.29320007794, 6170.56806023592, 6196.256449226122, 6228.781992630236, 6419.069234960811, 6439.517036222208, 9840.901590984286, 9861.852072219066, 9923.702288931343, 9943.900560994298, 10003.249756268164, 8921.553922303989, 9599.520023998632, 10022.599096036369, 10265.692029239135, 10303.330283531546, 7236.6019868907715, 7585.848283034198, 7733.574653394117, 7795.64919578609, 8013.198680132174, 8496.617652205789, 8509.829803403773, 8574.742757717278, 8582.613782379933, 8592.0, 7217.783466496014, 7261.709531618676, 7316.487845850952, 7376.852462950818, 7597.6201189941385, 7110.25342339047, 7147.0, 7195.928040719735, 7211.1707153678, 7302.56184628924, 7023.824404389931, 7042.894356584758, 7050.753223637148, 7118.9644051779405, 7127.717010938081, 4997.700137991732, 5001.199808030698, 5031.3207716959205, 5077.035363280965, 5135.3324067870935, 5079.136546786981, 5180.7150606717, 5235.3717553893775, 5241.746049198881, 5303.098473259478], "value": 4670.080203269112, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8870006797554, 328.25813661125846, 328.6155198417851, 334.9715274201693, 342.47772147475104, 5388.78444862206, 5404.567634589233, 5407.188262103704, 5437.592180586457, 5439.824070371853, 5076.593872490201, 5193.558547523456, 5210.9478905210935, 5289.878971406869, 5390.4879036491475, 4217.810198541058, 4227.8308867645255, 4234.174336004465, 4250.851220207301, 4255.978565144374, 4247.426597409341, 4250.808713607879, 4269.50900646425, 4283.693473490584, 4285.614294713475, 3986.800659967005, 4157.792110394484, 4164.916701665965, 4181.832726690929, 4186.455760751113, 4141.772202528859, 4156.168766246763, 4158.293090174662, 4160.7517744676625, 4187.706860519765, 3688.3729765939856, 3691.6492933171576, 3694.371956767356, 3700.833462494194, 3704.0924973381425, 5003.874903127415, 5209.947900520984, 5276.7889284428575, 5297.046531624306, 5297.152455607084, 4706.364640773486, 4719.952800471986, 4727.267273572602, 4745.810167593292, 4746.715197088151, 5536.529395001429, 5548.389677135512, 5569.136783798518, 5590.496855283044, 5598.496135347838, 3882.320593896057, 3933.724639275252, 3966.206758648253, 3986.5814089520472, 4008.158286759784, 5757.769689212427, 5784.855378615526, 5791.754772723884, 5823.272090988627, 5832.2418085649015, 4122.299209134454, 4139.855105071369, 4148.688848336386, 4177.665786737054, 4183.832646694159, 4112.773797441169, 4176.498820141603, 4212.326027835532, 4227.809748561261, 4231.87304380869, 4702.224133018082, 4729.148753224453, 4748.358971538867, 4798.3042458843975, 4806.567408933143, 5605.7106865420365, 5622.887542249132, 5641.0, 5659.292588426447, 5661.801836935688, 1289.471316760124, 1307.5031488034676, 1362.8773410393112, 1392.9303534823218, 1401.7126489069717, 949.4161090929028, 950.235060776068, 959.9712008639752, 962.1581116523042, 977.2621670638622, 5241.606879484054, 5253.028189784825, 5259.132243179833, 5285.814996475105, 5291.867703307448, 5512.366077901012, 5541.919325731525, 5544.972275138599, 5548.278723765885, 5550.972245138829, 4970.3538539990295, 5228.55557277628, 5240.244518086408, 5268.078086334876, 5287.841364759063, 2939.4562006028955, 2957.269997051706, 2969.8515074246634, 2970.2425881400536, 2976.479116154664, 5683.232763576864, 5713.200151978726, 5736.017271019046, 5741.478508195331, 5764.942350576441, 5586.608937374344, 5644.5484361251, 5848.567101060183, 5853.297604287428, 5866.472017518358, 5999.760009599567, 6003.279606447254, 6021.488173505301, 6030.819075427744, 6031.60794548353, 5613.270274864405, 5757.2728181544535, 5811.82564523065, 5823.213866128019, 5829.94170058294, 5714.971425142848, 5742.454466825645, 5751.827445176651, 5754.0, 5764.221830053057, 5957.523398128226, 5963.165156878127, 5989.436285410174, 5990.760369585168, 6000.919834429845, 3928.7053470990363, 4040.9795102448775, 4114.218298523271, 4142.5857414258335, 4149.128682976488, 5548.278723765885, 5723.713814309352, 5741.598088133791, 5747.13218204077, 5764.19301297827, 5523.232565578976, 5578.386377498391, 5677.971610141923, 5685.573581981451, 5694.0, 5600.215969764317, 5649.661020338793, 5652.463016013472, 5652.519535839499, 5666.631668941505, 5345.358556973188, 5566.944330556643, 5607.943920560905, 5617.971910140586, 5619.381867994435, 5686.545076393962, 5688.084392232033, 5693.772249110155, 5695.715214239354, 5706.9714651426475, 5459.317585301837, 5563.582731295088, 5584.916226256691, 5593.468620481048, 5600.971995139998], "value": 4264.184953833348, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.6227672993691, 815.4617952151581, 821.7206149909026, 829.2205326992627, 836.8451836410264, 13655.726885462285, 14306.999999999987, 14309.570712878603, 14326.426942922271, 14400.351984160712, 14448.349824257908, 14601.707965840676, 14605.123692578427, 14619.561413157595, 14623.341949612266, 720.6792977125182, 739.9852002959965, 845.2899564365931, 863.5725315968589, 867.8437881181385, 865.4807115730574, 868.1405408645427, 868.4658934755112, 868.8088620503479, 868.8870446841902, 900.6172376739892, 904.6607522179182, 904.7873749668822, 904.9773755656129, 905.1536813079758, 907.4872696926216, 907.4963395315597, 907.9455232686026, 908.0601577367426, 908.3777612335538, 668.0146783494356, 668.5019660353069, 668.7625892808031, 669.1167658690531, 669.1234482827512, 14525.418983240657, 14572.927135364362, 14577.708445831024, 14587.0, 14599.78100328496, 14193.0, 15133.243337833064, 15226.695466090616, 15367.538973830802, 15739.685206295924, 11415.885841141566, 11435.256708313933, 11444.48499817502, 11590.76818463626, 11708.0, 3760.2291530236234, 3806.5725352992627, 3826.9617303827163, 3827.4641550182996, 3872.4191371294532, 59925.0, 60599.39400605982, 61027.0, 61295.08057379143, 61542.69228653873, 10898.72753181161, 11033.172512061628, 11044.226904116635, 11132.833007504894, 11176.329420234812, 19023.048847557842, 19176.712349314494, 20535.4866128348, 21982.89008554947, 22427.327180184293, 7853.41099417546, 7970.1631328709655, 7981.72063977758, 8146.389020823462, 8189.209312552104, 4718.7168769873915, 4753.667243293005, 4773.522647735199, 4826.975865120652, 4863.562279394871, 3395.0833275015607, 3472.2708231271213, 3492.022233774547, 3648.671619554253, 3799.240151969562, 673.0678010954765, 674.8549061951704, 680.9761658342034, 696.665600511747, 697.7836870570139, 708.3589351636776, 741.1180694973073, 767.4167632599265, 771.7761849063709, 786.5595266650694, 8365.24712775841, 8973.461592304351, 9056.184943355129, 9113.726588202364, 9310.208632266333, 711.2673945835797, 718.0, 724.1382754522102, 736.8268456912622, 744.4863044499278, 4077.612626800449, 4098.938515922264, 4463.843765468193, 4501.797419116082, 4508.616767574793, 76174.61912690512, 84171.5791421039, 85669.14330856736, 87336.56331718301, 87442.0, 72298.0, 72359.0, 72948.63525682337, 74908.0, 75654.0, 61320.38679613147, 63119.0, 64019.6799016002, 65611.67194163999, 68130.3186968134, 8463.957680211559, 8804.47173169612, 8942.396370796827, 9092.454452732858, 9118.22495087925, 33485.0, 34609.65390346165, 42605.78697106495, 44203.778981104886, 45522.54477455183, 60852.69573652103, 61021.69489152526, 61627.38372616217, 63211.57518973812, 64915.67542162259, 10323.535440905327, 10798.298110622783, 11152.498137583665, 11435.142364322543, 11460.426978651201, 12557.372131393577, 12573.622791316275, 12705.237685738884, 12820.551280705131, 13168.407421665856, 12195.51217951272, 12414.379281036092, 12902.483900644245, 12909.0, 13734.93132534331, 12226.14416990802, 12337.814932776195, 12377.195482293622, 12654.620361389174, 12764.48942042345, 11719.0, 12568.120231584067, 12755.0, 12779.80830287565, 13413.463461461823, 9884.802303954024, 10081.747956301151, 10287.84568231492, 10454.268201225841, 10580.41807700584, 10529.473526323807, 10740.593270953552, 10951.671449856518, 11100.666979990614, 11327.490262938352], "value": 7125.466503763904, "unit": "score"}], "name": "dromaeo_css", "value": 7274.717244525533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 116.0, 156.0, 125.0, 119.0, 118.0, 117.0, 144.0, 118.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 160.0, 160.0, 160.0, 162.0, 159.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 113.0, 75.0, 75.0, 75.0, 75.0, 108.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 106.0, 82.0, 81.0, 82.0, 100.0, 82.0, 83.0, 111.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 48.0, 49.0, 49.0, 50.0, 50.0, 50.0, 49.0, 50.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 57.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 75.0, 76.0, 74.0, 75.0, 78.0, 75.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 123.0, 127.0, 122.0, 121.0, 121.0, 120.0, 168.0, 128.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 155.0, 161.0, 158.0, 154.0, 153.0, 158.0, 155.0, 165.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 70.0, 62.0, 62.0, 68.0, 62.0, 61.0, 62.0, 60.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1445.8000000000002, "alertThreshold": 2.0}]} 05:23:00 INFO - Return code: 0 05:23:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:00 INFO - # TBPL SUCCESS # 05:23:00 INFO - Running post-action listener: _resource_record_post_action 05:23:00 INFO - [mozharness: 2017-02-22 13:23:00.304776Z] Finished run-tests step (success) 05:23:00 INFO - Running post-run listener: _resource_record_post_run 05:23:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 983040; Write bytes: 321724416; Read time: 172; Write time: 223972 05:23:00 INFO - TinderboxPrint: CPU usage
12.9% 05:23:00 INFO - TinderboxPrint: I/O read bytes / time
983,040 / 172 05:23:00 INFO - TinderboxPrint: I/O write bytes / time
321,724,416 / 223,972 05:23:00 INFO - TinderboxPrint: CPU idle
8,262.6 (87.0%) 05:23:00 INFO - TinderboxPrint: CPU user
1,185.8 (12.5%) 05:23:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:23:00 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101105664; Read time: 0; Write time: 77196 05:23:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 983040; Write bytes: 220618752; Read time: 172; Write time: 146776 05:23:00 INFO - Running post-run listener: _upload_blobber_files 05:23:00 INFO - Blob upload gear active. 05:23:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:00 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 05:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:23:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:23:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:02 INFO - (blobuploader) - INFO - Done attempting. 05:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:05 INFO - (blobuploader) - INFO - Done attempting. 05:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:06 INFO - (blobuploader) - INFO - Done attempting. 05:23:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:23:06 INFO - Return code: 0 05:23:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:23:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:23:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/468e9d566496962d73ccb62e671b47b71734339dcfb6a6ced0dcda1835fcfd303db914052519ea5561f3f52c9f7197b399e471327c8c30b44e081bf6d8ff830b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76632932e768eabc49de23ec303fabd3d57f6cb521fedc2e52ddd4c2c47a7a60f7444b32611c7e658c76f034810ef810f4fe7de9ce7c34c2812d3be3f46ff6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02805e46e38c379a0effa603924d748f3900b190107912f4f313d18b099fbbb55f9f28ca53d66757f577f012d109697cf82c6d459784ca18d67e790a0e94e3ea"} 05:23:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:23:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:23:06 INFO - Contents: 05:23:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/468e9d566496962d73ccb62e671b47b71734339dcfb6a6ced0dcda1835fcfd303db914052519ea5561f3f52c9f7197b399e471327c8c30b44e081bf6d8ff830b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76632932e768eabc49de23ec303fabd3d57f6cb521fedc2e52ddd4c2c47a7a60f7444b32611c7e658c76f034810ef810f4fe7de9ce7c34c2812d3be3f46ff6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02805e46e38c379a0effa603924d748f3900b190107912f4f313d18b099fbbb55f9f28ca53d66757f577f012d109697cf82c6d459784ca18d67e790a0e94e3ea"} 05:23:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:23:06 INFO - Copying logs to upload dir... 05:23:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:23:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.971934 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-22 05:23:05.798909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 05:23:05.802224) ========= 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=920470bf432669ad7e3a5387000001ca-1487768551.361-957529201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/468e9d566496962d73ccb62e671b47b71734339dcfb6a6ced0dcda1835fcfd303db914052519ea5561f3f52c9f7197b399e471327c8c30b44e081bf6d8ff830b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76632932e768eabc49de23ec303fabd3d57f6cb521fedc2e52ddd4c2c47a7a60f7444b32611c7e658c76f034810ef810f4fe7de9ce7c34c2812d3be3f46ff6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02805e46e38c379a0effa603924d748f3900b190107912f4f313d18b099fbbb55f9f28ca53d66757f577f012d109697cf82c6d459784ca18d67e790a0e94e3ea"} build_url:https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/UobC7ds0ToOVdWpjhs9uuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/468e9d566496962d73ccb62e671b47b71734339dcfb6a6ced0dcda1835fcfd303db914052519ea5561f3f52c9f7197b399e471327c8c30b44e081bf6d8ff830b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76632932e768eabc49de23ec303fabd3d57f6cb521fedc2e52ddd4c2c47a7a60f7444b32611c7e658c76f034810ef810f4fe7de9ce7c34c2812d3be3f46ff6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02805e46e38c379a0effa603924d748f3900b190107912f4f313d18b099fbbb55f9f28ca53d66757f577f012d109697cf82c6d459784ca18d67e790a0e94e3ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 05:23:05.836944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:23:05.837276) ========= 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=920470bf432669ad7e3a5387000001ca-1487768551.361-957529201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 05:23:05.915515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 05:23:05.916215) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 05:23:05.916850) ========= ========= Total master_lag: -0.12 =========