builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1478974391.25 results: success (0) buildid: 20161112073220 builduid: f76b8c20262240188aa8abbac783e499 revision: b37be3d705d929ee52280051d58cedc70a47626f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.254188) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.254707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.255042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.270291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.270722) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-12 10:13:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-11-12 10:13:12 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.403318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.403667) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019524 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.453667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:11.454056) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b37be3d705d929ee52280051d58cedc70a47626f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b37be3d705d929ee52280051d58cedc70a47626f --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=7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-12 10:13:12,453 truncating revision to first 12 chars 2016-11-12 10:13:12,453 Setting DEBUG logging. 2016-11-12 10:13:12,453 attempt 1/10 2016-11-12 10:13:12,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b37be3d705d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 10:13:12,864 unpacking tar archive at: mozilla-central-b37be3d705d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748397 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:12.217927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:12.218267) ========= script_repo_revision: b37be3d705d929ee52280051d58cedc70a47626f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:12.218726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:12.219040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 10:13:12.228145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-12 10:13:12.228453) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:13 INFO - MultiFileLogger online at 20161112 10:13:13 in /builds/slave/test 10:13:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:13:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:13 INFO - {'append_to_log': False, 10:13:13 INFO - 'base_work_dir': '/builds/slave/test', 10:13:13 INFO - 'blob_upload_branch': 'Firefox', 10:13:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:13 INFO - 'branch': 'Firefox', 10:13:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:13 INFO - 'config_files': ('talos/linux_config.py',), 10:13:13 INFO - 'default_actions': ('clobber', 10:13:13 INFO - 'read-buildbot-config', 10:13:13 INFO - 'download-and-extract', 10:13:13 INFO - 'populate-webroot', 10:13:13 INFO - 'create-virtualenv', 10:13:13 INFO - 'install', 10:13:13 INFO - 'run-tests'), 10:13:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:13 INFO - 'download_minidump_stackwalk': True, 10:13:13 INFO - 'download_symbols': 'ondemand', 10:13:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:13 INFO - 'installer_path': 'installer.exe', 10:13:13 INFO - 'log_level': 'info', 10:13:13 INFO - 'log_name': 'talos', 10:13:13 INFO - 'log_to_console': True, 10:13:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:13 INFO - 'opt_config_files': (), 10:13:13 INFO - 'pip_index': False, 10:13:13 INFO - 'sps_profile': False, 10:13:13 INFO - 'sps_profile_interval': 0, 10:13:13 INFO - 'suite': 'dromaeojs', 10:13:13 INFO - 'system_bits': '32', 10:13:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:13 INFO - 'title': 'talos-linux64-ix-005', 10:13:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:13 INFO - 'use_talos_json': True, 10:13:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:13 INFO - 'work_dir': 'build'} 10:13:13 INFO - [mozharness: 2016-11-12 18:13:13.331343Z] Running clobber step. 10:13:13 INFO - Running pre-action listener: _resource_record_pre_action 10:13:13 INFO - Running main action method: clobber 10:13:13 INFO - rmtree: /builds/slave/test/build 10:13:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:13 INFO - Running post-action listener: _resource_record_post_action 10:13:13 INFO - [mozharness: 2016-11-12 18:13:13.793679Z] Finished clobber step (success) 10:13:13 INFO - [mozharness: 2016-11-12 18:13:13.793779Z] Running read-buildbot-config step. 10:13:13 INFO - Running pre-action listener: _resource_record_pre_action 10:13:13 INFO - Running main action method: read_buildbot_config 10:13:13 INFO - Using buildbot properties: 10:13:13 INFO - { 10:13:13 INFO - "project": "", 10:13:13 INFO - "product": "firefox", 10:13:13 INFO - "script_repo_revision": "production", 10:13:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:13:13 INFO - "repository": "", 10:13:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:13:13 INFO - "buildid": "20161112073220", 10:13:13 INFO - "pgo_build": "True", 10:13:13 INFO - "basedir": "/builds/slave/test", 10:13:13 INFO - "buildnumber": 83, 10:13:13 INFO - "slavename": "talos-linux64-ix-005", 10:13:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:13:13 INFO - "platform": "ubuntu64_hw", 10:13:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:13:13 INFO - "branch": "mozilla-central", 10:13:13 INFO - "repo_path": "mozilla-central", 10:13:13 INFO - "revision": "b37be3d705d929ee52280051d58cedc70a47626f", 10:13:13 INFO - "stage_platform": "linux64-pgo", 10:13:13 INFO - "builduid": "f76b8c20262240188aa8abbac783e499", 10:13:13 INFO - "slavebuilddir": "test" 10:13:13 INFO - } 10:13:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:13:13 INFO - Running post-action listener: _resource_record_post_action 10:13:13 INFO - [mozharness: 2016-11-12 18:13:13.796206Z] Finished read-buildbot-config step (success) 10:13:13 INFO - [mozharness: 2016-11-12 18:13:13.796295Z] Running download-and-extract step. 10:13:13 INFO - Running pre-action listener: _resource_record_pre_action 10:13:13 INFO - Running main action method: download_and_extract 10:13:13 INFO - mkdir: /builds/slave/test/build/tests 10:13:13 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')]} 10:13:13 INFO - trying https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:13:13 INFO - Downloading https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:13:14 INFO - Downloaded 1361 bytes. 10:13:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:13:14 INFO - Using the following test package requirements: 10:13:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'jsshell-linux-x86_64.zip'], 10:13:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:13:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:14 INFO - Fetch https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:13:14 INFO - Http code: 200 10:13:14 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:13:14 INFO - x-amz-cf-id: pdGbiXRMZRbtbLuUiO6581wOh670FQYXY3AX54PnsJaXRJZUipqi9A== 10:13:14 INFO - x-amz-version-id: _oUEsNg4BHLozlGq02l6SJmtcT24WL8E 10:13:15 INFO - Expected file size: 21974540 10:13:15 INFO - Obtained file size: 21974540 10:13:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:13:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:13:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:19 INFO - Fetch https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:13:19 INFO - Http code: 200 10:13:19 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 10:13:19 INFO - x-amz-cf-id: c7z1ype1-AulLUmUdssUgjJ1QDeihIPliNjmhYLiQAoE-kzk0Jz7zg== 10:13:19 INFO - x-amz-version-id: _oUEsNg4BHLozlGq02l6SJmtcT24WL8E 10:13:20 INFO - Expected file size: 21974540 10:13:20 INFO - Obtained file size: 21974540 10:13:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:13:24 INFO - Fetch https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:13:25 INFO - Http code: 200 10:13:25 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 10:13:25 INFO - x-amz-cf-id: zGPmnzq7UwjQbxzzEtV96yDMS75LeuZI4HnKg_tMZSMaQ3Zjap4k_A== 10:13:25 INFO - x-amz-version-id: XfDDsH.CSUj.IPsd69PFfCRavfHNdiLC 10:13:25 INFO - Expected file size: 14409038 10:13:25 INFO - Obtained file size: 14409038 10:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:25 INFO - trying https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:13:27 INFO - Downloaded 59604906 bytes. 10:13:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:13:27 INFO - mkdir: /builds/slave/test/properties 10:13:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:27 INFO - Contents: 10:13:27 INFO - build_url:https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:13:27 INFO - Running post-action listener: _resource_record_post_action 10:13:27 INFO - Running post-action listener: set_extra_try_arguments 10:13:27 INFO - [mozharness: 2016-11-12 18:13:27.977344Z] Finished download-and-extract step (success) 10:13:27 INFO - [mozharness: 2016-11-12 18:13:27.977571Z] Running populate-webroot step. 10:13:27 INFO - Running pre-action listener: _resource_record_pre_action 10:13:27 INFO - Running main action method: populate_webroot 10:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:27 INFO - '--tppagecycles', 10:13:27 INFO - '7'], 10:13:27 INFO - 'tests': ['tsvgm']}}, 10:13:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['damp', 'tps']}, 10:13:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'tests': ['damp', 'tps']}, 10:13:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['dromaeo_dom']}, 10:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['basic_compositor_video']}, 10:13:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['a11yr', 10:13:27 INFO - 'ts_paint', 10:13:27 INFO - 'tpaint', 10:13:27 INFO - 'sessionrestore', 10:13:27 INFO - 'sessionrestore_no_auto_restore', 10:13:27 INFO - 'tabpaint']}, 10:13:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tsvgx', 10:13:27 INFO - 'tsvgr_opacity', 10:13:27 INFO - 'tart', 10:13:27 INFO - 'tscrollx', 10:13:27 INFO - 'cart']}, 10:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:27 INFO - 'tsvgr_opacity', 10:13:27 INFO - 'tart', 10:13:27 INFO - 'tscrollx', 10:13:27 INFO - 'cart']}, 10:13:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s'], 10:13:27 INFO - 'tests': ['tp5o']}, 10:13:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'tests': ['tp5o']}, 10:13:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'talos_options': ['--disable-e10s', 10:13:27 INFO - '--xperf_path', 10:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:27 INFO - 'tests': ['tp5n']}, 10:13:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:27 INFO - 'talos_options': ['--xperf_path', 10:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:27 INFO - 'tests': ['tp5n']}}, 10:13:27 INFO - 'talos.zip': {'path': '', 10:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:27 INFO - Running post-action listener: _resource_record_post_action 10:13:27 INFO - [mozharness: 2016-11-12 18:13:27.992925Z] Finished populate-webroot step (success) 10:13:27 INFO - [mozharness: 2016-11-12 18:13:27.993012Z] Running create-virtualenv step. 10:13:27 INFO - Running pre-action listener: _resource_record_pre_action 10:13:27 INFO - Running main action method: create_virtualenv 10:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:27 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 10:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:28 INFO - Using real prefix '/usr' 10:13:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:30 INFO - Installing pip.................done. 10:13:30 INFO - Return code: 0 10:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:30 INFO - Reading from file tmpfile_stdout 10:13:30 INFO - Output received: 10:13:30 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) 10:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:30 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')]} 10:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 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')]} 10:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:30 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 10:13:30 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 10:13:30 INFO - Using env: {'DISPLAY': ':0', 10:13:30 INFO - 'HOME': '/home/cltbld', 10:13:30 INFO - 'LANG': 'en_US.UTF-8', 10:13:30 INFO - 'LANGUAGE': 'en_US:en', 10:13:30 INFO - 'LOGNAME': 'cltbld', 10:13:30 INFO - 'MAIL': '/var/mail/cltbld', 10:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:30 INFO - 'MOZ_NO_REMOTE': '1', 10:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:30 INFO - 'NO_EM_RESTART': '1', 10:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:30 INFO - 'PWD': '/builds/slave/test', 10:13:30 INFO - 'SHELL': '/bin/bash', 10:13:30 INFO - 'SHLVL': '1', 10:13:30 INFO - 'TERM': 'linux', 10:13:30 INFO - 'TMOUT': '86400', 10:13:30 INFO - 'USER': 'cltbld', 10:13:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:30 INFO - '_': '/tools/buildbot/bin/python'} 10:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:30 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 10:13:30 INFO - Cleaning up... 10:13:30 INFO - Return code: 0 10:13:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:30 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')]} 10:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 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')]} 10:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:31 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:31 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 10:13:31 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 10:13:31 INFO - Using env: {'DISPLAY': ':0', 10:13:31 INFO - 'HOME': '/home/cltbld', 10:13:31 INFO - 'LANG': 'en_US.UTF-8', 10:13:31 INFO - 'LANGUAGE': 'en_US:en', 10:13:31 INFO - 'LOGNAME': 'cltbld', 10:13:31 INFO - 'MAIL': '/var/mail/cltbld', 10:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:31 INFO - 'MOZ_NO_REMOTE': '1', 10:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:31 INFO - 'NO_EM_RESTART': '1', 10:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:31 INFO - 'PWD': '/builds/slave/test', 10:13:31 INFO - 'SHELL': '/bin/bash', 10:13:31 INFO - 'SHLVL': '1', 10:13:31 INFO - 'TERM': 'linux', 10:13:31 INFO - 'TMOUT': '86400', 10:13:31 INFO - 'USER': 'cltbld', 10:13:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:31 INFO - '_': '/tools/buildbot/bin/python'} 10:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:31 INFO - Downloading/unpacking psutil>=3.1.1 10:13:31 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 10:13:31 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 10:13:31 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 10:13:31 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 10:13:31 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 10:13:31 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 10:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:33 INFO - Installing collected packages: psutil 10:13:33 INFO - Running setup.py install for psutil 10:13:33 INFO - building 'psutil._psutil_linux' extension 10:13:33 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 10:13:33 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 10:13:33 INFO - building 'psutil._psutil_posix' extension 10:13:33 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 10:13:33 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 10:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:33 INFO - Successfully installed psutil 10:13:33 INFO - Cleaning up... 10:13:33 INFO - Return code: 0 10:13:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:33 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')]} 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 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')]} 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:33 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 10:13:33 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 10:13:33 INFO - Using env: {'DISPLAY': ':0', 10:13:33 INFO - 'HOME': '/home/cltbld', 10:13:33 INFO - 'LANG': 'en_US.UTF-8', 10:13:33 INFO - 'LANGUAGE': 'en_US:en', 10:13:33 INFO - 'LOGNAME': 'cltbld', 10:13:33 INFO - 'MAIL': '/var/mail/cltbld', 10:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:33 INFO - 'MOZ_NO_REMOTE': '1', 10:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:33 INFO - 'NO_EM_RESTART': '1', 10:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:33 INFO - 'PWD': '/builds/slave/test', 10:13:33 INFO - 'SHELL': '/bin/bash', 10:13:33 INFO - 'SHLVL': '1', 10:13:33 INFO - 'TERM': 'linux', 10:13:33 INFO - 'TMOUT': '86400', 10:13:33 INFO - 'USER': 'cltbld', 10:13:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:33 INFO - '_': '/tools/buildbot/bin/python'} 10:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:34 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 10:13:34 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 10:13:34 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 10:13:34 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 10:13:34 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 10:13:34 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 10:13:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:35 INFO - Installing collected packages: mozsystemmonitor 10:13:35 INFO - Running setup.py install for mozsystemmonitor 10:13:36 INFO - Successfully installed mozsystemmonitor 10:13:36 INFO - Cleaning up... 10:13:36 INFO - Return code: 0 10:13:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:36 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')]} 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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')]} 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:36 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 10:13:36 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 10:13:36 INFO - Using env: {'DISPLAY': ':0', 10:13:36 INFO - 'HOME': '/home/cltbld', 10:13:36 INFO - 'LANG': 'en_US.UTF-8', 10:13:36 INFO - 'LANGUAGE': 'en_US:en', 10:13:36 INFO - 'LOGNAME': 'cltbld', 10:13:36 INFO - 'MAIL': '/var/mail/cltbld', 10:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:36 INFO - 'MOZ_NO_REMOTE': '1', 10:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:36 INFO - 'NO_EM_RESTART': '1', 10:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:36 INFO - 'PWD': '/builds/slave/test', 10:13:36 INFO - 'SHELL': '/bin/bash', 10:13:36 INFO - 'SHLVL': '1', 10:13:36 INFO - 'TERM': 'linux', 10:13:36 INFO - 'TMOUT': '86400', 10:13:36 INFO - 'USER': 'cltbld', 10:13:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:36 INFO - '_': '/tools/buildbot/bin/python'} 10:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:36 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 10:13:36 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 10:13:36 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 10:13:36 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 10:13:36 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 10:13:36 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 10:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:38 INFO - warning: no files found matching '*.txt' 10:13:38 INFO - no previously-included directories found matching 'build' 10:13:38 INFO - no previously-included directories found matching 'dist' 10:13:38 INFO - no previously-included directories found matching '.git*' 10:13:38 INFO - Installing collected packages: jsonschema, functools32 10:13:38 INFO - Running setup.py install for functools32 10:13:38 INFO - warning: no files found matching '*.txt' 10:13:38 INFO - no previously-included directories found matching 'build' 10:13:38 INFO - no previously-included directories found matching 'dist' 10:13:38 INFO - no previously-included directories found matching '.git*' 10:13:38 INFO - Successfully installed jsonschema functools32 10:13:38 INFO - Cleaning up... 10:13:38 INFO - Return code: 0 10:13:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:13:38 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')]} 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 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')]} 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:13:38 INFO - Using env: {'DISPLAY': ':0', 10:13:38 INFO - 'HOME': '/home/cltbld', 10:13:38 INFO - 'LANG': 'en_US.UTF-8', 10:13:38 INFO - 'LANGUAGE': 'en_US:en', 10:13:38 INFO - 'LOGNAME': 'cltbld', 10:13:38 INFO - 'MAIL': '/var/mail/cltbld', 10:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:38 INFO - 'MOZ_NO_REMOTE': '1', 10:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:38 INFO - 'NO_EM_RESTART': '1', 10:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:38 INFO - 'PWD': '/builds/slave/test', 10:13:38 INFO - 'SHELL': '/bin/bash', 10:13:38 INFO - 'SHLVL': '1', 10:13:38 INFO - 'TERM': 'linux', 10:13:38 INFO - 'TMOUT': '86400', 10:13:38 INFO - 'USER': 'cltbld', 10:13:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:38 INFO - '_': '/tools/buildbot/bin/python'} 10:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:13:38 INFO - Cleaning up... 10:13:38 INFO - Return code: 0 10:13:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:38 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')]} 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 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')]} 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:39 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:39 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 10:13:39 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 10:13:39 INFO - Using env: {'DISPLAY': ':0', 10:13:39 INFO - 'HOME': '/home/cltbld', 10:13:39 INFO - 'LANG': 'en_US.UTF-8', 10:13:39 INFO - 'LANGUAGE': 'en_US:en', 10:13:39 INFO - 'LOGNAME': 'cltbld', 10:13:39 INFO - 'MAIL': '/var/mail/cltbld', 10:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:39 INFO - 'MOZ_NO_REMOTE': '1', 10:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:39 INFO - 'NO_EM_RESTART': '1', 10:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:39 INFO - 'PWD': '/builds/slave/test', 10:13:39 INFO - 'SHELL': '/bin/bash', 10:13:39 INFO - 'SHLVL': '1', 10:13:39 INFO - 'TERM': 'linux', 10:13:39 INFO - 'TMOUT': '86400', 10:13:39 INFO - 'USER': 'cltbld', 10:13:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:39 INFO - '_': '/tools/buildbot/bin/python'} 10:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:39 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 10:13:39 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 10:13:39 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 10:13:39 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 10:13:39 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 10:13:39 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 10:13:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 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 10:13:41 INFO - Downloading docopt-0.6.1.tar.gz 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:41 INFO - Running setup.py install for blobuploader 10:13:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:41 INFO - Running setup.py install for requests 10:13:42 INFO - Running setup.py install for docopt 10:13:42 INFO - Successfully installed blobuploader requests docopt 10:13:42 INFO - Cleaning up... 10:13:42 INFO - Return code: 0 10:13:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:42 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')]} 10:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:42 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')]} 10:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:42 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:42 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 10:13:42 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 10:13:42 INFO - Using env: {'DISPLAY': ':0', 10:13:42 INFO - 'HOME': '/home/cltbld', 10:13:42 INFO - 'LANG': 'en_US.UTF-8', 10:13:42 INFO - 'LANGUAGE': 'en_US:en', 10:13:42 INFO - 'LOGNAME': 'cltbld', 10:13:42 INFO - 'MAIL': '/var/mail/cltbld', 10:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:42 INFO - 'MOZ_NO_REMOTE': '1', 10:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:42 INFO - 'NO_EM_RESTART': '1', 10:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:42 INFO - 'PWD': '/builds/slave/test', 10:13:42 INFO - 'SHELL': '/bin/bash', 10:13:42 INFO - 'SHLVL': '1', 10:13:42 INFO - 'TERM': 'linux', 10:13:42 INFO - 'TMOUT': '86400', 10:13:42 INFO - 'USER': 'cltbld', 10:13:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:42 INFO - '_': '/tools/buildbot/bin/python'} 10:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:42 INFO - Running setup.py (path:/tmp/pip-TjbTsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:42 INFO - Running setup.py (path:/tmp/pip-BP8Ibe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:42 INFO - Running setup.py (path:/tmp/pip-kNcOE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:42 INFO - Running setup.py (path:/tmp/pip-_leYQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:43 INFO - Running setup.py (path:/tmp/pip-qRtvVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:43 INFO - Running setup.py (path:/tmp/pip-Vsw2We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:43 INFO - Running setup.py (path:/tmp/pip-27ORgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:43 INFO - Running setup.py (path:/tmp/pip-ezfJ08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:43 INFO - Running setup.py (path:/tmp/pip-vhcyj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:43 INFO - Running setup.py (path:/tmp/pip-RHOa3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:43 INFO - Running setup.py (path:/tmp/pip-v_QEJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:43 INFO - Running setup.py (path:/tmp/pip-3c2Lt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:43 INFO - Running setup.py (path:/tmp/pip-wB3Q2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:43 INFO - Running setup.py (path:/tmp/pip-XZtvP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:43 INFO - Running setup.py (path:/tmp/pip-nUbmca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:43 INFO - Running setup.py (path:/tmp/pip-rUQzEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:43 INFO - Running setup.py (path:/tmp/pip-G7qSIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:43 INFO - Running setup.py install for manifestparser 10:13:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozcrash 10:13:44 INFO - Running setup.py install for mozdebug 10:13:44 INFO - Running setup.py install for mozdevice 10:13:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozfile 10:13:44 INFO - Running setup.py install for mozhttpd 10:13:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozinfo 10:13:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozInstall 10:13:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:44 INFO - Running setup.py install for mozleak 10:13:44 INFO - Running setup.py install for mozlog 10:13:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for moznetwork 10:13:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for mozprocess 10:13:45 INFO - Running setup.py install for mozprofile 10:13:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for mozrunner 10:13:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Running setup.py install for mozscreenshot 10:13:45 INFO - Running setup.py install for moztest 10:13:45 INFO - Running setup.py install for mozversion 10:13:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:45 INFO - Cleaning up... 10:13:45 INFO - Return code: 0 10:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:45 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')]} 10:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:45 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')]} 10:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:45 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:45 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 10:13:45 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 10:13:45 INFO - Using env: {'DISPLAY': ':0', 10:13:45 INFO - 'HOME': '/home/cltbld', 10:13:45 INFO - 'LANG': 'en_US.UTF-8', 10:13:45 INFO - 'LANGUAGE': 'en_US:en', 10:13:45 INFO - 'LOGNAME': 'cltbld', 10:13:45 INFO - 'MAIL': '/var/mail/cltbld', 10:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:45 INFO - 'MOZ_NO_REMOTE': '1', 10:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:45 INFO - 'NO_EM_RESTART': '1', 10:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:45 INFO - 'PWD': '/builds/slave/test', 10:13:45 INFO - 'SHELL': '/bin/bash', 10:13:45 INFO - 'SHLVL': '1', 10:13:45 INFO - 'TERM': 'linux', 10:13:45 INFO - 'TMOUT': '86400', 10:13:45 INFO - 'USER': 'cltbld', 10:13:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:45 INFO - '_': '/tools/buildbot/bin/python'} 10:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:45 INFO - Running setup.py (path:/tmp/pip-C6fJ3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:46 INFO - Running setup.py (path:/tmp/pip-8w2PkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:46 INFO - Running setup.py (path:/tmp/pip-hfgmJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:46 INFO - Running setup.py (path:/tmp/pip-BZPFtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:46 INFO - Running setup.py (path:/tmp/pip-ydmrgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:46 INFO - Running setup.py (path:/tmp/pip-gvBrRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:46 INFO - Running setup.py (path:/tmp/pip-D2VfHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:46 INFO - Running setup.py (path:/tmp/pip-m9wGPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:46 INFO - Running setup.py (path:/tmp/pip-45ScxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:46 INFO - Running setup.py (path:/tmp/pip-g7eRr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:46 INFO - Running setup.py (path:/tmp/pip-4bRA4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:46 INFO - Running setup.py (path:/tmp/pip-Yb5geH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:46 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)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:46 INFO - Running setup.py (path:/tmp/pip-IJIdE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:46 INFO - Running setup.py (path:/tmp/pip-VvvQGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:47 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)) 10:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:47 INFO - Running setup.py (path:/tmp/pip-YyMFa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:47 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)) 10:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:47 INFO - Running setup.py (path:/tmp/pip-Zm1_At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:47 INFO - Running setup.py (path:/tmp/pip-N4ykAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 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)) 10:13:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:47 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 10:13:47 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 10:13:47 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 10:13:47 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 10:13:47 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 10:13:47 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 10:13:49 INFO - Downloading blessings-1.6.tar.gz 10:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:49 INFO - Installing collected packages: blessings 10:13:49 INFO - Running setup.py install for blessings 10:13:49 INFO - Successfully installed blessings 10:13:49 INFO - Cleaning up... 10:13:49 INFO - Return code: 0 10:13:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:49 INFO - Reading from file tmpfile_stdout 10:13:49 INFO - Current package versions: 10:13:49 INFO - argparse == 1.2.1 10:13:49 INFO - blessings == 1.6 10:13:49 INFO - blobuploader == 1.2.4 10:13:49 INFO - docopt == 0.6.1 10:13:49 INFO - functools32 == 3.2.3-2 10:13:49 INFO - jsonschema == 2.5.1 10:13:49 INFO - manifestparser == 1.1 10:13:49 INFO - mozInstall == 1.12 10:13:49 INFO - mozcrash == 1.0 10:13:49 INFO - mozdebug == 0.1 10:13:49 INFO - mozdevice == 0.48 10:13:49 INFO - mozfile == 1.2 10:13:49 INFO - mozhttpd == 0.7 10:13:49 INFO - mozinfo == 0.9 10:13:49 INFO - mozleak == 0.1 10:13:49 INFO - mozlog == 3.4 10:13:49 INFO - moznetwork == 0.27 10:13:49 INFO - mozprocess == 0.23 10:13:49 INFO - mozprofile == 0.28 10:13:49 INFO - mozrunner == 6.13 10:13:49 INFO - mozscreenshot == 0.1 10:13:49 INFO - mozsystemmonitor == 0.3 10:13:49 INFO - moztest == 0.7 10:13:49 INFO - mozversion == 1.4 10:13:49 INFO - psutil == 3.1.1 10:13:49 INFO - requests == 1.2.3 10:13:49 INFO - wsgiref == 0.1.2 10:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 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 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:49 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 10:13:49 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 10:13:49 INFO - Using env: {'DISPLAY': ':0', 10:13:49 INFO - 'HOME': '/home/cltbld', 10:13:49 INFO - 'LANG': 'en_US.UTF-8', 10:13:49 INFO - 'LANGUAGE': 'en_US:en', 10:13:49 INFO - 'LOGNAME': 'cltbld', 10:13:49 INFO - 'MAIL': '/var/mail/cltbld', 10:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:49 INFO - 'MOZ_NO_REMOTE': '1', 10:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:49 INFO - 'NO_EM_RESTART': '1', 10:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:49 INFO - 'PWD': '/builds/slave/test', 10:13:49 INFO - 'SHELL': '/bin/bash', 10:13:49 INFO - 'SHLVL': '1', 10:13:49 INFO - 'TERM': 'linux', 10:13:49 INFO - 'TMOUT': '86400', 10:13:49 INFO - 'USER': 'cltbld', 10:13:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:49 INFO - '_': '/tools/buildbot/bin/python'} 10:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:13:49 INFO - Cleaning up... 10:13:49 INFO - Return code: 0 10:13:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffac2482f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', '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 10:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:13:49 INFO - Using env: {'DISPLAY': ':0', 10:13:49 INFO - 'HOME': '/home/cltbld', 10:13:49 INFO - 'LANG': 'en_US.UTF-8', 10:13:49 INFO - 'LANGUAGE': 'en_US:en', 10:13:49 INFO - 'LOGNAME': 'cltbld', 10:13:49 INFO - 'MAIL': '/var/mail/cltbld', 10:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:49 INFO - 'MOZ_NO_REMOTE': '1', 10:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:49 INFO - 'NO_EM_RESTART': '1', 10:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:49 INFO - 'PWD': '/builds/slave/test', 10:13:49 INFO - 'SHELL': '/bin/bash', 10:13:49 INFO - 'SHLVL': '1', 10:13:49 INFO - 'TERM': 'linux', 10:13:49 INFO - 'TMOUT': '86400', 10:13:49 INFO - 'USER': 'cltbld', 10:13:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:49 INFO - '_': '/tools/buildbot/bin/python'} 10:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:50 INFO - Cleaning up... 10:13:50 INFO - Return code: 0 10:13:50 INFO - Running post-action listener: _resource_record_post_action 10:13:50 INFO - Running post-action listener: _start_resource_monitoring 10:13:50 INFO - Starting resource monitoring. 10:13:50 INFO - [mozharness: 2016-11-12 18:13:50.123893Z] Finished create-virtualenv step (success) 10:13:50 INFO - [mozharness: 2016-11-12 18:13:50.124411Z] Running install step. 10:13:50 INFO - Running pre-action listener: _resource_record_pre_action 10:13:50 INFO - Running main action method: install 10:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:50 INFO - Reading from file tmpfile_stdout 10:13:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:50 INFO - Reading from file tmpfile_stdout 10:13:50 INFO - Output received: 10:13:50 INFO - Usage: mozinstall [options] installer 10:13:50 INFO - Options: 10:13:50 INFO - -h, --help show this help message and exit 10:13:50 INFO - -d DEST, --destination=DEST 10:13:50 INFO - Directory to install application into. [default: 10:13:50 INFO - "/builds/slave/test"] 10:13:50 INFO - --app=APP Application being installed. [default: firefox] 10:13:50 INFO - mkdir: /builds/slave/test/build/application 10:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:14:07 INFO - Reading from file tmpfile_stdout 10:14:07 INFO - Output received: 10:14:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:07 INFO - Running post-action listener: _resource_record_post_action 10:14:07 INFO - [mozharness: 2016-11-12 18:14:07.313920Z] Finished install step (success) 10:14:07 INFO - [mozharness: 2016-11-12 18:14:07.314163Z] Running run-tests step. 10:14:07 INFO - Running pre-action listener: _resource_record_pre_action 10:14:07 INFO - Running main action method: run_tests 10:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:07 INFO - Python 2.7.3 10:14:07 INFO - Return code: 0 10:14:07 INFO - grabbing minidump binary from tooltool 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:07 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 0x2b7a930>, '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 0x2b7b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7bcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:07 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 10:14:07 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 10:14:07 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 10:14:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:07 INFO - Return code: 0 10:14:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 10:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 10:14:07 INFO - Using env: {'DISPLAY': ':0', 10:14:07 INFO - 'HOME': '/home/cltbld', 10:14:07 INFO - 'LANG': 'en_US.UTF-8', 10:14:07 INFO - 'LANGUAGE': 'en_US:en', 10:14:07 INFO - 'LOGNAME': 'cltbld', 10:14:07 INFO - 'MAIL': '/var/mail/cltbld', 10:14:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:07 INFO - 'MOZ_NO_REMOTE': '1', 10:14:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:07 INFO - 'NO_EM_RESTART': '1', 10:14:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:07 INFO - 'PWD': '/builds/slave/test', 10:14:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:07 INFO - 'SHELL': '/bin/bash', 10:14:07 INFO - 'SHLVL': '1', 10:14:07 INFO - 'TERM': 'linux', 10:14:07 INFO - 'TMOUT': '86400', 10:14:07 INFO - 'USER': 'cltbld', 10:14:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606', 10:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:07 INFO - '_': '/tools/buildbot/bin/python'} 10:14:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 10:14:07 INFO - mozversion application_buildid: 20161112073220 10:14:07 INFO - mozversion application_changeset: b37be3d705d929ee52280051d58cedc70a47626f 10:14:07 INFO - mozversion application_display_name: Nightly 10:14:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:07 INFO - mozversion application_name: Firefox 10:14:07 INFO - mozversion application_remotingname: firefox 10:14:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:07 INFO - mozversion application_vendor: Mozilla 10:14:07 INFO - mozversion application_version: 52.0a1 10:14:07 INFO - mozversion platform_buildid: 20161112073220 10:14:07 INFO - mozversion platform_changeset: b37be3d705d929ee52280051d58cedc70a47626f 10:14:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:07 INFO - mozversion platform_version: 52.0a1 10:14:07 INFO - using testdate: 1478974447 10:14:07 INFO - actual date: 1478974447 10:14:07 INFO - starting webserver on 'localhost:58510' 10:14:07 INFO - SUITE-START | Running 2 tests 10:14:07 INFO - TEST-START | dromaeo_css 10:14:07 INFO - operating with platform_type : linux_ 10:14:07 INFO - Initialising browser for dromaeo_css test... 10:14:07 INFO - TEST-INFO | started process 32531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfL8pnI/profile http://localhost:58510/getInfo.html) 10:14:11 INFO - PROCESS | 32531 | __metrics Screen width/height:1600/1200 10:14:11 INFO - PROCESS | 32531 | colorDepth:24 10:14:11 INFO - PROCESS | 32531 | Browser inner width/height: 1024/697 10:14:11 INFO - PROCESS | 32531 | __metrics 10:14:12 INFO - PROCESS | 32531 | 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" 10:14:12 INFO - PROCESS | 32531 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:12 INFO - PROCESS | 32531 | console.error: PushService: 10:14:12 INFO - PROCESS | 32531 | stateChangeProcessEnqueue: Error transitioning state 10:14:12 INFO - PROCESS | 32531 | UnknownError 10:14:13 INFO - TEST-INFO | 32531: exit 0 10:14:13 INFO - Browser initialized. 10:14:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:13 INFO - TEST-INFO | started process 32614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfL8pnI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:25 INFO - PROCESS | 32614 | RSS: Main: 175206400 10:14:25 INFO - PROCESS | 32614 | 10:15:17 INFO - PROCESS | 32614 | 1478974517331 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:17:27 INFO - PROCESS | 32614 | Cycle 1(1): loaded http://localhost:58510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58510/tests/dromaeo/cssquery-ext.html) 10:17:28 INFO - PROCESS | 32614 | RSS: Main: 338055168 10:17:28 INFO - PROCESS | 32614 | 10:20:31 INFO - PROCESS | 32614 | Cycle 1(1): loaded http://localhost:58510/tests/dromaeo/cssquery-ext.html (next: http://localhost:58510/tests/dromaeo/cssquery-jquery.html) 10:20:31 INFO - PROCESS | 32614 | RSS: Main: 272326656 10:20:31 INFO - PROCESS | 32614 | 10:23:33 INFO - PROCESS | 32614 | Cycle 1(1): loaded http://localhost:58510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58510/tests/dromaeo/cssquery-mootools.html) 10:23:34 INFO - PROCESS | 32614 | RSS: Main: 218279936 10:23:34 INFO - PROCESS | 32614 | 10:26:36 INFO - PROCESS | 32614 | Cycle 1(1): loaded http://localhost:58510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58510/tests/dromaeo/cssquery-prototype.html) 10:26:37 INFO - PROCESS | 32614 | RSS: Main: 248885248 10:26:37 INFO - PROCESS | 32614 | 10:29:40 INFO - PROCESS | 32614 | Cycle 1(1): loaded http://localhost:58510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58510/tests/dromaeo/cssquery-yui.html) 10:29:40 INFO - PROCESS | 32614 | RSS: Main: 217509888 10:29:40 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | Cycle 1(1): loaded http://localhost:58510/tests/dromaeo/cssquery-yui.html (next: http://localhost:58510/tests/dromaeo/cssquery-dojo.html) 10:32:43 INFO - PROCESS | 32614 | RSS: Main: 306180096 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | __start_tp_report 10:32:43 INFO - PROCESS | 32614 | _x_x_mozilla_page_load 10:32:43 INFO - PROCESS | 32614 | _x_x_mozilla_page_load_details 10:32:43 INFO - PROCESS | 32614 | |i|pagename|runs| 10:32:43 INFO - PROCESS | 32614 | |0;dojo.html;3129.374125174965;3162.3991441626104;3177.714005739483;3194.8562314695837;3196.1050905746383;5326.840194794153;5352.330958630171;5421.864453388663;5465.508104270615;5485.451454854512;5411.783528658859;5433.320834895638;5433.565314774818;5435.266239057726;5440.945590544094;4877;4899.681520701143;4912.852614421573;4949.901001979958;4980.950190498103;4886.511348865103;4894.1679914414635;4915.901681966377;4988.176950803113;5038.974805125988;4895.437024742165;4949.406071271453;4952.975235123819;4959.479254678261;4995.6003519718515;191.49358854888828;4955.925661115104;4979.10376132296;4996.125678006334;5004.749762511896;4889.853304400874;4909.337239472661;4940.357753492023;4958.727270000149;4970.726610036447;5398.325209348832;5402.513773760341;5410.323709536308;5414.945850541483;5445;5636;5686.658800471985;5720.2849643794525;5839.240898683186;5845.473907348359;5807.390224026459;5894.145348924382;5925.940740592582;5941.405859414067;6029.397060293935;5539.778408863681;5540.36285827131;5543.473370029841;5548.195511650869;5552.86117847053;6076.270847498328;6078.75684972605;6080.817575472743;6088.025915853442;6088.117223002729;5616.634918730269;5643.40744221859;5652.943470565242;5657.60396772222;5726.541876649858;5629.155626655953;5738.397468265855;5788.855278617984;5800.4489573490455;5813.651180929158;5863.208466857005;5863.589548731547;5867.73595188209;5880.764769409261;5917.6745279010065;5878.235829342244;5878.911816322759;5881.088431293157;5882.735276912549;5911.113333000085;4386.956130438719;4476.104779044204;4486.484054333728;4489.685721999429;4529.026259354188;3957.920841583152;3978.0253837809923;3991.4611527444004;4027.577104404054;4058.5738497457933;5573.69344686038;5578.693171875586;5579.46995035471;5582.134769110794;5585.357683866408;5870.823875283749;5912.9113063304085;5915.852103697356;5920.31916329619;5924.318703349084;5385.353757549119;5440.265564148868;5545.085060964976;5591.720413979285;5601.6358936668985;5142.742862856842;5151.124308867502;5153.587712982952;5158.380994280636;5186.40356359016;6087.57386982907;6101.115338276014;6103.572749907464;6107.236595425572;6109.450149486567;5732.942670573241;5770.047942089508;5851.678157701367;5914.142449344735;5971.880562388815;6115.483736156459;6119.167450728499;6122.428649698624;6123.112148738497;6130.795626845359;5772.249607550992;5822.214001109796;5822.417758224144;5822.679752613647;5828.271466066742;5642.915356269741;5712.457316554921;5712.7714891403875;5934.317553481233;5955.731992060281;5589.720513974366;5677.943220567907;5680.233168522197;5715.828525144252;5722.055860782924;5572.136318870582;5610.635308704921;5611.859703507445;5612.494875461228;5656.519195868397;5437.592180586393;5497.285352904097;5552.194931734956;5566.582506312124;5570.4151064139305;5660.433956604306;5695.430456954271;5708.743106560298;5791.102379131242;5791.189233507396;5567.47109024642;5611.803586874603;5612.691301978431;5628.324601047901;5663.546916246608 10:32:43 INFO - PROCESS | 32614 | |1;ext.html;544.905829095177;579.2325169150876;601.0413390641926;623.0933991043033;631.2393565753267;31576.84211578942;40313.79843100784;41230.58769412305;41257.174856502854;41307.79346103273;43040.56959430405;43435.78282108585;43469.78265108678;43476.3478547822;43507;8473.11032341603;8620.913790862105;8621.396502244845;8624.611892464854;8625.95687021564;8364.874526882102;8438.2827459666;8458.111898250687;8463.449875758086;8468.195521425454;8496.87254691177;8552.743417697448;8553.444026138312;8562.957185214065;8564.657413703444;8480.491170529787;8513.616887240089;8524.70163544273;8529.061803201643;8530.914690853075;8491.872621910676;8519.48883067018;8546.786330341729;8562.957185214096;8564.100769419183;40560.79719601413;40812.18375632471;40999.38500922488;41089.79455102735;41258.587414125774;3334.282844335169;3383.899636161195;3416.830312751396;3418.1112910643164;3492.8253587320532;30815.537766933514;30875.536866947015;31175;31575.84212078948;32636.510452343235;3988.4591810802162;4101.958980410188;4178.540360560336;4211.410402543646;4223.704340696153;341478;342698;342818.9999999975;343176;343238;54863.45136548583;55408.44591554113;55532;55533.72233138889;55546.44453555493;35803.28393432169;58520.414795852346;58595;58603.12095318574;58686.4131358681;14947.402103915721;15954.441594544136;15974.920125399298;16036.358545658277;16069.35722571084;11647;11650.41747912601;11650.53397864076;11729.941350293195;11737.589184378676;18895.433137005635;19072.90463547701;19077;19100.61798764017;19129.713054304197;6811.182658081062;6917.9654101730175;6962.547434416747;7082.575045497287;7354.521956072838;928.456852741154;975.3124047546463;986.8914419413859;1048.9475526223657;1085.4030283344287;29965.400691986473;30046.84976575103;30702.38595228083;30863.2284192897;31050.378992420025;1075.2365820267541;1086.0605576176551;1091.4488183467456;1143.6054561176381;1145.9743529541015;15819.304965318022;16429.67140657204;16465.753013704805;16526.752098718527;16650.417235396704;585922;588906;589697.390852238;591905;593350;56538.71730641403;56658.43341566614;56708.71645641745;56770.43229567734;56914.430855690916;1313.5599574142577;1319.5711393797246;1328.5217321764158;1339.7990301454665;1340.1958824705098;28877.566836497048;29719.405611888073;29727.25681857971;30409.69590304157;30552.08343749691;49204;54012;55268.44731552794;55493.72253138709;58855.70572147112;476342;479976;481832;483129;485530;40710.59289407068;41403;41594;42007.369889451074;42521.32265450736;45957.310640339754;46081;46139.76930115328;46735.53264467312;47503.287450687574;38820.80589597034;39364.14306780951;40620.79689601533;41377.93945176558;41417;39639;39774;40351.798241008604;41066.58933410628;41818.58181418147;32369.838150809097;34884.65115348814;35562.64437355593;38628.420573691976;40388;33222.667773321955;34814;35276.76826250561;35808;36124.27751445009;26028.479430411666;27056.188314350602;27416.451670966868;27464.862675686494;27522.449551009267 10:32:43 INFO - PROCESS | 32614 | |2;jquery.html;367.36445948509095;380.49014320810124;387.3531202891172;391.1570565431495;414.848580268202;14281.357338919748;17462.65074698505;17527.12364381779;18030;19070.713939290923;17308;17374.04442755648;17861.017644029573;17990.82009179908;18369.357072502466;4934.703917764937;5173.654849739058;5177.663451875616;5178.326817513718;5183.611229157809;5079.288899554065;5154.329937108189;5154.433012368637;5226.634135610509;5504.559635229192;5576.219329293902;5593.909187708398;5596.356419011805;5598.552115830724;5598.832035038955;5451.155070964007;5601.327840659106;5616.691081990489;5623.943760562403;5646.604737668365;5475.589330800166;5481.150421684645;5481.780728770845;5482.4101010706845;5488.725563721798;13086.214827110403;13412.26232557209;13497;13508.257045862474;13546.796798048037;2153.3432303147533;2215.4018415027854;2239.7984181423585;2433.841800282976;2581.7676409123083;9465.66870159548;9727.173190278834;9941.403515789003;10291.794164116676;10421.114205292559;1849.3157531713218;1863.5806943437753;1864.4686264414577;1885.8774179678414;1905.2569497895831;68377.31622683808;82993;83612;83991;86006;10548.525316360628;10772.245942784086;10838.67483975482;11002.614908478165;11106.222564420414;15185.544433667008;15315.770263446057;15321.846781532042;15325;15339.539813805604;7714.961425192838;7810.960945195351;7854.410919181084;7980.082290536547;8035.196480351918;7371.631418429057;7410.851782964311;7444.478886477895;7540.585267810214;7666.310032097138;4571.9314210286875;4595.793189306489;4642.51253618372;4685.742284174403;4708.293755936637;1911.4170178095815;1931.9227230910888;1960.7941166177632;1964.5186929202437;1993.1031036033553;821.482466046387;892.1747383670208;930.7393929699695;983.6508039645965;1008.8537162111453;17175.620216844625;17294.913525432545;18391.448256552325;18497.445076647724;18713.345032923782;942.1406032690751;944.9622015119318;956.3735753081743;964.1515466389673;966.917811985975;9737.610495580238;9990.700278991642;10172.135368493613;10194.592216311414;10265.973402659823;429130;442091;444623;445089;445936;83907;84642.57678711567;87283.56358218295;88720;89606;955.245356168633;970.427447805798;1025.8050970315765;1027.173125633857;1032.210359075308;16105.67788644244;16446.67106657884;16489.09309987962;16928.49214523566;17589.64820703553;42064;42829.35755963601;43139;43650;44085.82798408161;58364.70817646055;59098;59436.40563594309;59471.40528594659;60548.091778622475;7650.349720273839;8128.75613731589;8200.220979006985;8226.465279756796;8542.145785421408;12716.427760750974;12743.171693839871;12763.872361276268;12853.228806271654;13300.733985320432;10659.733506662396;11107.72230694239;11113.555457781598;11545.076393888638;11580;11222.214444988773;11356.772864542829;11374.374409407563;11420.31478111316;11524;11370.772584548427;11531.596394126165;11635.883641163819;11752.76494470123;11986.220895641756;8154.469959452616;8277.668893244203;11164.720881978015;11730.296182228753;12190.512379505075;10695.732606684895;11707.941460292644;11736;12144.33206173669;12534 10:32:43 INFO - PROCESS | 32614 | |3;mootools.html;1355.8983076269283;1398.0772690024585;1442.516756886443;1527.7784721215423;1730.9221085051172;7515.361194298484;8085.4340196186295;8387.496750194992;8396.286315663176;8668.956655216714;8355.331573474123;8441.662333506667;8446.83106337873;8453.450525715823;8456.154384561556;2297.850639708418;2307.538492301538;2307.7230732312146;2308.73449553301;2316.281952594701;2297.9195728149516;2339.42684042409;2365.562370961369;2366.1363602285214;2371.2412028150998;2288.096202000217;2291.873946932918;2302.631578947369;2322.6864373309554;2323.2101085630884;2246.5619204255177;2285.245868863271;2308;2311.387482317179;2312.537492501498;2272.216085450517;2290.599145149609;2292.7821856923565;2299.1722979727283;2299.2872209614907;8514.403991720583;8519.829603407898;8609.913900860975;8624.78438039054;8634.740957771213;5059.468755780626;5231.581473482112;5237.188235823453;5272.868178295535;5297.311349524537;3485.1112966193714;3494.6155922848466;3523.788572685647;3590.35373632746;3595.8741444049333;1116.385987706758;1121.506537123671;1134;1187.091874715843;1205.6202296276645;11343.886561134366;11348.716282092932;11355.943220283845;11369.31784092957;11504.137189710722;4196.790160491963;4445.444319460067;4448.911021779546;4555.385023021916;4561.794719237642;9135.360524763202;9156.587953542106;9159.267258619295;9168.129027742354;9171.174594286545;5005.649604527648;5041.319421878;5042.218456139304;5047.823326183639;5060.291559181717;3952.8616498422994;4258.297380932174;4396.3625274335045;4425.269830478;4719.83480578185;3689.151495156129;3771.9245615088093;3789.204267103939;3827.2154208387215;3924.5682974872743;1146.2434793036555;1161.9593314233962;1171.6485054483621;1172.8475298211179;1185.17038073349;767.6699019421702;824.7855557555079;880.6389380354024;903.9276857851356;915.5285028210477;5355.169948657965;5480.698561579072;5550.888982220333;5558.471945165203;5937.821865344046;887.2990337633197;888.8755574219614;899.2850683706469;956.1251454918671;993.9503024848729;3324.2317430372545;3434.1242983039165;3476.3047390521997;3518.3702296340934;3541.911452213715;10096.596136154618;10631.52158152885;10637.46812659364;10637.9468102659;10685.412302323291;10542.683719488428;10578;10604.734881627866;10616.628418005488;10617.787644247072;7862.213778622092;8047.959760201162;8053.798655033671;8055.5972201389695;8065.4757440767335;4985.700857948535;5063.291139240436;5122.46214147524;5213.869653258547;5318.042752304467;9555.331126821056;9637.469939153134;9749.36629119105;9817.950910245689;9860.556274967501;9543.90456095458;9743.61025558998;9794.559244834141;9851.128285625708;9855.605775769176;7569.962150189213;7704.499207551491;7756.650950707119;7757.883631745642;7761.883571746315;8116.797080073045;8192;8200;8219.095899450936;8312.916870831456;7248.782536523912;7263.34629883313;7291.161516425679;7433.628318584158;7583.2416758323725;7311.195768465571;7422.480426370103;7427.7771666850085;7442.479026468095;7471.775846724607;6953.443724501926;6986.231514533296;7055.435565154878;7055.6824942876665;7062;4537.591616754508;4557.7721113944835;4582.725036497821;4590.586847183636;4676.111538807616;4681.906361872675;4687.507811679725;4691.03833714081;4699.835505757282;4802.556038140938 10:32:43 INFO - PROCESS | 32614 | |4;prototype.html;323.07600263247093;326.9133679574913;327.6068717538953;331.7362696656158;338.0247984564531;5091.777973286413;5302.549283310918;5352.277442545255;5361.276227709258;5440.156775699763;5155.871103222421;5223.294855194547;5230.424653288144;5243.134882744353;5252.395974462938;4129.194807012634;4139.296319625656;4139.461869956901;4145.636986917459;4159.022629682037;3912.5304963404433;4106.2198182345255;4161.479815023122;4162.41726158338;4163.916721665565;4083.8162282697203;4090.202410529948;4100.261952848486;4100.753954762708;4101.159262351226;4070.1859628074358;4071.5724848890886;4088.1414902870433;4101.405296232059;4102.159057393257;3604.873829415958;3605.7019472989705;3610.837512311952;3618.656227658368;3623.076115590534;5058.799422251295;5143.408508021551;5154.38147422308;5158.948410515922;5161.948380516184;4647.837325693618;4663.463701674317;4668.136394766979;4672.719636821767;4674.158651442773;5498.505134537871;5498.697571633558;5505.091385116532;5510.8071217507195;5510.834674959758;3783.9054023649355;3880.5925377835483;3920.5099362579676;3920.9803950980063;3922.17634296798;5672.546196304327;5694.4590263924865;5694.914576281359;5697.373288938214;5720.971395143039;3997.760134391946;4005.619466150711;4008.4788977432745;4025.396190571379;4026.7583944963394;3958.129211573449;4068.270984831494;4071.918561628751;4073.24644940681;4085.97957010219;4652.371929789503;4656.185167595657;4662.510436404129;4664.766761661904;4675.181843177498;5505.421930697219;5516.972415137979;5528.44715528452;5538.418466061086;5542.140968149944;1289.509986205236;1331.7003674173427;1347.9326033698276;1359.9732202187286;1363.277462944641;906.2613969614742;933.710549729586;944.6821683751128;945.4232917920064;948.5826236455937;5117.8464646060675;5128.871778205575;5130.9230361544605;5150.845474635767;5160.612954028463;5387.767339596211;5427.3758517770175;5433.6196466247775;5444.237806707064;5459.918101228484;4897.975510122426;5074.467180945948;5135.639055650256;5164.561012313995;5170.638055336166;2908.4619345421165;2917.6207093078187;2919.3285544324926;2923.2399576110365;2926.0300794692976;5548.195511650788;5566.972165139148;5630.690312032795;5655;5671.716414179275;5205.24523944026;5462.535684466785;5464.9180262296095;5524.1989911462615;5546.417626149277;5585.720713964285;5608.523275521627;5610.747516361774;5612;5637.238972738628;5272.841814745564;5393.40672526014;5418.187271909245;5428.647137936022;5471.534919531884;5332.760025798771;5356.705381204071;5363.517283444508;5368.731563421735;5370.489803468664;5586.13414920688;5600.7199640017025;5607.355154157324;5617.578681598979;5620.381758006698;3775.5091838060875;3880.2627500775893;3892.2410130025505;3905.3556163232747;3917.8628747993685;5371.838844834661;5393.325834270716;5453.345598528202;5455.890882182413;5477.424870388551;5443.428440013741;5502.624343914022;5541.556675466034;5559.305086864142;5568.6658800472105;5502.459311392817;5528.640638358494;5535.916961245665;5540.833774986757;5560.972195138998;5185.818496352609;5405.810796622257;5423.620346575702;5458;5475.534579560782;5503.3120859892515;5518.834434966958;5599.580031497572;5606.635568688022;5607.214989901336;5506.091494903296;5507.944920550904;5508.586855985897;5523.309586301712;5530.640508367104 10:32:43 INFO - PROCESS | 32614 | |5;yui.html;699.1714817940741;705.7882635209437;728.7376544443999;743.6988019851958;774.8101715079806;14025.579232623026;14964.027338223035;15098.018628789148;15150.090994540335;15242.237888105592;13143.145695529807;13196.406161722722;13204.141730787493;13215.867841321584;13227.206367617926;760.3385055002155;773.0182668011649;776.638862928738;779.1312686354702;779.3219898688121;771.1863983497408;772.8686123359042;775.9030121234846;776.4836383804763;776.7786180938434;805.4925396999911;810.5015415519442;810.9918900810975;812.695239285268;812.8414959082982;809.7570728781342;810.432697112021;810.8256724804196;811.1482942909951;811.2333844516934;595.6009473652663;596.785157343356;597.2832600878919;597.5040716205539;597.7728463184005;12817.615471535868;13817.240051797147;13953.581392558239;14003.369848356848;14009.789853152211;11501.30992140466;11796;11853.229540079867;11944;12201;10175.491225438698;10277.383356998529;10305.12406445453;10440.843387349196;10482.68551943443;3494.1771976183154;3574.4459608760685;3578.6600272974024;3580.1407662161155;3588.6949609283242;57516.712416438066;61963.38036619621;62238.68880655568;62363.68818155926;62385;8921.509316987627;8962.775930601787;9004.549772511347;9138.725838224864;9298.488583127857;17887;18065.7290140648;18139.183736731615;18152.818471815375;18193;7397.667104980289;7487.475876688688;7558.924410755932;7598.240175982468;7878.566678832604;3994.980025099856;4020.638142567183;4023.295923213426;4096.73371230869;4114.115465175002;3295.1926777939557;3426.554547908756;3428.4171690812123;3428.9657103429145;3436.7078798302423;567.9233303504056;577.535084257177;581.7294957844538;587.7384563869037;591.0189086117025;580.9448102430263;587.1574290892582;643.2891654721559;651.3486513486514;655.2301046270613;8317.916820831835;8366.707165249187;8515.14848515156;8644.092370301154;8687.826243475096;561.6012631032013;606.3814908793006;637.4836382530166;642.5823214910346;653.5621133840339;3902.687784977195;4172.5410204877435;4178.895527611834;4180.519240287345;4229.450171477688;85882.57058714791;87813;89017;89767.55116224507;90339.54830225807;78523;79329.60335198288;80117;83113;83498;41671.26104513384;56580.01969931032;62487;68778;69021.999999999;8478.096021648802;8807.691730789391;8916.643334266557;8961.462312261285;9005.864912026456;47729.374884381694;48421.5157848417;48423.75788121037;48696;49197.262041068694;53005;54761.72619136879;60500;64921.35078649342;65626.34373656202;12268;12456.31490268044;12461.563845265735;12743.044271679475;12858.678533036375;12585.622431327074;13280.80078798838;13562.79655805144;13753.587392378246;14210.21843798601;12025.338606376383;12120.696982575506;12423.565175218824;12836.87163128394;13132.409041593342;12253.326067066397;12299.262044277371;12311.692207694521;13183.736325273248;13190.868091319348;12179.269243845398;12389.814152787536;12772.936135319263;13115.606531804062;13117.34413279313;9635.710928672152;9759.9024009759;10008.976660682169;10204.571360009753;10345.586176553155;9556.474393908402;10659.680209593724;10856.782864342511;10942.124630029737;10967.903209678969 10:32:43 INFO - PROCESS | 32614 | __end_tp_report 10:32:43 INFO - PROCESS | 32614 | __start_cc_report 10:32:43 INFO - PROCESS | 32614 | _x_x_mozilla_cycle_collect,1641 10:32:43 INFO - PROCESS | 32614 | __end_cc_report 10:32:43 INFO - PROCESS | 32614 | __startTimestamp1478975563688__endTimestamp 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | ------- Summary: start ------- 10:32:43 INFO - PROCESS | 32614 | Number of tests: 6 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | [#0] dojo.html Cycles:165 Average:5398.54 Median:5601.64 stddev:740.75 (13.2%) stddev-sans-first:721.32 10:32:43 INFO - PROCESS | 32614 | Values: 3129.4 3162.4 3177.7 3194.9 3196.1 5326.8 5352.3 5421.9 5465.5 5485.5 5411.8 5433.3 5433.6 5435.3 5440.9 4877.0 4899.7 4912.9 4949.9 4981.0 4886.5 4894.2 4915.9 4988.2 5039.0 4895.4 4949.4 4953.0 4959.5 4995.6 191.5 4955.9 4979.1 4996.1 5004.7 4889.9 4909.3 4940.4 4958.7 4970.7 5398.3 5402.5 5410.3 5414.9 5445.0 5636.0 5686.7 5720.3 5839.2 5845.5 5807.4 5894.1 5925.9 5941.4 6029.4 5539.8 5540.4 5543.5 5548.2 5552.9 6076.3 6078.8 6080.8 6088.0 6088.1 5616.6 5643.4 5652.9 5657.6 5726.5 5629.2 5738.4 5788.9 5800.4 5813.7 5863.2 5863.6 5867.7 5880.8 5917.7 5878.2 5878.9 5881.1 5882.7 5911.1 4387.0 4476.1 4486.5 4489.7 4529.0 3957.9 3978.0 3991.5 4027.6 4058.6 5573.7 5578.7 5579.5 5582.1 5585.4 5870.8 5912.9 5915.9 5920.3 5924.3 5385.4 5440.3 5545.1 5591.7 5601.6 5142.7 5151.1 5153.6 5158.4 5186.4 6087.6 6101.1 6103.6 6107.2 6109.5 5732.9 5770.0 5851.7 5914.1 5971.9 6115.5 6119.2 6122.4 6123.1 6130.8 5772.2 5822.2 5822.4 5822.7 5828.3 5642.9 5712.5 5712.8 5934.3 5955.7 5589.7 5677.9 5680.2 5715.8 5722.1 5572.1 5610.6 5611.9 5612.5 5656.5 5437.6 5497.3 5552.2 5566.6 5570.4 5660.4 5695.4 5708.7 5791.1 5791.2 5567.5 5611.8 5612.7 5628.3 5663.5 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | [#1] ext.html Cycles:180 Average:62267.24 Median:41257.88 stddev:128347.94 (311.1%) stddev-sans-first:128624.33 10:32:43 INFO - PROCESS | 32614 | Values: 544.9 579.2 601.0 623.1 631.2 31576.8 40313.8 41230.6 41257.2 41307.8 43040.6 43435.8 43469.8 43476.3 43507.0 8473.1 8620.9 8621.4 8624.6 8626.0 8364.9 8438.3 8458.1 8463.4 8468.2 8496.9 8552.7 8553.4 8563.0 8564.7 8480.5 8513.6 8524.7 8529.1 8530.9 8491.9 8519.5 8546.8 8563.0 8564.1 40560.8 40812.2 40999.4 41089.8 41258.6 3334.3 3383.9 3416.8 3418.1 3492.8 30815.5 30875.5 31175.0 31575.8 32636.5 3988.5 4102.0 4178.5 4211.4 4223.7 341478.0 342698.0 342819.0 343176.0 343238.0 54863.5 55408.4 55532.0 55533.7 55546.4 35803.3 58520.4 58595.0 58603.1 58686.4 14947.4 15954.4 15974.9 16036.4 16069.4 11647.0 11650.4 11650.5 11729.9 11737.6 18895.4 19072.9 19077.0 19100.6 19129.7 6811.2 6918.0 6962.5 7082.6 7354.5 928.5 975.3 986.9 1048.9 1085.4 29965.4 30046.8 30702.4 30863.2 31050.4 1075.2 1086.1 1091.4 1143.6 1146.0 15819.3 16429.7 16465.8 16526.8 16650.4 585922.0 588906.0 589697.4 591905.0 593350.0 56538.7 56658.4 56708.7 56770.4 56914.4 1313.6 1319.6 1328.5 1339.8 1340.2 28877.6 29719.4 29727.3 30409.7 30552.1 49204.0 54012.0 55268.4 55493.7 58855.7 476342.0 479976.0 481832.0 483129.0 485530.0 40710.6 41403.0 41594.0 42007.4 42521.3 45957.3 46081.0 46139.8 46735.5 47503.3 38820.8 39364.1 40620.8 41377.9 41417.0 39639.0 39774.0 40351.8 41066.6 41818.6 32369.8 34884.7 35562.6 38628.4 40388.0 33222.7 34814.0 35276.8 35808.0 36124.3 26028.5 27056.2 27416.5 27464.9 27522.4 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | [#2] jquery.html Cycles:180 Average:27080.50 Median:403.00 stddev:73063.84 (18129.9%) stddev-sans-first:73241.28 10:32:43 INFO - PROCESS | 32614 | Values: 367.4 380.5 387.4 391.2 414.8 14281.4 17462.7 17527.1 18030.0 19070.7 17308.0 17374.0 17861.0 17990.8 18369.4 4934.7 5173.7 5177.7 5178.3 5183.6 5079.3 5154.3 5154.4 5226.6 5504.6 5576.2 5593.9 5596.4 5598.6 5598.8 5451.2 5601.3 5616.7 5623.9 5646.6 5475.6 5481.2 5481.8 5482.4 5488.7 13086.2 13412.3 13497.0 13508.3 13546.8 2153.3 2215.4 2239.8 2433.8 2581.8 9465.7 9727.2 9941.4 10291.8 10421.1 1849.3 1863.6 1864.5 1885.9 1905.3 68377.3 82993.0 83612.0 83991.0 86006.0 10548.5 10772.2 10838.7 11002.6 11106.2 15185.5 15315.8 15321.8 15325.0 15339.5 7715.0 7811.0 7854.4 7980.1 8035.2 7371.6 7410.9 7444.5 7540.6 7666.3 4571.9 4595.8 4642.5 4685.7 4708.3 1911.4 1931.9 1960.8 1964.5 1993.1 821.5 892.2 930.7 983.7 1008.9 17175.6 17294.9 18391.4 18497.4 18713.3 942.1 945.0 956.4 964.2 966.9 9737.6 9990.7 10172.1 10194.6 10266.0 429130.0 442091.0 444623.0 445089.0 445936.0 83907.0 84642.6 87283.6 88720.0 89606.0 955.2 970.4 1025.8 1027.2 1032.2 16105.7 16446.7 16489.1 16928.5 17589.6 42064.0 42829.4 43139.0 43650.0 44085.8 58364.7 59098.0 59436.4 59471.4 60548.1 7650.3 8128.8 8200.2 8226.5 8542.1 12716.4 12743.2 12763.9 12853.2 13300.7 10659.7 11107.7 11113.6 11545.1 11580.0 11222.2 11356.8 11374.4 11420.3 11524.0 11370.8 11531.6 11635.9 11752.8 11986.2 8154.5 8277.7 11164.7 11730.3 12190.5 10695.7 11707.9 11736.0 12144.3 12534.0 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | [#3] mootools.html Cycles:180 Average:5531.14 Median:4995.68 stddev:3133.44 (62.7%) stddev-sans-first:3126.52 10:32:43 INFO - PROCESS | 32614 | Values: 1355.9 1398.1 1442.5 1527.8 1730.9 7515.4 8085.4 8387.5 8396.3 8669.0 8355.3 8441.7 8446.8 8453.5 8456.2 2297.9 2307.5 2307.7 2308.7 2316.3 2297.9 2339.4 2365.6 2366.1 2371.2 2288.1 2291.9 2302.6 2322.7 2323.2 2246.6 2285.2 2308.0 2311.4 2312.5 2272.2 2290.6 2292.8 2299.2 2299.3 8514.4 8519.8 8609.9 8624.8 8634.7 5059.5 5231.6 5237.2 5272.9 5297.3 3485.1 3494.6 3523.8 3590.4 3595.9 1116.4 1121.5 1134.0 1187.1 1205.6 11343.9 11348.7 11355.9 11369.3 11504.1 4196.8 4445.4 4448.9 4555.4 4561.8 9135.4 9156.6 9159.3 9168.1 9171.2 5005.6 5041.3 5042.2 5047.8 5060.3 3952.9 4258.3 4396.4 4425.3 4719.8 3689.2 3771.9 3789.2 3827.2 3924.6 1146.2 1162.0 1171.6 1172.8 1185.2 767.7 824.8 880.6 903.9 915.5 5355.2 5480.7 5550.9 5558.5 5937.8 887.3 888.9 899.3 956.1 994.0 3324.2 3434.1 3476.3 3518.4 3541.9 10096.6 10631.5 10637.5 10637.9 10685.4 10542.7 10578.0 10604.7 10616.6 10617.8 7862.2 8048.0 8053.8 8055.6 8065.5 4985.7 5063.3 5122.5 5213.9 5318.0 9555.3 9637.5 9749.4 9818.0 9860.6 9543.9 9743.6 9794.6 9851.1 9855.6 7570.0 7704.5 7756.7 7757.9 7761.9 8116.8 8192.0 8200.0 8219.1 8312.9 7248.8 7263.3 7291.2 7433.6 7583.2 7311.2 7422.5 7427.8 7442.5 7471.8 6953.4 6986.2 7055.4 7055.7 7062.0 4537.6 4557.8 4582.7 4590.6 4676.1 4681.9 4687.5 4691.0 4699.8 4802.6 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | [#4] prototype.html Cycles:180 Average:4576.40 Median:5236.78 stddev:1336.00 (25.5%) stddev-sans-first:1301.05 10:32:43 INFO - PROCESS | 32614 | Values: 323.1 326.9 327.6 331.7 338.0 5091.8 5302.5 5352.3 5361.3 5440.2 5155.9 5223.3 5230.4 5243.1 5252.4 4129.2 4139.3 4139.5 4145.6 4159.0 3912.5 4106.2 4161.5 4162.4 4163.9 4083.8 4090.2 4100.3 4100.8 4101.2 4070.2 4071.6 4088.1 4101.4 4102.2 3604.9 3605.7 3610.8 3618.7 3623.1 5058.8 5143.4 5154.4 5158.9 5161.9 4647.8 4663.5 4668.1 4672.7 4674.2 5498.5 5498.7 5505.1 5510.8 5510.8 3783.9 3880.6 3920.5 3921.0 3922.2 5672.5 5694.5 5694.9 5697.4 5721.0 3997.8 4005.6 4008.5 4025.4 4026.8 3958.1 4068.3 4071.9 4073.2 4086.0 4652.4 4656.2 4662.5 4664.8 4675.2 5505.4 5517.0 5528.4 5538.4 5542.1 1289.5 1331.7 1347.9 1360.0 1363.3 906.3 933.7 944.7 945.4 948.6 5117.8 5128.9 5130.9 5150.8 5160.6 5387.8 5427.4 5433.6 5444.2 5459.9 4898.0 5074.5 5135.6 5164.6 5170.6 2908.5 2917.6 2919.3 2923.2 2926.0 5548.2 5567.0 5630.7 5655.0 5671.7 5205.2 5462.5 5464.9 5524.2 5546.4 5585.7 5608.5 5610.7 5612.0 5637.2 5272.8 5393.4 5418.2 5428.6 5471.5 5332.8 5356.7 5363.5 5368.7 5370.5 5586.1 5600.7 5607.4 5617.6 5620.4 3775.5 3880.3 3892.2 3905.4 3917.9 5371.8 5393.3 5453.3 5455.9 5477.4 5443.4 5502.6 5541.6 5559.3 5568.7 5502.5 5528.6 5535.9 5540.8 5561.0 5185.8 5405.8 5423.6 5458.0 5475.5 5503.3 5518.8 5599.6 5606.6 5607.2 5506.1 5507.9 5508.6 5523.3 5530.6 10:32:43 INFO - PROCESS | 32614 | 10:32:43 INFO - PROCESS | 32614 | [#5] yui.html Cycles:180 Average:17244.15 Median:28570.81 stddev:23406.19 (81.9%) stddev-sans-first:23438.88 10:32:43 INFO - PROCESS | 32614 | Values: 699.2 705.8 728.7 743.7 774.8 14025.6 14964.0 15098.0 15150.1 15242.2 13143.1 13196.4 13204.1 13215.9 13227.2 760.3 773.0 776.6 779.1 779.3 771.2 772.9 775.9 776.5 776.8 805.5 810.5 811.0 812.7 812.8 809.8 810.4 810.8 811.1 811.2 595.6 596.8 597.3 597.5 597.8 12817.6 13817.2 13953.6 14003.4 14009.8 11501.3 11796.0 11853.2 11944.0 12201.0 10175.5 10277.4 10305.1 10440.8 10482.7 3494.2 3574.4 3578.7 3580.1 3588.7 57516.7 61963.4 62238.7 62363.7 62385.0 8921.5 8962.8 9004.5 9138.7 9298.5 17887.0 18065.7 18139.2 18152.8 18193.0 7397.7 7487.5 7558.9 7598.2 7878.6 3995.0 4020.6 4023.3 4096.7 4114.1 3295.2 3426.6 3428.4 3429.0 3436.7 567.9 577.5 581.7 587.7 591.0 580.9 587.2 643.3 651.3 655.2 8317.9 8366.7 8515.1 8644.1 8687.8 561.6 606.4 637.5 642.6 653.6 3902.7 4172.5 4178.9 4180.5 4229.5 85882.6 87813.0 89017.0 89767.6 90339.5 78523.0 79329.6 80117.0 83113.0 83498.0 41671.3 56580.0 62487.0 68778.0 69022.0 8478.1 8807.7 8916.6 8961.5 9005.9 47729.4 48421.5 48423.8 48696.0 49197.3 53005.0 54761.7 60500.0 64921.4 65626.3 12268.0 12456.3 12461.6 12743.0 12858.7 12585.6 13280.8 13562.8 13753.6 14210.2 12025.3 12120.7 12423.6 12836.9 13132.4 12253.3 12299.3 12311.7 13183.7 13190.9 12179.3 12389.8 12772.9 13115.6 13117.3 9635.7 9759.9 10009.0 10204.6 10345.6 9556.5 10659.7 10856.8 10942.1 10967.9 10:32:43 INFO - PROCESS | 32614 | -------- Summary: end -------- 10:32:43 INFO - PROCESS | 32614 | 10:32:44 INFO - TEST-INFO | 32614: exit 0 10:32:44 INFO - TEST-OK | dromaeo_css | took 1116985ms 10:32:44 INFO - TEST-START | kraken 10:32:44 INFO - operating with platform_type : linux_ 10:32:44 INFO - Initialising browser for kraken test... 10:32:44 INFO - TEST-INFO | started process 456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPAV4X5/profile http://localhost:58510/getInfo.html) 10:32:48 INFO - PROCESS | 456 | __metrics Screen width/height:1600/1200 10:32:48 INFO - PROCESS | 456 | colorDepth:24 10:32:48 INFO - PROCESS | 456 | Browser inner width/height: 1024/697 10:32:48 INFO - PROCESS | 456 | __metrics 10:32:48 INFO - PROCESS | 456 | 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" 10:32:48 INFO - PROCESS | 456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:49 INFO - PROCESS | 456 | console.error: PushService: 10:32:49 INFO - PROCESS | 456 | stateChangeProcessEnqueue: Error transitioning state 10:32:49 INFO - PROCESS | 456 | UnknownError 10:32:50 INFO - TEST-INFO | 456: exit 0 10:32:50 INFO - Browser initialized. 10:32:50 INFO - Running cycle 1/1 for kraken test... 10:32:50 INFO - TEST-INFO | started process 539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPAV4X5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:02 INFO - PROCESS | 539 | RSS: Main: 173355008 10:33:02 INFO - PROCESS | 539 | 10:33:05 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58510/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:05 INFO - PROCESS | 539 | RSS: Main: 234889216 10:33:05 INFO - PROCESS | 539 | 10:33:08 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58510/tests/kraken/driver.html?testName=audio-dft) 10:33:09 INFO - PROCESS | 539 | RSS: Main: 216666112 10:33:09 INFO - PROCESS | 539 | 10:33:12 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58510/tests/kraken/driver.html?testName=audio-fft) 10:33:12 INFO - PROCESS | 539 | RSS: Main: 297406464 10:33:12 INFO - PROCESS | 539 | 10:33:15 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58510/tests/kraken/driver.html?testName=audio-oscillator) 10:33:15 INFO - PROCESS | 539 | RSS: Main: 206913536 10:33:15 INFO - PROCESS | 539 | 10:33:17 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:18 INFO - PROCESS | 539 | RSS: Main: 212930560 10:33:18 INFO - PROCESS | 539 | 10:33:21 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58510/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:21 INFO - PROCESS | 539 | RSS: Main: 252010496 10:33:21 INFO - PROCESS | 539 | 10:33:25 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58510/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:25 INFO - PROCESS | 539 | RSS: Main: 251953152 10:33:25 INFO - PROCESS | 539 | 10:33:28 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58510/tests/kraken/driver.html?testName=json-parse-financial) 10:33:29 INFO - PROCESS | 539 | RSS: Main: 250404864 10:33:29 INFO - PROCESS | 539 | 10:33:30 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:31 INFO - PROCESS | 539 | RSS: Main: 213319680 10:33:31 INFO - PROCESS | 539 | 10:33:32 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:33 INFO - PROCESS | 539 | RSS: Main: 219602944 10:33:33 INFO - PROCESS | 539 | 10:33:35 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:36 INFO - PROCESS | 539 | RSS: Main: 229163008 10:33:36 INFO - PROCESS | 539 | 10:33:38 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:39 INFO - PROCESS | 539 | RSS: Main: 237236224 10:33:39 INFO - PROCESS | 539 | 10:33:42 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:43 INFO - PROCESS | 539 | RSS: Main: 235040768 10:33:43 INFO - PROCESS | 539 | 10:33:44 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:58510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58510/tests/kraken/driver.html?testName=ai-astar) 10:33:44 INFO - PROCESS | 539 | RSS: Main: 286130176 10:33:44 INFO - PROCESS | 539 | 10:33:44 INFO - PROCESS | 539 | __start_tp_report 10:33:44 INFO - PROCESS | 539 | _x_x_mozilla_page_load 10:33:44 INFO - PROCESS | 539 | _x_x_mozilla_page_load_details 10:33:44 INFO - PROCESS | 539 | |i|pagename|runs| 10:33:44 INFO - PROCESS | 539 | |0;ai-astar;112;114;113;114;116;114;114;113;113;114 10:33:44 INFO - PROCESS | 539 | |1;audio-beat-detection;146;128;123;168;125;126;124;124;154;124 10:33:44 INFO - PROCESS | 539 | |2;audio-dft;162;162;164;161;161;164;163;163;162;163 10:33:44 INFO - PROCESS | 539 | |3;audio-fft;75;76;75;107;76;75;76;76;99;76 10:33:44 INFO - PROCESS | 539 | |4;audio-oscillator;82;83;115;81;81;82;100;82;82;113 10:33:44 INFO - PROCESS | 539 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 10:33:44 INFO - PROCESS | 539 | |6;imaging-darkroom;146;145;147;146;145;146;146;146;145;146 10:33:44 INFO - PROCESS | 539 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;85;84 10:33:44 INFO - PROCESS | 539 | |8;json-parse-financial;53;51;52;51;51;54;53;54;52;52 10:33:44 INFO - PROCESS | 539 | |9;json-stringify-tinderbox;62;63;64;63;63;63;64;62;62;62 10:33:44 INFO - PROCESS | 539 | |10;stanford-crypto-aes;86;82;85;79;79;79;90;80;79;79 10:33:44 INFO - PROCESS | 539 | |11;stanford-crypto-ccm;146;131;129;131;140;134;133;131;175;141 10:33:44 INFO - PROCESS | 539 | |12;stanford-crypto-pbkdf2;170;166;165;165;169;181;169;173;164;162 10:33:45 INFO - PROCESS | 539 | |13;stanford-crypto-sha256-iterative;63;65;64;64;63;63;67;66;63;63 10:33:45 INFO - PROCESS | 539 | __end_tp_report 10:33:45 INFO - PROCESS | 539 | __start_cc_report 10:33:45 INFO - PROCESS | 539 | _x_x_mozilla_cycle_collect,1684 10:33:45 INFO - PROCESS | 539 | __end_cc_report 10:33:45 INFO - PROCESS | 539 | __startTimestamp1478975624991__endTimestamp 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | ------- Summary: start ------- 10:33:45 INFO - PROCESS | 539 | Number of tests: 14 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:0.93 10:33:45 INFO - PROCESS | 539 | Values: 112.0 114.0 113.0 114.0 116.0 114.0 114.0 113.0 113.0 114.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:127.00 stddev:15.99 (12.6%) stddev-sans-first:16.38 10:33:45 INFO - PROCESS | 539 | Values: 146.0 128.0 123.0 168.0 125.0 126.0 124.0 124.0 154.0 124.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 10:33:45 INFO - PROCESS | 539 | Values: 162.0 162.0 164.0 161.0 161.0 164.0 163.0 163.0 162.0 163.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.70 (15.4%) stddev-sans-first:12.20 10:33:45 INFO - PROCESS | 539 | Values: 75.0 76.0 75.0 107.0 76.0 75.0 76.0 76.0 99.0 76.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.83 (16.9%) stddev-sans-first:14.35 10:33:45 INFO - PROCESS | 539 | Values: 82.0 83.0 115.0 81.0 81.0 82.0 100.0 82.0 82.0 113.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:33:45 INFO - PROCESS | 539 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:33:45 INFO - PROCESS | 539 | Values: 146.0 145.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 10:33:45 INFO - PROCESS | 539 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:1.16 (2.2%) stddev-sans-first:1.20 10:33:45 INFO - PROCESS | 539 | Values: 53.0 51.0 52.0 51.0 51.0 54.0 53.0 54.0 52.0 52.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 10:33:45 INFO - PROCESS | 539 | Values: 62.0 63.0 64.0 63.0 63.0 63.0 64.0 62.0 62.0 62.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.91 (4.8%) stddev-sans-first:3.84 10:33:45 INFO - PROCESS | 539 | Values: 86.0 82.0 85.0 79.0 79.0 79.0 90.0 80.0 79.0 79.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:137.00 stddev:13.76 (10.0%) stddev-sans-first:14.36 10:33:45 INFO - PROCESS | 539 | Values: 146.0 131.0 129.0 131.0 140.0 134.0 133.0 131.0 175.0 141.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:5.50 (3.3%) stddev-sans-first:5.80 10:33:45 INFO - PROCESS | 539 | Values: 170.0 166.0 165.0 165.0 169.0 181.0 169.0 173.0 164.0 162.0 10:33:45 INFO - PROCESS | 539 | 10:33:45 INFO - PROCESS | 539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 10:33:45 INFO - PROCESS | 539 | Values: 63.0 65.0 64.0 64.0 63.0 63.0 67.0 66.0 63.0 63.0 10:33:45 INFO - PROCESS | 539 | -------- Summary: end -------- 10:33:45 INFO - PROCESS | 539 | 10:33:46 INFO - TEST-INFO | 539: exit 0 10:33:46 INFO - TEST-OK | kraken | took 61705ms 10:33:46 INFO - SUITE-END | took 1178s 10:33:46 INFO - Completed test suite (00:19:39) 10:33:46 INFO - javascript benchmark 10:33:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.374125174965, 3162.3991441626104, 3177.714005739483, 3194.8562314695837, 3196.1050905746383, 5326.840194794153, 5352.330958630171, 5421.864453388663, 5465.508104270615, 5485.451454854512, 5411.783528658859, 5433.320834895638, 5433.565314774818, 5435.266239057726, 5440.945590544094, 4877.0, 4899.681520701143, 4912.852614421573, 4949.901001979958, 4980.950190498103, 4886.511348865103, 4894.1679914414635, 4915.901681966377, 4988.176950803113, 5038.974805125988, 4895.437024742165, 4949.406071271453, 4952.975235123819, 4959.479254678261, 4995.6003519718515, 191.49358854888828, 4955.925661115104, 4979.10376132296, 4996.125678006334, 5004.749762511896, 4889.853304400874, 4909.337239472661, 4940.357753492023, 4958.727270000149, 4970.726610036447, 5398.325209348832, 5402.513773760341, 5410.323709536308, 5414.945850541483, 5445.0, 5636.0, 5686.658800471985, 5720.2849643794525, 5839.240898683186, 5845.473907348359, 5807.390224026459, 5894.145348924382, 5925.940740592582, 5941.405859414067, 6029.397060293935, 5539.778408863681, 5540.36285827131, 5543.473370029841, 5548.195511650869, 5552.86117847053, 6076.270847498328, 6078.75684972605, 6080.817575472743, 6088.025915853442, 6088.117223002729, 5616.634918730269, 5643.40744221859, 5652.943470565242, 5657.60396772222, 5726.541876649858, 5629.155626655953, 5738.397468265855, 5788.855278617984, 5800.4489573490455, 5813.651180929158, 5863.208466857005, 5863.589548731547, 5867.73595188209, 5880.764769409261, 5917.6745279010065, 5878.235829342244, 5878.911816322759, 5881.088431293157, 5882.735276912549, 5911.113333000085, 4386.956130438719, 4476.104779044204, 4486.484054333728, 4489.685721999429, 4529.026259354188, 3957.920841583152, 3978.0253837809923, 3991.4611527444004, 4027.577104404054, 4058.5738497457933, 5573.69344686038, 5578.693171875586, 5579.46995035471, 5582.134769110794, 5585.357683866408, 5870.823875283749, 5912.9113063304085, 5915.852103697356, 5920.31916329619, 5924.318703349084, 5385.353757549119, 5440.265564148868, 5545.085060964976, 5591.720413979285, 5601.6358936668985, 5142.742862856842, 5151.124308867502, 5153.587712982952, 5158.380994280636, 5186.40356359016, 6087.57386982907, 6101.115338276014, 6103.572749907464, 6107.236595425572, 6109.450149486567, 5732.942670573241, 5770.047942089508, 5851.678157701367, 5914.142449344735, 5971.880562388815, 6115.483736156459, 6119.167450728499, 6122.428649698624, 6123.112148738497, 6130.795626845359, 5772.249607550992, 5822.214001109796, 5822.417758224144, 5822.679752613647, 5828.271466066742, 5642.915356269741, 5712.457316554921, 5712.7714891403875, 5934.317553481233, 5955.731992060281, 5589.720513974366, 5677.943220567907, 5680.233168522197, 5715.828525144252, 5722.055860782924, 5572.136318870582, 5610.635308704921, 5611.859703507445, 5612.494875461228, 5656.519195868397, 5437.592180586393, 5497.285352904097, 5552.194931734956, 5566.582506312124, 5570.4151064139305, 5660.433956604306, 5695.430456954271, 5708.743106560298, 5791.102379131242, 5791.189233507396, 5567.47109024642, 5611.803586874603, 5612.691301978431, 5628.324601047901, 5663.546916246608], "value": 5351.051892673154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.905829095177, 579.2325169150876, 601.0413390641926, 623.0933991043033, 631.2393565753267, 31576.84211578942, 40313.79843100784, 41230.58769412305, 41257.174856502854, 41307.79346103273, 43040.56959430405, 43435.78282108585, 43469.78265108678, 43476.3478547822, 43507.0, 8473.11032341603, 8620.913790862105, 8621.396502244845, 8624.611892464854, 8625.95687021564, 8364.874526882102, 8438.2827459666, 8458.111898250687, 8463.449875758086, 8468.195521425454, 8496.87254691177, 8552.743417697448, 8553.444026138312, 8562.957185214065, 8564.657413703444, 8480.491170529787, 8513.616887240089, 8524.70163544273, 8529.061803201643, 8530.914690853075, 8491.872621910676, 8519.48883067018, 8546.786330341729, 8562.957185214096, 8564.100769419183, 40560.79719601413, 40812.18375632471, 40999.38500922488, 41089.79455102735, 41258.587414125774, 3334.282844335169, 3383.899636161195, 3416.830312751396, 3418.1112910643164, 3492.8253587320532, 30815.537766933514, 30875.536866947015, 31175.0, 31575.84212078948, 32636.510452343235, 3988.4591810802162, 4101.958980410188, 4178.540360560336, 4211.410402543646, 4223.704340696153, 341478.0, 342698.0, 342818.9999999975, 343176.0, 343238.0, 54863.45136548583, 55408.44591554113, 55532.0, 55533.72233138889, 55546.44453555493, 35803.28393432169, 58520.414795852346, 58595.0, 58603.12095318574, 58686.4131358681, 14947.402103915721, 15954.441594544136, 15974.920125399298, 16036.358545658277, 16069.35722571084, 11647.0, 11650.41747912601, 11650.53397864076, 11729.941350293195, 11737.589184378676, 18895.433137005635, 19072.90463547701, 19077.0, 19100.61798764017, 19129.713054304197, 6811.182658081062, 6917.9654101730175, 6962.547434416747, 7082.575045497287, 7354.521956072838, 928.456852741154, 975.3124047546463, 986.8914419413859, 1048.9475526223657, 1085.4030283344287, 29965.400691986473, 30046.84976575103, 30702.38595228083, 30863.2284192897, 31050.378992420025, 1075.2365820267541, 1086.0605576176551, 1091.4488183467456, 1143.6054561176381, 1145.9743529541015, 15819.304965318022, 16429.67140657204, 16465.753013704805, 16526.752098718527, 16650.417235396704, 585922.0, 588906.0, 589697.390852238, 591905.0, 593350.0, 56538.71730641403, 56658.43341566614, 56708.71645641745, 56770.43229567734, 56914.430855690916, 1313.5599574142577, 1319.5711393797246, 1328.5217321764158, 1339.7990301454665, 1340.1958824705098, 28877.566836497048, 29719.405611888073, 29727.25681857971, 30409.69590304157, 30552.08343749691, 49204.0, 54012.0, 55268.44731552794, 55493.72253138709, 58855.70572147112, 476342.0, 479976.0, 481832.0, 483129.0, 485530.0, 40710.59289407068, 41403.0, 41594.0, 42007.369889451074, 42521.32265450736, 45957.310640339754, 46081.0, 46139.76930115328, 46735.53264467312, 47503.287450687574, 38820.80589597034, 39364.14306780951, 40620.79689601533, 41377.93945176558, 41417.0, 39639.0, 39774.0, 40351.798241008604, 41066.58933410628, 41818.58181418147, 32369.838150809097, 34884.65115348814, 35562.64437355593, 38628.420573691976, 40388.0, 33222.667773321955, 34814.0, 35276.76826250561, 35808.0, 36124.27751445009, 26028.479430411666, 27056.188314350602, 27416.451670966868, 27464.862675686494, 27522.449551009267], "value": 19762.419115478264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.36445948509095, 380.49014320810124, 387.3531202891172, 391.1570565431495, 414.848580268202, 14281.357338919748, 17462.65074698505, 17527.12364381779, 18030.0, 19070.713939290923, 17308.0, 17374.04442755648, 17861.017644029573, 17990.82009179908, 18369.357072502466, 4934.703917764937, 5173.654849739058, 5177.663451875616, 5178.326817513718, 5183.611229157809, 5079.288899554065, 5154.329937108189, 5154.433012368637, 5226.634135610509, 5504.559635229192, 5576.219329293902, 5593.909187708398, 5596.356419011805, 5598.552115830724, 5598.832035038955, 5451.155070964007, 5601.327840659106, 5616.691081990489, 5623.943760562403, 5646.604737668365, 5475.589330800166, 5481.150421684645, 5481.780728770845, 5482.4101010706845, 5488.725563721798, 13086.214827110403, 13412.26232557209, 13497.0, 13508.257045862474, 13546.796798048037, 2153.3432303147533, 2215.4018415027854, 2239.7984181423585, 2433.841800282976, 2581.7676409123083, 9465.66870159548, 9727.173190278834, 9941.403515789003, 10291.794164116676, 10421.114205292559, 1849.3157531713218, 1863.5806943437753, 1864.4686264414577, 1885.8774179678414, 1905.2569497895831, 68377.31622683808, 82993.0, 83612.0, 83991.0, 86006.0, 10548.525316360628, 10772.245942784086, 10838.67483975482, 11002.614908478165, 11106.222564420414, 15185.544433667008, 15315.770263446057, 15321.846781532042, 15325.0, 15339.539813805604, 7714.961425192838, 7810.960945195351, 7854.410919181084, 7980.082290536547, 8035.196480351918, 7371.631418429057, 7410.851782964311, 7444.478886477895, 7540.585267810214, 7666.310032097138, 4571.9314210286875, 4595.793189306489, 4642.51253618372, 4685.742284174403, 4708.293755936637, 1911.4170178095815, 1931.9227230910888, 1960.7941166177632, 1964.5186929202437, 1993.1031036033553, 821.482466046387, 892.1747383670208, 930.7393929699695, 983.6508039645965, 1008.8537162111453, 17175.620216844625, 17294.913525432545, 18391.448256552325, 18497.445076647724, 18713.345032923782, 942.1406032690751, 944.9622015119318, 956.3735753081743, 964.1515466389673, 966.917811985975, 9737.610495580238, 9990.700278991642, 10172.135368493613, 10194.592216311414, 10265.973402659823, 429130.0, 442091.0, 444623.0, 445089.0, 445936.0, 83907.0, 84642.57678711567, 87283.56358218295, 88720.0, 89606.0, 955.245356168633, 970.427447805798, 1025.8050970315765, 1027.173125633857, 1032.210359075308, 16105.67788644244, 16446.67106657884, 16489.09309987962, 16928.49214523566, 17589.64820703553, 42064.0, 42829.35755963601, 43139.0, 43650.0, 44085.82798408161, 58364.70817646055, 59098.0, 59436.40563594309, 59471.40528594659, 60548.091778622475, 7650.349720273839, 8128.75613731589, 8200.220979006985, 8226.465279756796, 8542.145785421408, 12716.427760750974, 12743.171693839871, 12763.872361276268, 12853.228806271654, 13300.733985320432, 10659.733506662396, 11107.72230694239, 11113.555457781598, 11545.076393888638, 11580.0, 11222.214444988773, 11356.772864542829, 11374.374409407563, 11420.31478111316, 11524.0, 11370.772584548427, 11531.596394126165, 11635.883641163819, 11752.76494470123, 11986.220895641756, 8154.469959452616, 8277.668893244203, 11164.720881978015, 11730.296182228753, 12190.512379505075, 10695.732606684895, 11707.941460292644, 11736.0, 12144.33206173669, 12534.0], "value": 8833.692893875083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.8983076269283, 1398.0772690024585, 1442.516756886443, 1527.7784721215423, 1730.9221085051172, 7515.361194298484, 8085.4340196186295, 8387.496750194992, 8396.286315663176, 8668.956655216714, 8355.331573474123, 8441.662333506667, 8446.83106337873, 8453.450525715823, 8456.154384561556, 2297.850639708418, 2307.538492301538, 2307.7230732312146, 2308.73449553301, 2316.281952594701, 2297.9195728149516, 2339.42684042409, 2365.562370961369, 2366.1363602285214, 2371.2412028150998, 2288.096202000217, 2291.873946932918, 2302.631578947369, 2322.6864373309554, 2323.2101085630884, 2246.5619204255177, 2285.245868863271, 2308.0, 2311.387482317179, 2312.537492501498, 2272.216085450517, 2290.599145149609, 2292.7821856923565, 2299.1722979727283, 2299.2872209614907, 8514.403991720583, 8519.829603407898, 8609.913900860975, 8624.78438039054, 8634.740957771213, 5059.468755780626, 5231.581473482112, 5237.188235823453, 5272.868178295535, 5297.311349524537, 3485.1112966193714, 3494.6155922848466, 3523.788572685647, 3590.35373632746, 3595.8741444049333, 1116.385987706758, 1121.506537123671, 1134.0, 1187.091874715843, 1205.6202296276645, 11343.886561134366, 11348.716282092932, 11355.943220283845, 11369.31784092957, 11504.137189710722, 4196.790160491963, 4445.444319460067, 4448.911021779546, 4555.385023021916, 4561.794719237642, 9135.360524763202, 9156.587953542106, 9159.267258619295, 9168.129027742354, 9171.174594286545, 5005.649604527648, 5041.319421878, 5042.218456139304, 5047.823326183639, 5060.291559181717, 3952.8616498422994, 4258.297380932174, 4396.3625274335045, 4425.269830478, 4719.83480578185, 3689.151495156129, 3771.9245615088093, 3789.204267103939, 3827.2154208387215, 3924.5682974872743, 1146.2434793036555, 1161.9593314233962, 1171.6485054483621, 1172.8475298211179, 1185.17038073349, 767.6699019421702, 824.7855557555079, 880.6389380354024, 903.9276857851356, 915.5285028210477, 5355.169948657965, 5480.698561579072, 5550.888982220333, 5558.471945165203, 5937.821865344046, 887.2990337633197, 888.8755574219614, 899.2850683706469, 956.1251454918671, 993.9503024848729, 3324.2317430372545, 3434.1242983039165, 3476.3047390521997, 3518.3702296340934, 3541.911452213715, 10096.596136154618, 10631.52158152885, 10637.46812659364, 10637.9468102659, 10685.412302323291, 10542.683719488428, 10578.0, 10604.734881627866, 10616.628418005488, 10617.787644247072, 7862.213778622092, 8047.959760201162, 8053.798655033671, 8055.5972201389695, 8065.4757440767335, 4985.700857948535, 5063.291139240436, 5122.46214147524, 5213.869653258547, 5318.042752304467, 9555.331126821056, 9637.469939153134, 9749.36629119105, 9817.950910245689, 9860.556274967501, 9543.90456095458, 9743.61025558998, 9794.559244834141, 9851.128285625708, 9855.605775769176, 7569.962150189213, 7704.499207551491, 7756.650950707119, 7757.883631745642, 7761.883571746315, 8116.797080073045, 8192.0, 8200.0, 8219.095899450936, 8312.916870831456, 7248.782536523912, 7263.34629883313, 7291.161516425679, 7433.628318584158, 7583.2416758323725, 7311.195768465571, 7422.480426370103, 7427.7771666850085, 7442.479026468095, 7471.775846724607, 6953.443724501926, 6986.231514533296, 7055.435565154878, 7055.6824942876665, 7062.0, 4537.591616754508, 4557.7721113944835, 4582.725036497821, 4590.586847183636, 4676.111538807616, 4681.906361872675, 4687.507811679725, 4691.03833714081, 4699.835505757282, 4802.556038140938], "value": 4436.27642592207, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.07600263247093, 326.9133679574913, 327.6068717538953, 331.7362696656158, 338.0247984564531, 5091.777973286413, 5302.549283310918, 5352.277442545255, 5361.276227709258, 5440.156775699763, 5155.871103222421, 5223.294855194547, 5230.424653288144, 5243.134882744353, 5252.395974462938, 4129.194807012634, 4139.296319625656, 4139.461869956901, 4145.636986917459, 4159.022629682037, 3912.5304963404433, 4106.2198182345255, 4161.479815023122, 4162.41726158338, 4163.916721665565, 4083.8162282697203, 4090.202410529948, 4100.261952848486, 4100.753954762708, 4101.159262351226, 4070.1859628074358, 4071.5724848890886, 4088.1414902870433, 4101.405296232059, 4102.159057393257, 3604.873829415958, 3605.7019472989705, 3610.837512311952, 3618.656227658368, 3623.076115590534, 5058.799422251295, 5143.408508021551, 5154.38147422308, 5158.948410515922, 5161.948380516184, 4647.837325693618, 4663.463701674317, 4668.136394766979, 4672.719636821767, 4674.158651442773, 5498.505134537871, 5498.697571633558, 5505.091385116532, 5510.8071217507195, 5510.834674959758, 3783.9054023649355, 3880.5925377835483, 3920.5099362579676, 3920.9803950980063, 3922.17634296798, 5672.546196304327, 5694.4590263924865, 5694.914576281359, 5697.373288938214, 5720.971395143039, 3997.760134391946, 4005.619466150711, 4008.4788977432745, 4025.396190571379, 4026.7583944963394, 3958.129211573449, 4068.270984831494, 4071.918561628751, 4073.24644940681, 4085.97957010219, 4652.371929789503, 4656.185167595657, 4662.510436404129, 4664.766761661904, 4675.181843177498, 5505.421930697219, 5516.972415137979, 5528.44715528452, 5538.418466061086, 5542.140968149944, 1289.509986205236, 1331.7003674173427, 1347.9326033698276, 1359.9732202187286, 1363.277462944641, 906.2613969614742, 933.710549729586, 944.6821683751128, 945.4232917920064, 948.5826236455937, 5117.8464646060675, 5128.871778205575, 5130.9230361544605, 5150.845474635767, 5160.612954028463, 5387.767339596211, 5427.3758517770175, 5433.6196466247775, 5444.237806707064, 5459.918101228484, 4897.975510122426, 5074.467180945948, 5135.639055650256, 5164.561012313995, 5170.638055336166, 2908.4619345421165, 2917.6207093078187, 2919.3285544324926, 2923.2399576110365, 2926.0300794692976, 5548.195511650788, 5566.972165139148, 5630.690312032795, 5655.0, 5671.716414179275, 5205.24523944026, 5462.535684466785, 5464.9180262296095, 5524.1989911462615, 5546.417626149277, 5585.720713964285, 5608.523275521627, 5610.747516361774, 5612.0, 5637.238972738628, 5272.841814745564, 5393.40672526014, 5418.187271909245, 5428.647137936022, 5471.534919531884, 5332.760025798771, 5356.705381204071, 5363.517283444508, 5368.731563421735, 5370.489803468664, 5586.13414920688, 5600.7199640017025, 5607.355154157324, 5617.578681598979, 5620.381758006698, 3775.5091838060875, 3880.2627500775893, 3892.2410130025505, 3905.3556163232747, 3917.8628747993685, 5371.838844834661, 5393.325834270716, 5453.345598528202, 5455.890882182413, 5477.424870388551, 5443.428440013741, 5502.624343914022, 5541.556675466034, 5559.305086864142, 5568.6658800472105, 5502.459311392817, 5528.640638358494, 5535.916961245665, 5540.833774986757, 5560.972195138998, 5185.818496352609, 5405.810796622257, 5423.620346575702, 5458.0, 5475.534579560782, 5503.3120859892515, 5518.834434966958, 5599.580031497572, 5606.635568688022, 5607.214989901336, 5506.091494903296, 5507.944920550904, 5508.586855985897, 5523.309586301712, 5530.640508367104], "value": 4149.282423147152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.1714817940741, 705.7882635209437, 728.7376544443999, 743.6988019851958, 774.8101715079806, 14025.579232623026, 14964.027338223035, 15098.018628789148, 15150.090994540335, 15242.237888105592, 13143.145695529807, 13196.406161722722, 13204.141730787493, 13215.867841321584, 13227.206367617926, 760.3385055002155, 773.0182668011649, 776.638862928738, 779.1312686354702, 779.3219898688121, 771.1863983497408, 772.8686123359042, 775.9030121234846, 776.4836383804763, 776.7786180938434, 805.4925396999911, 810.5015415519442, 810.9918900810975, 812.695239285268, 812.8414959082982, 809.7570728781342, 810.432697112021, 810.8256724804196, 811.1482942909951, 811.2333844516934, 595.6009473652663, 596.785157343356, 597.2832600878919, 597.5040716205539, 597.7728463184005, 12817.615471535868, 13817.240051797147, 13953.581392558239, 14003.369848356848, 14009.789853152211, 11501.30992140466, 11796.0, 11853.229540079867, 11944.0, 12201.0, 10175.491225438698, 10277.383356998529, 10305.12406445453, 10440.843387349196, 10482.68551943443, 3494.1771976183154, 3574.4459608760685, 3578.6600272974024, 3580.1407662161155, 3588.6949609283242, 57516.712416438066, 61963.38036619621, 62238.68880655568, 62363.68818155926, 62385.0, 8921.509316987627, 8962.775930601787, 9004.549772511347, 9138.725838224864, 9298.488583127857, 17887.0, 18065.7290140648, 18139.183736731615, 18152.818471815375, 18193.0, 7397.667104980289, 7487.475876688688, 7558.924410755932, 7598.240175982468, 7878.566678832604, 3994.980025099856, 4020.638142567183, 4023.295923213426, 4096.73371230869, 4114.115465175002, 3295.1926777939557, 3426.554547908756, 3428.4171690812123, 3428.9657103429145, 3436.7078798302423, 567.9233303504056, 577.535084257177, 581.7294957844538, 587.7384563869037, 591.0189086117025, 580.9448102430263, 587.1574290892582, 643.2891654721559, 651.3486513486514, 655.2301046270613, 8317.916820831835, 8366.707165249187, 8515.14848515156, 8644.092370301154, 8687.826243475096, 561.6012631032013, 606.3814908793006, 637.4836382530166, 642.5823214910346, 653.5621133840339, 3902.687784977195, 4172.5410204877435, 4178.895527611834, 4180.519240287345, 4229.450171477688, 85882.57058714791, 87813.0, 89017.0, 89767.55116224507, 90339.54830225807, 78523.0, 79329.60335198288, 80117.0, 83113.0, 83498.0, 41671.26104513384, 56580.01969931032, 62487.0, 68778.0, 69021.999999999, 8478.096021648802, 8807.691730789391, 8916.643334266557, 8961.462312261285, 9005.864912026456, 47729.374884381694, 48421.5157848417, 48423.75788121037, 48696.0, 49197.262041068694, 53005.0, 54761.72619136879, 60500.0, 64921.35078649342, 65626.34373656202, 12268.0, 12456.31490268044, 12461.563845265735, 12743.044271679475, 12858.678533036375, 12585.622431327074, 13280.80078798838, 13562.79655805144, 13753.587392378246, 14210.21843798601, 12025.338606376383, 12120.696982575506, 12423.565175218824, 12836.87163128394, 13132.409041593342, 12253.326067066397, 12299.262044277371, 12311.692207694521, 13183.736325273248, 13190.868091319348, 12179.269243845398, 12389.814152787536, 12772.936135319263, 13115.606531804062, 13117.34413279313, 9635.710928672152, 9759.9024009759, 10008.976660682169, 10204.571360009753, 10345.586176553155, 9556.474393908402, 10659.680209593724, 10856.782864342511, 10942.124630029737, 10967.903209678969], "value": 6737.589798825059, "unit": "score"}], "name": "dromaeo_css", "value": 6982.227138283579, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 114.0, 116.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 123.0, 168.0, 125.0, 126.0, 124.0, 124.0, 154.0, 124.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 161.0, 164.0, 163.0, 163.0, 162.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 107.0, 76.0, 75.0, 76.0, 76.0, 99.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 115.0, 81.0, 81.0, 82.0, 100.0, 82.0, 82.0, 113.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 51.0, 54.0, 53.0, 54.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 85.0, 79.0, 79.0, 79.0, 90.0, 80.0, 79.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 131.0, 129.0, 131.0, 140.0, 134.0, 133.0, 131.0, 175.0, 141.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 165.0, 165.0, 169.0, 181.0, 169.0, 173.0, 164.0, 162.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 63.0, 63.0, 67.0, 66.0, 63.0, 63.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1497.6, "alertThreshold": 2.0}]} 10:33:46 INFO - Return code: 0 10:33:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:33:46 INFO - # TBPL SUCCESS # 10:33:46 INFO - Running post-action listener: _resource_record_post_action 10:33:46 INFO - [mozharness: 2016-11-12 18:33:46.803345Z] Finished run-tests step (success) 10:33:46 INFO - Running post-run listener: _resource_record_post_run 10:33:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395776000; Read time: 8; Write time: 237772 10:33:46 INFO - TinderboxPrint: CPU usage
13.1% 10:33:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:33:46 INFO - TinderboxPrint: I/O write bytes / time
395,776,000 / 237,772 10:33:46 INFO - TinderboxPrint: CPU idle
8,293.3 (86.9%) 10:33:46 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 10:33:46 INFO - TinderboxPrint: Swap in / out
0 / 0 10:33:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103727104; Read time: 0; Write time: 88916 10:33:46 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 291713024; Read time: 0; Write time: 148856 10:33:47 INFO - Running post-run listener: _upload_blobber_files 10:33:47 INFO - Blob upload gear active. 10:33:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:47 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 10:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:33:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:48 INFO - (blobuploader) - INFO - Done attempting. 10:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:49 INFO - (blobuploader) - INFO - Done attempting. 10:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:52 INFO - (blobuploader) - INFO - Done attempting. 10:33:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:52 INFO - Return code: 0 10:33:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/475026fc9a5c5a5a2de3e345cdfbf66299722451f68c4e068a0b41d1ce305ab73344f6d14905647b6692a12267b54fce68538cf49c5e78aab5f8d97fff87f794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6b1aacdd3c7f5c59ff43faf2524e87ca36a3267ad1ab34ab2dc47acbe798ca8d5359de6d96ef1c80d08cb688fd89a081f3126f7905b3f53a24eac8ab33787f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9c94bbeb85fa555252b59bc0d92509e1b47b18e7f7d49f11dcfddc0b4252904557ee020249da1129c334f46194ea65bff317a7ba49436347ab8b0604aed18c"} 10:33:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:52 INFO - Contents: 10:33:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/475026fc9a5c5a5a2de3e345cdfbf66299722451f68c4e068a0b41d1ce305ab73344f6d14905647b6692a12267b54fce68538cf49c5e78aab5f8d97fff87f794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6b1aacdd3c7f5c59ff43faf2524e87ca36a3267ad1ab34ab2dc47acbe798ca8d5359de6d96ef1c80d08cb688fd89a081f3126f7905b3f53a24eac8ab33787f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9c94bbeb85fa555252b59bc0d92509e1b47b18e7f7d49f11dcfddc0b4252904557ee020249da1129c334f46194ea65bff317a7ba49436347ab8b0604aed18c"} 10:33:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:52 INFO - Copying logs to upload dir... 10:33:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.334375 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-12 10:33:51.579875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 10:33:51.583156) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/475026fc9a5c5a5a2de3e345cdfbf66299722451f68c4e068a0b41d1ce305ab73344f6d14905647b6692a12267b54fce68538cf49c5e78aab5f8d97fff87f794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6b1aacdd3c7f5c59ff43faf2524e87ca36a3267ad1ab34ab2dc47acbe798ca8d5359de6d96ef1c80d08cb688fd89a081f3126f7905b3f53a24eac8ab33787f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9c94bbeb85fa555252b59bc0d92509e1b47b18e7f7d49f11dcfddc0b4252904557ee020249da1129c334f46194ea65bff317a7ba49436347ab8b0604aed18c"} build_url:https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/L4cOml15Rga9dUmHRe0B6A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/475026fc9a5c5a5a2de3e345cdfbf66299722451f68c4e068a0b41d1ce305ab73344f6d14905647b6692a12267b54fce68538cf49c5e78aab5f8d97fff87f794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6b1aacdd3c7f5c59ff43faf2524e87ca36a3267ad1ab34ab2dc47acbe798ca8d5359de6d96ef1c80d08cb688fd89a081f3126f7905b3f53a24eac8ab33787f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9c94bbeb85fa555252b59bc0d92509e1b47b18e7f7d49f11dcfddc0b4252904557ee020249da1129c334f46194ea65bff317a7ba49436347ab8b0604aed18c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 10:33:51.609713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:33:51.610085) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1478973871.268221-309655606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 10:33:51.695799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 10:33:51.696346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 10:33:51.696936) ========= ========= Total master_lag: 0.18 =========