builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1485167047.83 results: success (0) buildid: 20170123004004 builduid: c50289cf99724f65990a187417e962aa revision: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.826919) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.827393) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.827700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.842294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.842772) ========= 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=52faae308a556c440401f8e5000001e8-1485167050.63607-915934285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 02:24:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2017-01-23 02:24:10 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.999086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:07.999399) ========= 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=52faae308a556c440401f8e5000001e8-1485167050.63607-915934285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015036 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.049363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.049770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 24a81d93e07cc96300f8e1f5c69034dd4743bd63 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 24a81d93e07cc96300f8e1f5c69034dd4743bd63 --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=52faae308a556c440401f8e5000001e8-1485167050.63607-915934285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 02:24:10,960 truncating revision to first 12 chars 2017-01-23 02:24:10,961 Setting DEBUG logging. 2017-01-23 02:24:10,961 attempt 1/10 2017-01-23 02:24:10,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/24a81d93e07c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 02:24:11,316 unpacking tar archive at: mozilla-aurora-24a81d93e07c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.748554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.748880) ========= script_repo_revision: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.749280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.749575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 02:24:08.758835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-23 02:24:08.759124) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1485167050.63607-915934285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:11 INFO - MultiFileLogger online at 20170123 02:24:11 in /builds/slave/test 02:24:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:24:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:11 INFO - {'append_to_log': False, 02:24:11 INFO - 'base_work_dir': '/builds/slave/test', 02:24:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:24:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:11 INFO - 'branch': 'Mozilla-Aurora', 02:24:11 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:11 INFO - 'config_files': ('talos/linux_config.py',), 02:24:11 INFO - 'default_actions': ('clobber', 02:24:11 INFO - 'read-buildbot-config', 02:24:11 INFO - 'download-and-extract', 02:24:11 INFO - 'populate-webroot', 02:24:11 INFO - 'create-virtualenv', 02:24:11 INFO - 'install', 02:24:11 INFO - 'run-tests'), 02:24:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:11 INFO - 'download_minidump_stackwalk': True, 02:24:11 INFO - 'download_symbols': 'ondemand', 02:24:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:11 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:11 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:11 INFO - 'installer_path': 'installer.exe', 02:24:11 INFO - 'log_level': 'info', 02:24:11 INFO - 'log_name': 'talos', 02:24:11 INFO - 'log_to_console': True, 02:24:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:11 INFO - 'opt_config_files': (), 02:24:11 INFO - 'pip_index': False, 02:24:11 INFO - 'sps_profile': False, 02:24:11 INFO - 'sps_profile_interval': 0, 02:24:11 INFO - 'suite': 'dromaeojs', 02:24:11 INFO - 'system_bits': '32', 02:24:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:11 INFO - 'title': 'talos-linux64-ix-056', 02:24:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:11 INFO - 'use_talos_json': True, 02:24:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:11 INFO - 'work_dir': 'build'} 02:24:11 INFO - [mozharness: 2017-01-23 10:24:11.770376Z] Running clobber step. 02:24:11 INFO - Running pre-action listener: _resource_record_pre_action 02:24:11 INFO - Running main action method: clobber 02:24:11 INFO - rmtree: /builds/slave/test/build 02:24:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:12 INFO - Running post-action listener: _resource_record_post_action 02:24:12 INFO - [mozharness: 2017-01-23 10:24:12.237679Z] Finished clobber step (success) 02:24:12 INFO - [mozharness: 2017-01-23 10:24:12.237780Z] Running read-buildbot-config step. 02:24:12 INFO - Running pre-action listener: _resource_record_pre_action 02:24:12 INFO - Running main action method: read_buildbot_config 02:24:12 INFO - Using buildbot properties: 02:24:12 INFO - { 02:24:12 INFO - "project": "", 02:24:12 INFO - "product": "firefox", 02:24:12 INFO - "script_repo_revision": "production", 02:24:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:24:12 INFO - "repository": "", 02:24:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:24:12 INFO - "buildid": "20170123004004", 02:24:12 INFO - "stage_platform": "linux64-pgo", 02:24:12 INFO - "basedir": "/builds/slave/test", 02:24:12 INFO - "nightly_build": "True", 02:24:12 INFO - "buildnumber": 1027, 02:24:12 INFO - "slavename": "talos-linux64-ix-056", 02:24:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:24:12 INFO - "platform": "ubuntu64_hw", 02:24:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:24:12 INFO - "branch": "mozilla-aurora", 02:24:12 INFO - "repo_path": "releases/mozilla-aurora", 02:24:12 INFO - "revision": "24a81d93e07cc96300f8e1f5c69034dd4743bd63", 02:24:12 INFO - "pgo_build": "True", 02:24:12 INFO - "builduid": "c50289cf99724f65990a187417e962aa", 02:24:12 INFO - "slavebuilddir": "test" 02:24:12 INFO - } 02:24:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:24:12 INFO - Running post-action listener: _resource_record_post_action 02:24:12 INFO - [mozharness: 2017-01-23 10:24:12.240408Z] Finished read-buildbot-config step (success) 02:24:12 INFO - [mozharness: 2017-01-23 10:24:12.240496Z] Running download-and-extract step. 02:24:12 INFO - Running pre-action listener: _resource_record_pre_action 02:24:12 INFO - Running main action method: download_and_extract 02:24:12 INFO - mkdir: /builds/slave/test/build/tests 02:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:12 INFO - trying https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:24:12 INFO - Downloading https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:24:12 INFO - Downloaded 1361 bytes. 02:24:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:24:12 INFO - Using the following test package requirements: 02:24:12 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:24:12 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:12 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:24:12 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'jsshell-linux-x86_64.zip'], 02:24:12 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:12 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:24:12 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:24:12 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:24:12 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:12 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:24:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:12 INFO - Fetch https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:24:13 INFO - Http code: 200 02:24:13 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 02:24:13 INFO - x-amz-cf-id: zuJpmSpANjw79bUqEW1ZgfRIaH_Nlo_E9WhPd8ymVHaiC_Y7Th3Nlg== 02:24:13 INFO - x-amz-version-id: Id7UG.cWT1F6xx244kKTZc4YVzXDZizd 02:24:13 INFO - Expected file size: 21950454 02:24:13 INFO - Obtained file size: 21950454 02:24:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:24:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:24:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:17 INFO - Fetch https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:24:18 INFO - Http code: 200 02:24:18 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 02:24:18 INFO - x-amz-cf-id: gy7e97EwGsWJQUrbqsdPFRUcfN7OOqkyU4vheyOEtUG0pMEA1XqhRA== 02:24:18 INFO - x-amz-version-id: Id7UG.cWT1F6xx244kKTZc4YVzXDZizd 02:24:18 INFO - Expected file size: 21950454 02:24:18 INFO - Obtained file size: 21950454 02:24:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:24:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:24:22 INFO - Fetch https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:24:23 INFO - Http code: 200 02:24:23 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 02:24:23 INFO - x-amz-cf-id: o-DCVGmVcNfZ8fNz5CJqlMZcUlFdGFBZj1QJZbZcT3hTPy5Tvq9b-g== 02:24:23 INFO - x-amz-version-id: TU9MrHrRYuq8BfKgKtGRMRVm2Tsti17j 02:24:23 INFO - Expected file size: 14402992 02:24:23 INFO - Obtained file size: 14402992 02:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:23 INFO - trying https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:24:23 INFO - Downloading https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:24:24 INFO - Downloaded 64498406 bytes. 02:24:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:24:24 INFO - mkdir: /builds/slave/test/properties 02:24:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:24:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:24:24 INFO - Contents: 02:24:24 INFO - build_url:https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:24:25 INFO - Running post-action listener: _resource_record_post_action 02:24:25 INFO - Running post-action listener: set_extra_try_arguments 02:24:25 INFO - [mozharness: 2017-01-23 10:24:25.515637Z] Finished download-and-extract step (success) 02:24:25 INFO - [mozharness: 2017-01-23 10:24:25.515864Z] Running populate-webroot step. 02:24:25 INFO - Running pre-action listener: _resource_record_pre_action 02:24:25 INFO - Running main action method: populate_webroot 02:24:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:25 INFO - '--tppagecycles', 02:24:25 INFO - '7'], 02:24:25 INFO - 'tests': ['tsvgm']}}, 02:24:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:24:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:24:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:24:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['damp', 'tps']}, 02:24:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'tests': ['damp', 'tps']}, 02:24:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['dromaeo_dom']}, 02:24:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['basic_compositor_video']}, 02:24:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:24:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['a11yr', 02:24:25 INFO - 'ts_paint', 02:24:25 INFO - 'tpaint', 02:24:25 INFO - 'sessionrestore', 02:24:25 INFO - 'sessionrestore_no_auto_restore', 02:24:25 INFO - 'tabpaint']}, 02:24:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:24:25 INFO - 'ts_paint', 02:24:25 INFO - 'tpaint', 02:24:25 INFO - 'sessionrestore', 02:24:25 INFO - 'sessionrestore_no_auto_restore', 02:24:25 INFO - 'tabpaint']}, 02:24:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:24:25 INFO - 'ts_paint', 02:24:25 INFO - 'tpaint', 02:24:25 INFO - 'sessionrestore', 02:24:25 INFO - 'sessionrestore_no_auto_restore', 02:24:25 INFO - 'tabpaint']}, 02:24:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:24:25 INFO - 'ts_paint', 02:24:25 INFO - 'tpaint', 02:24:25 INFO - 'sessionrestore', 02:24:25 INFO - 'sessionrestore_no_auto_restore', 02:24:25 INFO - 'tabpaint']}, 02:24:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['a11yr', 02:24:25 INFO - 'ts_paint', 02:24:25 INFO - 'tpaint', 02:24:25 INFO - 'sessionrestore', 02:24:25 INFO - 'sessionrestore_no_auto_restore', 02:24:25 INFO - 'tabpaint']}, 02:24:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['a11yr', 02:24:25 INFO - 'ts_paint', 02:24:25 INFO - 'tpaint', 02:24:25 INFO - 'sessionrestore', 02:24:25 INFO - 'sessionrestore_no_auto_restore', 02:24:25 INFO - 'tabpaint']}, 02:24:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['tsvgx', 02:24:25 INFO - 'tsvgr_opacity', 02:24:25 INFO - 'tart', 02:24:25 INFO - 'tscrollx', 02:24:25 INFO - 'cart']}, 02:24:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:24:25 INFO - 'tsvgr_opacity', 02:24:25 INFO - 'tart', 02:24:25 INFO - 'tscrollx', 02:24:25 INFO - 'cart']}, 02:24:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'talos_options': ['--disable-e10s'], 02:24:25 INFO - 'tests': ['tp5o']}, 02:24:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'tests': ['tp5o']}, 02:24:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'talos_options': ['--disable-e10s', 02:24:25 INFO - '--xperf_path', 02:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:25 INFO - 'tests': ['tp5n']}, 02:24:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:25 INFO - 'talos_options': ['--xperf_path', 02:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:25 INFO - 'tests': ['tp5n']}}, 02:24:25 INFO - 'talos.zip': {'path': '', 02:24:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:25 INFO - Running post-action listener: _resource_record_post_action 02:24:25 INFO - [mozharness: 2017-01-23 10:24:25.530977Z] Finished populate-webroot step (success) 02:24:25 INFO - [mozharness: 2017-01-23 10:24:25.531064Z] Running create-virtualenv step. 02:24:25 INFO - Running pre-action listener: _resource_record_pre_action 02:24:25 INFO - Running main action method: create_virtualenv 02:24:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:24:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:24:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:24:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:25 INFO - Using real prefix '/usr' 02:24:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:24:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:28 INFO - Installing pip.................done. 02:24:28 INFO - Return code: 0 02:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:24:28 INFO - Reading from file tmpfile_stdout 02:24:28 INFO - Output received: 02:24:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:24:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:24:28 INFO - Using env: {'DISPLAY': ':0', 02:24:28 INFO - 'HOME': '/home/cltbld', 02:24:28 INFO - 'LANG': 'en_US.UTF-8', 02:24:28 INFO - 'LANGUAGE': 'en_US:en', 02:24:28 INFO - 'LOGNAME': 'cltbld', 02:24:28 INFO - 'MAIL': '/var/mail/cltbld', 02:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:28 INFO - 'MOZ_NO_REMOTE': '1', 02:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:28 INFO - 'NO_EM_RESTART': '1', 02:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:28 INFO - 'PWD': '/builds/slave/test', 02:24:28 INFO - 'SHELL': '/bin/bash', 02:24:28 INFO - 'SHLVL': '1', 02:24:28 INFO - 'TERM': 'linux', 02:24:28 INFO - 'TMOUT': '86400', 02:24:28 INFO - 'USER': 'cltbld', 02:24:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:28 INFO - '_': '/tools/buildbot/bin/python'} 02:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:24:28 INFO - Cleaning up... 02:24:28 INFO - Return code: 0 02:24:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:28 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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:24:28 INFO - Using env: {'DISPLAY': ':0', 02:24:28 INFO - 'HOME': '/home/cltbld', 02:24:28 INFO - 'LANG': 'en_US.UTF-8', 02:24:28 INFO - 'LANGUAGE': 'en_US:en', 02:24:28 INFO - 'LOGNAME': 'cltbld', 02:24:28 INFO - 'MAIL': '/var/mail/cltbld', 02:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:28 INFO - 'MOZ_NO_REMOTE': '1', 02:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:28 INFO - 'NO_EM_RESTART': '1', 02:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:28 INFO - 'PWD': '/builds/slave/test', 02:24:28 INFO - 'SHELL': '/bin/bash', 02:24:28 INFO - 'SHLVL': '1', 02:24:28 INFO - 'TERM': 'linux', 02:24:28 INFO - 'TMOUT': '86400', 02:24:28 INFO - 'USER': 'cltbld', 02:24:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:28 INFO - '_': '/tools/buildbot/bin/python'} 02:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:28 INFO - Downloading/unpacking psutil>=3.1.1 02:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:30 INFO - Installing collected packages: psutil 02:24:30 INFO - Running setup.py install for psutil 02:24:30 INFO - building 'psutil._psutil_linux' extension 02:24:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:24:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:24:31 INFO - building 'psutil._psutil_posix' extension 02:24:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:24:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:24:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:31 INFO - Successfully installed psutil 02:24:31 INFO - Cleaning up... 02:24:31 INFO - Return code: 0 02:24:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:24: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 mozsystemmonitor==0.3 02:24:31 INFO - Using env: {'DISPLAY': ':0', 02:24:31 INFO - 'HOME': '/home/cltbld', 02:24:31 INFO - 'LANG': 'en_US.UTF-8', 02:24:31 INFO - 'LANGUAGE': 'en_US:en', 02:24:31 INFO - 'LOGNAME': 'cltbld', 02:24:31 INFO - 'MAIL': '/var/mail/cltbld', 02:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:31 INFO - 'MOZ_NO_REMOTE': '1', 02:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:31 INFO - 'NO_EM_RESTART': '1', 02:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:31 INFO - 'PWD': '/builds/slave/test', 02:24:31 INFO - 'SHELL': '/bin/bash', 02:24:31 INFO - 'SHLVL': '1', 02:24:31 INFO - 'TERM': 'linux', 02:24:31 INFO - 'TMOUT': '86400', 02:24:31 INFO - 'USER': 'cltbld', 02:24:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:31 INFO - '_': '/tools/buildbot/bin/python'} 02:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:24:33 INFO - Installing collected packages: mozsystemmonitor 02:24:33 INFO - Running setup.py install for mozsystemmonitor 02:24:33 INFO - Successfully installed mozsystemmonitor 02:24:33 INFO - Cleaning up... 02:24:33 INFO - Return code: 0 02:24:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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', '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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:24: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 jsonschema==2.5.1 02:24:33 INFO - Using env: {'DISPLAY': ':0', 02:24:33 INFO - 'HOME': '/home/cltbld', 02:24:33 INFO - 'LANG': 'en_US.UTF-8', 02:24:33 INFO - 'LANGUAGE': 'en_US:en', 02:24:33 INFO - 'LOGNAME': 'cltbld', 02:24:33 INFO - 'MAIL': '/var/mail/cltbld', 02:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:33 INFO - 'MOZ_NO_REMOTE': '1', 02:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:33 INFO - 'NO_EM_RESTART': '1', 02:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:33 INFO - 'PWD': '/builds/slave/test', 02:24:33 INFO - 'SHELL': '/bin/bash', 02:24:33 INFO - 'SHLVL': '1', 02:24:33 INFO - 'TERM': 'linux', 02:24:33 INFO - 'TMOUT': '86400', 02:24:33 INFO - 'USER': 'cltbld', 02:24:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:33 INFO - '_': '/tools/buildbot/bin/python'} 02:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:36 INFO - warning: no files found matching '*.txt' 02:24:36 INFO - no previously-included directories found matching 'build' 02:24:36 INFO - no previously-included directories found matching 'dist' 02:24:36 INFO - no previously-included directories found matching '.git*' 02:24:36 INFO - Installing collected packages: jsonschema, functools32 02:24:36 INFO - Running setup.py install for functools32 02:24:36 INFO - warning: no files found matching '*.txt' 02:24:36 INFO - no previously-included directories found matching 'build' 02:24:36 INFO - no previously-included directories found matching 'dist' 02:24:36 INFO - no previously-included directories found matching '.git*' 02:24:36 INFO - Successfully installed jsonschema functools32 02:24:36 INFO - Cleaning up... 02:24:36 INFO - Return code: 0 02:24:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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', '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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:24: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 functools32==3.2.3-2 02:24:36 INFO - Using env: {'DISPLAY': ':0', 02:24:36 INFO - 'HOME': '/home/cltbld', 02:24:36 INFO - 'LANG': 'en_US.UTF-8', 02:24:36 INFO - 'LANGUAGE': 'en_US:en', 02:24:36 INFO - 'LOGNAME': 'cltbld', 02:24:36 INFO - 'MAIL': '/var/mail/cltbld', 02:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:36 INFO - 'MOZ_NO_REMOTE': '1', 02:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:36 INFO - 'NO_EM_RESTART': '1', 02:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:36 INFO - 'PWD': '/builds/slave/test', 02:24:36 INFO - 'SHELL': '/bin/bash', 02:24:36 INFO - 'SHLVL': '1', 02:24:36 INFO - 'TERM': 'linux', 02:24:36 INFO - 'TMOUT': '86400', 02:24:36 INFO - 'USER': 'cltbld', 02:24:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:36 INFO - '_': '/tools/buildbot/bin/python'} 02:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:24:36 INFO - Cleaning up... 02:24:36 INFO - Return code: 0 02:24:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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', '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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:24: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 blobuploader==1.2.4 02:24:36 INFO - Using env: {'DISPLAY': ':0', 02:24:36 INFO - 'HOME': '/home/cltbld', 02:24:36 INFO - 'LANG': 'en_US.UTF-8', 02:24:36 INFO - 'LANGUAGE': 'en_US:en', 02:24:36 INFO - 'LOGNAME': 'cltbld', 02:24:36 INFO - 'MAIL': '/var/mail/cltbld', 02:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:36 INFO - 'MOZ_NO_REMOTE': '1', 02:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:36 INFO - 'NO_EM_RESTART': '1', 02:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:36 INFO - 'PWD': '/builds/slave/test', 02:24:36 INFO - 'SHELL': '/bin/bash', 02:24:36 INFO - 'SHLVL': '1', 02:24:36 INFO - 'TERM': 'linux', 02:24:36 INFO - 'TMOUT': '86400', 02:24:36 INFO - 'USER': 'cltbld', 02:24:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:36 INFO - '_': '/tools/buildbot/bin/python'} 02:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:39 INFO - Downloading docopt-0.6.1.tar.gz 02:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:39 INFO - Running setup.py install for blobuploader 02:24:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:39 INFO - Running setup.py install for requests 02:24:40 INFO - Running setup.py install for docopt 02:24:40 INFO - Successfully installed blobuploader requests docopt 02:24:40 INFO - Cleaning up... 02:24:40 INFO - Return code: 0 02:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:40 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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:40 INFO - Using env: {'DISPLAY': ':0', 02:24:40 INFO - 'HOME': '/home/cltbld', 02:24:40 INFO - 'LANG': 'en_US.UTF-8', 02:24:40 INFO - 'LANGUAGE': 'en_US:en', 02:24:40 INFO - 'LOGNAME': 'cltbld', 02:24:40 INFO - 'MAIL': '/var/mail/cltbld', 02:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:40 INFO - 'MOZ_NO_REMOTE': '1', 02:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:40 INFO - 'NO_EM_RESTART': '1', 02:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:40 INFO - 'PWD': '/builds/slave/test', 02:24:40 INFO - 'SHELL': '/bin/bash', 02:24:40 INFO - 'SHLVL': '1', 02:24:40 INFO - 'TERM': 'linux', 02:24:40 INFO - 'TMOUT': '86400', 02:24:40 INFO - 'USER': 'cltbld', 02:24:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:40 INFO - '_': '/tools/buildbot/bin/python'} 02:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:40 INFO - Running setup.py (path:/tmp/pip-CvLjoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:40 INFO - Running setup.py (path:/tmp/pip-cNzs0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:40 INFO - Running setup.py (path:/tmp/pip-fbbgCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:40 INFO - Running setup.py (path:/tmp/pip-j9ho6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:41 INFO - Running setup.py (path:/tmp/pip-64SKkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:41 INFO - Running setup.py (path:/tmp/pip-8gqrJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:41 INFO - Running setup.py (path:/tmp/pip-3QX6aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:41 INFO - Running setup.py (path:/tmp/pip-w43eyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:41 INFO - Running setup.py (path:/tmp/pip-U110Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:41 INFO - Running setup.py (path:/tmp/pip-YvZFeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:41 INFO - Running setup.py (path:/tmp/pip-p6_5Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:41 INFO - Running setup.py (path:/tmp/pip-4A8Tr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:41 INFO - Running setup.py (path:/tmp/pip-2wRuY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:41 INFO - Running setup.py (path:/tmp/pip-gf7s4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:41 INFO - Running setup.py (path:/tmp/pip-lyvENm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:41 INFO - Running setup.py (path:/tmp/pip-idpSp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:41 INFO - Running setup.py (path:/tmp/pip-wkqzgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:41 INFO - Running setup.py install for manifestparser 02:24:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Running setup.py install for mozcrash 02:24:42 INFO - Running setup.py install for mozdebug 02:24:42 INFO - Running setup.py install for mozdevice 02:24:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Running setup.py install for mozfile 02:24:42 INFO - Running setup.py install for mozhttpd 02:24:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Running setup.py install for mozinfo 02:24:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Running setup.py install for mozInstall 02:24:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:24:42 INFO - Running setup.py install for mozleak 02:24:42 INFO - Running setup.py install for mozlog 02:24:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Running setup.py install for moznetwork 02:24:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Running setup.py install for mozprocess 02:24:43 INFO - Running setup.py install for mozprofile 02:24:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Running setup.py install for mozrunner 02:24:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Running setup.py install for mozscreenshot 02:24:43 INFO - Running setup.py install for moztest 02:24:43 INFO - Running setup.py install for mozversion 02:24:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:43 INFO - Cleaning up... 02:24:43 INFO - Return code: 0 02:24:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:43 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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:43 INFO - Using env: {'DISPLAY': ':0', 02:24:43 INFO - 'HOME': '/home/cltbld', 02:24:43 INFO - 'LANG': 'en_US.UTF-8', 02:24:43 INFO - 'LANGUAGE': 'en_US:en', 02:24:43 INFO - 'LOGNAME': 'cltbld', 02:24:43 INFO - 'MAIL': '/var/mail/cltbld', 02:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:43 INFO - 'MOZ_NO_REMOTE': '1', 02:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:43 INFO - 'NO_EM_RESTART': '1', 02:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:43 INFO - 'PWD': '/builds/slave/test', 02:24:43 INFO - 'SHELL': '/bin/bash', 02:24:43 INFO - 'SHLVL': '1', 02:24:43 INFO - 'TERM': 'linux', 02:24:43 INFO - 'TMOUT': '86400', 02:24:43 INFO - 'USER': 'cltbld', 02:24:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:43 INFO - '_': '/tools/buildbot/bin/python'} 02:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:43 INFO - Running setup.py (path:/tmp/pip-MAvl3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:44 INFO - Running setup.py (path:/tmp/pip-S91VYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:44 INFO - Running setup.py (path:/tmp/pip-sxMPmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:44 INFO - Running setup.py (path:/tmp/pip-XOKoCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:44 INFO - Running setup.py (path:/tmp/pip-6Hoxiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:44 INFO - Running setup.py (path:/tmp/pip-j1539V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:44 INFO - Running setup.py (path:/tmp/pip-AA03wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:44 INFO - Running setup.py (path:/tmp/pip-JAZvc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:44 INFO - Running setup.py (path:/tmp/pip-RLdQV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:44 INFO - Running setup.py (path:/tmp/pip-TmApTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:44 INFO - Running setup.py (path:/tmp/pip-1NlXEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:44 INFO - Running setup.py (path:/tmp/pip-RWBbmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:44 INFO - Running setup.py (path:/tmp/pip-gTCxo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:44 INFO - Running setup.py (path:/tmp/pip-wGYe9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:45 INFO - Running setup.py (path:/tmp/pip-IYGKWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:45 INFO - Running setup.py (path:/tmp/pip-3Y1fWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:45 INFO - Running setup.py (path:/tmp/pip-ii49ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:47 INFO - Downloading blessings-1.6.tar.gz 02:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:47 INFO - Installing collected packages: blessings 02:24:47 INFO - Running setup.py install for blessings 02:24:47 INFO - Successfully installed blessings 02:24:47 INFO - Cleaning up... 02:24:47 INFO - Return code: 0 02:24:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:24:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:47 INFO - Reading from file tmpfile_stdout 02:24:47 INFO - Current package versions: 02:24:47 INFO - argparse == 1.2.1 02:24:47 INFO - blessings == 1.6 02:24:47 INFO - blobuploader == 1.2.4 02:24:47 INFO - docopt == 0.6.1 02:24:47 INFO - functools32 == 3.2.3-2 02:24:47 INFO - jsonschema == 2.5.1 02:24:47 INFO - manifestparser == 1.1 02:24:47 INFO - mozInstall == 1.12 02:24:47 INFO - mozcrash == 1.0 02:24:47 INFO - mozdebug == 0.1 02:24:47 INFO - mozdevice == 0.48 02:24:47 INFO - mozfile == 1.2 02:24:47 INFO - mozhttpd == 0.7 02:24:47 INFO - mozinfo == 0.9 02:24:47 INFO - mozleak == 0.1 02:24:47 INFO - mozlog == 3.4 02:24:47 INFO - moznetwork == 0.27 02:24:47 INFO - mozprocess == 0.23 02:24:47 INFO - mozprofile == 0.28 02:24:47 INFO - mozrunner == 6.13 02:24:47 INFO - mozscreenshot == 0.1 02:24:47 INFO - mozsystemmonitor == 0.3 02:24:47 INFO - moztest == 0.8 02:24:47 INFO - mozversion == 1.4 02:24:47 INFO - psutil == 3.1.1 02:24:47 INFO - requests == 1.2.3 02:24:47 INFO - wsgiref == 0.1.2 02:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:47 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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:47 INFO - Using env: {'DISPLAY': ':0', 02:24:47 INFO - 'HOME': '/home/cltbld', 02:24:47 INFO - 'LANG': 'en_US.UTF-8', 02:24:47 INFO - 'LANGUAGE': 'en_US:en', 02:24:47 INFO - 'LOGNAME': 'cltbld', 02:24:47 INFO - 'MAIL': '/var/mail/cltbld', 02:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:47 INFO - 'MOZ_NO_REMOTE': '1', 02:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:47 INFO - 'NO_EM_RESTART': '1', 02:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:47 INFO - 'PWD': '/builds/slave/test', 02:24:47 INFO - 'SHELL': '/bin/bash', 02:24:47 INFO - 'SHLVL': '1', 02:24:47 INFO - 'TERM': 'linux', 02:24:47 INFO - 'TMOUT': '86400', 02:24:47 INFO - 'USER': 'cltbld', 02:24:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:47 INFO - '_': '/tools/buildbot/bin/python'} 02:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:24:47 INFO - Cleaning up... 02:24:47 INFO - Return code: 0 02:24:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:47 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 0x7f7e91a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, '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': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:24:48 INFO - Using env: {'DISPLAY': ':0', 02:24:48 INFO - 'HOME': '/home/cltbld', 02:24:48 INFO - 'LANG': 'en_US.UTF-8', 02:24:48 INFO - 'LANGUAGE': 'en_US:en', 02:24:48 INFO - 'LOGNAME': 'cltbld', 02:24:48 INFO - 'MAIL': '/var/mail/cltbld', 02:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:48 INFO - 'MOZ_NO_REMOTE': '1', 02:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:48 INFO - 'NO_EM_RESTART': '1', 02:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:48 INFO - 'PWD': '/builds/slave/test', 02:24:48 INFO - 'SHELL': '/bin/bash', 02:24:48 INFO - 'SHLVL': '1', 02:24:48 INFO - 'TERM': 'linux', 02:24:48 INFO - 'TMOUT': '86400', 02:24:48 INFO - 'USER': 'cltbld', 02:24:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:48 INFO - '_': '/tools/buildbot/bin/python'} 02:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:24:48 INFO - Cleaning up... 02:24:48 INFO - Return code: 0 02:24:48 INFO - Running post-action listener: _resource_record_post_action 02:24:48 INFO - Running post-action listener: _start_resource_monitoring 02:24:48 INFO - Starting resource monitoring. 02:24:48 INFO - [mozharness: 2017-01-23 10:24:48.242188Z] Finished create-virtualenv step (success) 02:24:48 INFO - [mozharness: 2017-01-23 10:24:48.242790Z] Running install step. 02:24:48 INFO - Running pre-action listener: _resource_record_pre_action 02:24:48 INFO - Running main action method: install 02:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:48 INFO - Reading from file tmpfile_stdout 02:24:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:24:48 INFO - Reading from file tmpfile_stdout 02:24:48 INFO - Output received: 02:24:48 INFO - Usage: mozinstall [options] installer 02:24:48 INFO - Options: 02:24:48 INFO - -h, --help show this help message and exit 02:24:48 INFO - -d DEST, --destination=DEST 02:24:48 INFO - Directory to install application into. [default: 02:24:48 INFO - "/builds/slave/test"] 02:24:48 INFO - --app=APP Application being installed. [default: firefox] 02:24:48 INFO - mkdir: /builds/slave/test/build/application 02:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:25:04 INFO - Reading from file tmpfile_stdout 02:25:04 INFO - Output received: 02:25:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:25:04 INFO - Running post-action listener: _resource_record_post_action 02:25:04 INFO - [mozharness: 2017-01-23 10:25:04.593839Z] Finished install step (success) 02:25:04 INFO - [mozharness: 2017-01-23 10:25:04.594081Z] Running run-tests step. 02:25:04 INFO - Running pre-action listener: _resource_record_pre_action 02:25:04 INFO - Running main action method: run_tests 02:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:25:04 INFO - Python 2.7.3 02:25:04 INFO - Return code: 0 02:25:04 INFO - grabbing minidump binary from tooltool 02:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:04 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 0x1a38f60>, '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 0x1a39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:25:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:25:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:25:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:25:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:25:04 INFO - Return code: 0 02:25:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:25:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:25:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:25:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:25:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:25:04 INFO - Using env: {'DISPLAY': ':0', 02:25:04 INFO - 'HOME': '/home/cltbld', 02:25:04 INFO - 'LANG': 'en_US.UTF-8', 02:25:04 INFO - 'LANGUAGE': 'en_US:en', 02:25:04 INFO - 'LOGNAME': 'cltbld', 02:25:04 INFO - 'MAIL': '/var/mail/cltbld', 02:25:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:25:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:04 INFO - 'MOZ_NO_REMOTE': '1', 02:25:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:04 INFO - 'NO_EM_RESTART': '1', 02:25:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:04 INFO - 'PWD': '/builds/slave/test', 02:25:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:25:04 INFO - 'SHELL': '/bin/bash', 02:25:04 INFO - 'SHLVL': '1', 02:25:04 INFO - 'TERM': 'linux', 02:25:04 INFO - 'TMOUT': '86400', 02:25:04 INFO - 'USER': 'cltbld', 02:25:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1485167050.63607-915934285', 02:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:04 INFO - '_': '/tools/buildbot/bin/python'} 02:25:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:25:04 INFO - mozversion application_buildid: 20170123004004 02:25:04 INFO - mozversion application_changeset: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 02:25:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:25:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:25:04 INFO - mozversion application_name: Firefox 02:25:04 INFO - mozversion application_remotingname: firefox-dev 02:25:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:25:04 INFO - mozversion application_vendor: Mozilla 02:25:04 INFO - mozversion application_version: 52.0a2 02:25:04 INFO - mozversion platform_buildid: 20170123004004 02:25:04 INFO - mozversion platform_changeset: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 02:25:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:25:04 INFO - mozversion platform_version: 52.0a2 02:25:04 INFO - using testdate: 1485167104 02:25:04 INFO - actual date: 1485167104 02:25:04 INFO - starting webserver on 'localhost:59836' 02:25:04 INFO - SUITE-START | Running 2 tests 02:25:04 INFO - TEST-START | dromaeo_css 02:25:04 INFO - operating with platform_type : linux_ 02:25:04 INFO - Initialising browser for dromaeo_css test... 02:25:04 INFO - TEST-INFO | started process 11626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN1NLD/profile http://localhost:59836/getInfo.html) 02:25:09 INFO - PROCESS | 11626 | __metrics Screen width/height:1600/1200 02:25:09 INFO - PROCESS | 11626 | colorDepth:24 02:25:09 INFO - PROCESS | 11626 | Browser inner width/height: 1024/697 02:25:09 INFO - PROCESS | 11626 | __metrics 02:25:09 INFO - PROCESS | 11626 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:25:09 INFO - PROCESS | 11626 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:10 INFO - PROCESS | 11626 | console.error: PushService: 02:25:10 INFO - PROCESS | 11626 | stateChangeProcessEnqueue: Error transitioning state 02:25:10 INFO - PROCESS | 11626 | UnknownError 02:25:10 INFO - TEST-INFO | 11626: exit 0 02:25:10 INFO - Browser initialized. 02:25:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:25:10 INFO - TEST-INFO | started process 11718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN1NLD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:22 INFO - PROCESS | 11718 | RSS: Main: 143093760 02:25:22 INFO - PROCESS | 11718 | 02:28:24 INFO - PROCESS | 11718 | Cycle 1(1): loaded http://localhost:59836/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59836/tests/dromaeo/cssquery-ext.html) 02:28:25 INFO - PROCESS | 11718 | RSS: Main: 242655232 02:28:25 INFO - PROCESS | 11718 | 02:31:27 INFO - PROCESS | 11718 | Cycle 1(1): loaded http://localhost:59836/tests/dromaeo/cssquery-ext.html (next: http://localhost:59836/tests/dromaeo/cssquery-jquery.html) 02:31:28 INFO - PROCESS | 11718 | RSS: Main: 224800768 02:31:28 INFO - PROCESS | 11718 | 02:34:30 INFO - PROCESS | 11718 | Cycle 1(1): loaded http://localhost:59836/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59836/tests/dromaeo/cssquery-mootools.html) 02:34:30 INFO - PROCESS | 11718 | RSS: Main: 178905088 02:34:30 INFO - PROCESS | 11718 | 02:37:32 INFO - PROCESS | 11718 | Cycle 1(1): loaded http://localhost:59836/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59836/tests/dromaeo/cssquery-prototype.html) 02:37:33 INFO - PROCESS | 11718 | RSS: Main: 191455232 02:37:33 INFO - PROCESS | 11718 | 02:40:36 INFO - PROCESS | 11718 | Cycle 1(1): loaded http://localhost:59836/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59836/tests/dromaeo/cssquery-yui.html) 02:40:36 INFO - PROCESS | 11718 | RSS: Main: 173084672 02:40:36 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | Cycle 1(1): loaded http://localhost:59836/tests/dromaeo/cssquery-yui.html (next: http://localhost:59836/tests/dromaeo/cssquery-dojo.html) 02:43:39 INFO - PROCESS | 11718 | RSS: Main: 257859584 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | __start_tp_report 02:43:39 INFO - PROCESS | 11718 | _x_x_mozilla_page_load 02:43:39 INFO - PROCESS | 11718 | _x_x_mozilla_page_load_details 02:43:39 INFO - PROCESS | 11718 | |i|pagename|runs| 02:43:39 INFO - PROCESS | 11718 | |0;dojo.html;3205.5512228288035;3221.3879362921057;3241.9027429177117;3252.2844974105687;3275.770696051276;5504.366997795255;5588.077967135423;5605.299337582802;5612.494875461208;5632.77468901244;5602.327720673525;5655.26481557397;5662.150677398392;5663.915041274384;5698.487136157745;5056.873578160557;5125.359330083739;5134.974325128369;5155.948440515603;5192.065428222918;5020.849374518771;5024.296598476216;5209.791608335662;5211.557017653504;5214.426413094557;5085.211792172219;5108.64239503235;5118.181091025437;5122.026814905174;5126.794928202868;5153.098207813637;5153.2785410042625;5224.164133738584;5233.895322093536;5243.370795504526;4789.616830653539;5116.104681680691;5144.996725638502;5188.740562971874;5200.791968321262;5332.200169974496;5428.891422171574;5476.452354764531;5483.533899618497;5490.890182196334;5833.416658334175;5920.644761314335;5944.375840536768;5945.435183657545;5952.136940143699;5829.009068458372;5986.221791167164;5993.190919225893;5998.520118390518;6021.307549631804;5502.2296878437455;5506.449355064502;5518.696471694096;5527.751251193706;5553.944460555424;6071.605345652519;6072.210612620331;6085.1785009023215;6137.232845894263;6156.938430615726;5669.489745922887;5910.940890591039;5915.911261331084;5927.31835838884;5928.140419639214;5759.164921086419;5936.762529498858;5985.790497332572;5992;6026.216591843032;5955.642661440327;5958;5959.106134079922;5969.432903874125;5986.102084687244;5893.174955506232;5952.255968003999;5959.582829201914;5960.6721630309885;5982.790602328898;4471.8658440246845;4500.437445319335;4513.232750432434;4545.250033744395;4617.953820461752;4124.154548317588;4134.37984302351;4155.91688166235;4163.562825903297;4163.937540936889;5652.3217213934595;5654.943450565442;5656.123300888369;5656.8020119295625;5658.179563963202;5848.883022339614;5893.941060589425;5919.467247947619;6035.155078289043;6037.1246169305205;5551.611387202857;5617.269754931915;5618.887622247532;5638.746256418471;5647.943520564741;5136.614753893473;5183.45573714762;5196.402413722395;5203.505666961632;5239.73801309933;5969.76120955157;6028.487578555872;6138.1713468681155;6175.475084617858;6200.131981522591;5896.145058966512;5986.07215881539;5994.220751302303;6086.847828804315;6141.692915354304;6155.599886007395;6157.576483266522;6183.474404675653;6191.504679625529;6204.81385558434;5692.800751973827;5964.045752679551;5965.492933100735;5967.880642387215;6001.609895356788;5774.509166720708;5927.229460170151;6038.275406951018;6041.426064523863;6141.570090093651;5918.911216331845;5967.9701601491715;5972.671503067373;5977.252843394575;5988.940110599013;5894.882102357843;5905.734241959208;5906.379830117776;5909.734061967308;5958.1658567801405;5603.663780173202;5729.770809167587;5738.454846789548;5744.396838331915;5764.769409223752;5922.170896074467;5927.673977931255;5931.258592675916;5932.940670593239;5946.108083787466;5518.558515318685;5573.331200255995;5766.509846662912;5776.075827867521;5778.653280803165 02:43:39 INFO - PROCESS | 11718 | |1;ext.html;578.5429510686558;616.5899676714985;641.3682522715125;641.9390157934997;674.1101745695678;36461.635383646186;44438;45656.771716141455;45686;48486.51513484864;45776.313355299695;46262.306065408964;46267.30599041009;46292.3056154158;46324.76837615807;8340.499570025819;8810.20708136266;8962;8970;8971.474849275639;8507.744767656981;10428.322159059675;10708.892911070907;10710;10983.61557345493;10821.350718956848;10821.783564328709;10893;10909.07272881802;10910.61812836551;10639;10689.091427228695;10728.678139655784;10730.731731706692;10733.731656708645;10456.268061235716;10537.525811338432;10588.470576471223;10603.416812075333;10646.733831654194;43357;43743.125137497074;43823.56176438227;43867.78066109649;44026.33960490595;3640.9453858192146;3677.7425580209397;3750.774953502799;3934.980325098385;4146.357314616239;33480.665193347995;33509;33778.49332260018;33907;34632.30735385304;4307.806148723315;4319.157764235975;4337.501187363462;4366.956330436687;4402.8679139625865;321724;322155;323047;324128;324323;39124;63076.05385919215;63324.68337658282;63526.68236658787;63532.68233658802;39520.604793951694;41478.37782433266;41490;41518.37722434106;41541.79229103835;16940.661186776197;17072.48782536526;17077.316907323817;17078.146092695315;17100.0594967278;12918.160319579198;13194.802077968838;14116;14624.19566923808;14806.555803325917;9353.204977576983;9427.434353938786;9451.905480945241;9479.336446448682;9554.474503902213;3644.7448678592773;3655.4151335786146;3658.6158453362546;3708.128589781399;3732;1003.9297249192487;1009.0867764672836;1038.3873514626407;1046.0742243114746;1131.4738646529404;32306.676933230836;34225.48661770076;34353.76700514458;34933;36563.817180914455;1124.9381284029457;1133.7562424078862;1150.108665784024;1151.4588143572507;1189.5241903238773;17421.65156696859;17642.735358969625;17673.11634418274;17707;17773.20020599076;497575;498453;502170;502315;503142;61240.38759612436;61586;61842.38157618456;61889.690551546955;61995;1349.7772867476954;1408.3803126624252;1414.7453458377386;1458.2344269258513;1491.5450787509697;31710.36579268448;35463.69485983506;35956.28087438289;36441.81779091088;36831.81584092062;58925.70537147287;59852.10221846589;63404;63480.365196349296;63614.36385636085;447593;451416;452780;452845;454689;42536.361954570086;42710.359344609235;43593;48261;49592.504074960234;50106;51801.48198518117;51947.48052519577;52086.47913520816;55407.722961384934;42450.36324455074;42753;44217.107132707795;45231.54768452405;47122.76438617785;44158.55841441544;45387;46789.76605116953;46893;47094.52905470901;40921.59078409297;41032;41060;41162.79418602888;43520;38744.64393746205;41171.58828411797;41489.37765933574;42602;43008;29929;29958.08383233533;30251.546226807055;30393.24016899595;30960 02:43:39 INFO - PROCESS | 11718 | |2;jquery.html;400.4933758795123;401.3618346828542;423.6568379612514;435.5144014423917;441.63123791633984;18680.532986675324;19716.01419929003;20318.08568614412;20435.693464598044;20772.06525706343;20094.296699615516;20108.899455502702;20287;20290.59418811623;20353.796462035374;5690.5447564194765;5983.222181116449;5983.790567330145;5990.790322338719;6002.579819412643;5640.576956728261;5779.479846813786;5801;5816.563757718167;5898.7640494380175;5713.514351280146;5716.3426205986425;5719.59962802604;5768.163616275659;5772.826815195551;5545.584081193906;5687.6303040302455;5712.971435142839;5725.312962444513;5755.223044888929;5243.187305967581;5283.920741188886;5284.101702710548;5292.338457692788;5292.947070529284;22200.333989980325;23622.881885590636;23672;23734.76265237343;23800.166994155294;2390.557746816827;2414.9879250603635;2437.7805997460314;2530.7975361971;2578.1878708206855;14354.49759258421;14571.417143314255;14894;15022.624434389118;15207.771883421647;1885.981140188608;1932.8550358723153;2002.2091273946855;2034.0236686390467;2061.711360409544;79727;80819.9385046124;82557.58721206416;93841.5307923456;94927.52536237275;11353.318800871974;11630.53477860893;11818.409079545989;12173.573924912762;12190.756184876253;17566.91216543909;17574.945503269846;17584.648307034044;17595.296188152588;17600.735988960176;8893.4663920165;9062.954685226663;9115.407498512575;9185.95407022974;9254.768630784285;8642.178992995656;8698;8778.517181555077;8895.599698013604;8943.552822358855;5188.844334669966;5193.091209038404;5198.402183748917;5230.476952304815;5368.221607866837;2023.6863286190664;2039.5003224210163;2083.239617539587;2104;2110.9366718998454;948.7248697877538;1008.1128606825946;1061.4586560853866;1089.4824958144818;1095.4265939701713;18704.625907481775;20640.174393024412;20688.793112068986;20953.371398857755;20956.161753529686;1008.7931973945324;1029.7888932768765;1064.1965316186229;1064.707205518473;1087.6736978906297;10704.839427408595;11370;11413.801550837208;11513.712157196138;11585.82621260665;426121.08576199686;428136;444524;447264;449492;92802;93431;95182.52408737912;96247.51876240714;98120;1056.915446764257;1072.683558350273;1087.1628845788698;1118.3848883114417;1123.741539445932;17700.734488982416;17841.910790445963;18467.630647387246;18562.628747424707;18614.34849780251;40285.798571006955;40783.388249175696;41198.58801412067;42081.78959105185;42418.78790606027;57502.7124864373;58087.70956145192;59028;59845.70077149587;60321.69839150776;8556.957215213884;8636.740897773077;8738.563071846509;8752.518611476175;8757.343199259954;12545.560905368267;13059.281739504419;13200.14199077057;13388.732225355634;14144.292785360896;11163.330200188015;11447.25592836463;11711.1802173847;11864.466099025738;12060.75878482443;11803.763924721628;11815.40922953866;11905.40472976365;11926.701832454259;11935.343556104497;10781.84363127362;11138.944305278746;11562.248453850472;11601.593944211912;11741;8366.330693544624;8531;8752.78118047054;8873.556322183995;8905.73282801517;10952.780944381228;11124;11440.771184576428;11629.941850290694;11999.76000480003 02:43:39 INFO - PROCESS | 11718 | |3;mootools.html;1337.7123918357552;1473.8231412230534;1486.6432056306485;1630.2582325042108;1777.5467255849765;7435.442341824364;8168.91831081689;8467;8493.872591911118;8707.695230666928;8479.703210387623;8481.78795530112;8502.95748521258;8616.698415555442;8637;2401.867897265654;2420.7337192908767;2427.2232885476656;2431.258466167818;2434.866082365469;2388.140269502986;2408.12103582193;2436.549238390903;2445.1930862815316;2445.755424457549;2395.7244916834525;2400.375902265415;2420.7942324902315;2425.5391475619663;2426.8301218914685;2339.94150146246;2343.8476499027593;2373.7863592276776;2374.347054560001;2376.4058985253687;2251.268337790225;2278.624027035537;2286.8513546619583;2314.6065168921323;2319.5824751544715;8291.626876790559;8380.413371064027;8439.156084391572;8550.828983420297;8564.914350856474;4979.925301120486;5178.559822415099;5194.37667479901;5200.947990520084;5201.375834899836;3394.62659107498;3503.579570451562;3567.571891373026;3577.928441431183;3589.838457269429;1099.8350247462865;1104.1884215101893;1107.457345900503;1157.317182862107;1164.5050853387277;11764.705882352924;11876.940615296955;11898.821517677241;11916.582919597859;11923.463444144947;4133.318002529609;4395.494518130392;4452.0873220989615;4482.238019536687;4486.080353527519;9475.47884866339;9491.240700743923;9497.715068547956;9504.097110774464;9516.19112375442;5156.175011998137;5166.483351664803;5167.457416971239;5167.715775632301;5168.095583272988;4097.97951010243;4295.140971805651;4464.0402313502755;4483.977580112144;4857.319975203474;3704.592494825567;3742.3346610757953;3823.808809559511;3858.9807050964564;3864.072622570563;1174.4514403743897;1210.5702475621028;1213.5813144465146;1214.9331786751814;1222.3826967381415;952.7237101240563;959.6209497248688;964.7732782796037;965.6620182936057;986.6102889358663;5678;5689.175069614883;5771.653700777967;5804.1293805929445;5939.13882487037;468.1760102220117;476.56156336170807;481.4872161148366;489.3076297039649;498.30486471372234;3824.521934758155;4007.519097708294;4015.7590544566833;4032.475778148822;4032.91934161321;10097.293189476666;10435.634752783617;10530.15758739299;10533.631322903662;10561.102306303897;10387.636432724817;10475.580976760997;10479.94760026195;10507.632232871965;10526.263161578616;7981.04227492693;8055.113937466874;8060.798480037929;8066.314363279187;8081.878771818545;5618.550515958796;5685.033544297562;5690.9430905690415;5713.971430142823;5717.142428635571;9425.104615061558;9468.526573671152;9532.142107210384;9559.61761529531;9592.808143836945;8350.791230219293;8526.531040792815;9539.33224674266;9706.6117355305;9799.706008819747;7291.52605080668;7458.403327733877;7463.962680186564;7584.127825300161;7619.771406857803;7984.640691169027;8213;8299.751007469786;8456;8458.915410845813;7329.853402932018;7348.52234604749;7351.485396022441;7469.962650186714;7475.775726728207;7182.3535881770895;7198.49610527258;7249.891251631335;7281.5631062136445;7373.262673732584;6600.669966501751;6707.798766037026;6782.321767823179;6899.241083480712;6909.2745261748805;4707.599854012447;4833.10587541306;4837;4866.270059490963;4921.606271498343;4813.133635945564;4873.025394920959;4920.852374428773;4923.876903077452;4955.40535135786 02:43:39 INFO - PROCESS | 11718 | |4;prototype.html;325.2000079803681;333.72801167048857;334.6252197538757;336.6128951705539;338.2085918949657;5277.313949186605;5345.1982202669615;5355.6786592804365;5391.973040134803;5398.325209348832;5015.899682006358;5091.618128640348;5144.382674079106;5207.505286997739;5293.655912365693;4152.896177595554;4153.501579810427;4157.731891773008;4179.456670632813;4187.979060104695;4141.295979683461;4169.62473377396;4182.958170418303;4185.246655601991;4204.747715137086;3920.7451515651533;4006.519217693881;4012.8595499157536;4146.8133933972895;4151.481064866892;4126.5667104954;4128.793560321972;4131.462909821734;4145.9999999999845;4150.543440221573;3697.85208591656;3705.4256590228556;3721.106934335767;3736.626337366242;3754.1177823211524;5078.949210507884;5108.259302401131;5109.671485413819;5234.141879632752;5246.950609878039;4722.83570008092;4727.290906364038;4732.337472753818;4742.644301677354;4757.714537127748;5472.562195024429;5496.725163741837;5508.807191748269;5512.724363781795;5546.722663866791;3940.4483372327895;4055.8174882130374;4105.958940410587;4120.320147175742;4124.123124547537;5698.7435565399655;5700.25896633435;5707.77168913243;5715.1713001614535;5728.742206600713;4222.3244280914905;4222.4933008038615;4224.54253282617;4227.619514243671;4231.449911511484;3871.9806400968378;4024.5774193709826;4265.936010959838;4278.807453664593;4287.164003019381;4665.183592871234;4676;4678.228092364721;4688.390509233778;4691.601213896789;5540.9168862467095;5552.696145793247;5560.249366335493;5571.860703482445;5572.353132262143;1317.2952470428274;1344.7041650836995;1359.945602175902;1362.8364596248514;1367.5828872193877;936.4007035497287;960.2941837749248;963.3545524498462;964.3538828984457;981.3768257156614;5172.594743444316;5185.585153187736;5216.070054080014;5220.112580861262;5235.607329450307;5257.816991177031;5441.428649991773;5450.5367043801725;5473.397926228112;5484.204790305464;5133.486651334912;5138.505816045051;5147.422541333812;5156.375741641371;5160.355679888131;2822.943541129207;2884.793133253063;2896.5365541513256;2902.216401571606;2903.301568582403;5438.347398312228;5490.890182196334;5536.2249285100115;5561.4716601922755;5575.665460072409;5554.638948468418;5572.832815015556;5591.245181900473;5594.636348637326;5614;5303.520097078712;5481.287432633732;5539.279893613804;5548.639338442988;5584.190292407578;5406.540444062299;5432.239486471976;5437.504686211323;5444.537214336826;5451.591130665137;5354.411014788292;5423.186522021729;5426;5435.456454354533;5439.673619582838;5486.862828429162;5789.45000224978;5801.897639448492;5822.272215973004;5828.562857785599;4045.5145382554283;4054.8580799671868;4057.4928133983253;4070.6946978976102;4076.449679293376;5490.972545137409;5591.748371323219;5600.663960162403;5706.372299047184;5812;5561.555075593862;5610.691411972381;5616.1856530803625;5619.438056194348;5623.409541998195;5320.893582128413;5589.90996755645;5590.608657393944;5592.161175823497;5628.887422251614;5513.200585914939;5568.443155684561;5574.303212098488;5586.944130558805;5603;5620.494155525858;5639.689817060101;5641.182028605911;5656.745446454837;5656.830295091154;5247.842564723064;5435.945640543544;5456.754446050017;5485.1624705724025;5509.641873278224 02:43:39 INFO - PROCESS | 11718 | |5;yui.html;709.7941596936887;721.3940290156268;774.7791879314393;829.2702421868754;867.293156077797;12505.874941250597;12738.93630531846;12895.871041289596;13142.14576052556;13267.999999999987;13624.18254904704;13713.451461941535;13722;13735.519256826014;13756.31218439079;723.1683563901503;745.7986343687228;852.7271273192581;870.4255191573546;873.4191762477944;860.6428332242112;864.7362554420899;865.9565223905211;866.1295398124876;867.089555966236;919.7562645898843;921.8340698674236;922.5479515037616;922.7508572685371;923.372106967262;757.1141764135974;779.6413649721106;883.5979629268668;911.2118017914522;919.3472634429563;674.0832467843728;674.3728332650633;674.5244602555186;674.9730010799562;675.1627981303197;14866.033707809065;15236.390544378211;15305.387784488606;15327.923360383238;15330.770038449433;12702.491900323976;12943.482260709561;12953.417096230693;13046.804297935538;13155.210687358693;12549.435275412628;12587;12839.550615728405;12959.352032398436;13092.86907130926;4438.800253988546;4440.156370289635;4462.352958820985;4473.530279320689;4478.081993191388;60315;60391.09413358847;60802.695986519786;60880;61376;10456.68629941103;10730.409827459565;10811.567537298577;10926.945365273123;11000.779984400267;19761.209551617776;19763.60472790536;19914.103865326095;19965;20470;8178.46839955401;8241.25828675422;8293.419460637697;8387.83224335522;8480.406371553932;4760.880977975578;4761.095391875602;4763.809447622057;4814.301926220678;4960.355153830051;3262.8531716072835;3351.6648335166287;3356.8825091121694;3364.158960259935;3373.3421982713626;594.9643021418728;596.7225240263299;598.6886818854172;609.6616377910302;614.7233744814852;582.9708514574254;618.6690120785448;680;705.4532737128766;717.9712811487586;8482.575871206414;8683.56582170889;9079.50062746542;9202.125798049176;9385.15533601979;620.4725982914487;678.7081554931427;686.5606012152226;699.9825004374829;712.8609921065446;4230.90320975367;4343.218220720238;4394.406755088086;4397.494288156839;4420.690551661417;88586.55706721425;88794;89138.55430722804;90381.54809226043;92950.07049929415;77466.61266693744;78546;78880;81664.59167704123;81821;70127;71168.64415677992;71206.64396678087;71330;72473.6376318115;8340.791480213044;8556.957215213884;8639.5609877775;8721.694740684046;8930;50643.49356506388;51060.21289254858;51277;51536.484635154666;52405.21392179197;61701;67782.66108669425;67818.66090669515;67858;68718.28204294933;10648.8935110651;10678.092362148993;10818.350898946088;10852.945735271272;11097.445127743742;11391.658250252505;11497.08023358146;11911.642650720492;12149.635510934686;12922.676933076747;10799.168299889747;10906.50920708554;11040.944795275973;11134.665960021212;11532.711682208012;11922.165448418527;11974.161808673309;12199.268043917393;12233.938830305791;12320.383980800745;11201.887981120084;11359.48882300282;11407;11463.942680286546;11842.46708898119;8178.223068808454;8617.69838055665;8648.221660050625;8765.868511972198;8822.5588720565;8547.101953225834;8583.570821458778;8694.82610347802;8695.131624238584;8980.46117232968 02:43:39 INFO - PROCESS | 11718 | __end_tp_report 02:43:39 INFO - PROCESS | 11718 | __start_cc_report 02:43:39 INFO - PROCESS | 11718 | _x_x_mozilla_cycle_collect,985 02:43:39 INFO - PROCESS | 11718 | __end_cc_report 02:43:39 INFO - PROCESS | 11718 | __startTimestamp1485168219280__endTimestamp 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | ------- Summary: start ------- 02:43:39 INFO - PROCESS | 11718 | Number of tests: 6 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | [#0] dojo.html Cycles:165 Average:5555.71 Median:5744.40 stddev:620.58 (10.8%) stddev-sans-first:594.46 02:43:39 INFO - PROCESS | 11718 | Values: 3205.6 3221.4 3241.9 3252.3 3275.8 5504.4 5588.1 5605.3 5612.5 5632.8 5602.3 5655.3 5662.2 5663.9 5698.5 5056.9 5125.4 5135.0 5155.9 5192.1 5020.8 5024.3 5209.8 5211.6 5214.4 5085.2 5108.6 5118.2 5122.0 5126.8 5153.1 5153.3 5224.2 5233.9 5243.4 4789.6 5116.1 5145.0 5188.7 5200.8 5332.2 5428.9 5476.5 5483.5 5490.9 5833.4 5920.6 5944.4 5945.4 5952.1 5829.0 5986.2 5993.2 5998.5 6021.3 5502.2 5506.4 5518.7 5527.8 5553.9 6071.6 6072.2 6085.2 6137.2 6156.9 5669.5 5910.9 5915.9 5927.3 5928.1 5759.2 5936.8 5985.8 5992.0 6026.2 5955.6 5958.0 5959.1 5969.4 5986.1 5893.2 5952.3 5959.6 5960.7 5982.8 4471.9 4500.4 4513.2 4545.3 4618.0 4124.2 4134.4 4155.9 4163.6 4163.9 5652.3 5654.9 5656.1 5656.8 5658.2 5848.9 5893.9 5919.5 6035.2 6037.1 5551.6 5617.3 5618.9 5638.7 5647.9 5136.6 5183.5 5196.4 5203.5 5239.7 5969.8 6028.5 6138.2 6175.5 6200.1 5896.1 5986.1 5994.2 6086.8 6141.7 6155.6 6157.6 6183.5 6191.5 6204.8 5692.8 5964.0 5965.5 5967.9 6001.6 5774.5 5927.2 6038.3 6041.4 6141.6 5918.9 5968.0 5972.7 5977.3 5988.9 5894.9 5905.7 5906.4 5909.7 5958.2 5603.7 5729.8 5738.5 5744.4 5764.8 5922.2 5927.7 5931.3 5932.9 5946.1 5518.6 5573.3 5766.5 5776.1 5778.7 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | [#1] ext.html Cycles:180 Average:60090.44 Median:41167.19 stddev:114149.63 (277.3%) stddev-sans-first:114382.40 02:43:39 INFO - PROCESS | 11718 | Values: 578.5 616.6 641.4 641.9 674.1 36461.6 44438.0 45656.8 45686.0 48486.5 45776.3 46262.3 46267.3 46292.3 46324.8 8340.5 8810.2 8962.0 8970.0 8971.5 8507.7 10428.3 10708.9 10710.0 10983.6 10821.4 10821.8 10893.0 10909.1 10910.6 10639.0 10689.1 10728.7 10730.7 10733.7 10456.3 10537.5 10588.5 10603.4 10646.7 43357.0 43743.1 43823.6 43867.8 44026.3 3640.9 3677.7 3750.8 3935.0 4146.4 33480.7 33509.0 33778.5 33907.0 34632.3 4307.8 4319.2 4337.5 4367.0 4402.9 321724.0 322155.0 323047.0 324128.0 324323.0 39124.0 63076.1 63324.7 63526.7 63532.7 39520.6 41478.4 41490.0 41518.4 41541.8 16940.7 17072.5 17077.3 17078.1 17100.1 12918.2 13194.8 14116.0 14624.2 14806.6 9353.2 9427.4 9451.9 9479.3 9554.5 3644.7 3655.4 3658.6 3708.1 3732.0 1003.9 1009.1 1038.4 1046.1 1131.5 32306.7 34225.5 34353.8 34933.0 36563.8 1124.9 1133.8 1150.1 1151.5 1189.5 17421.7 17642.7 17673.1 17707.0 17773.2 497575.0 498453.0 502170.0 502315.0 503142.0 61240.4 61586.0 61842.4 61889.7 61995.0 1349.8 1408.4 1414.7 1458.2 1491.5 31710.4 35463.7 35956.3 36441.8 36831.8 58925.7 59852.1 63404.0 63480.4 63614.4 447593.0 451416.0 452780.0 452845.0 454689.0 42536.4 42710.4 43593.0 48261.0 49592.5 50106.0 51801.5 51947.5 52086.5 55407.7 42450.4 42753.0 44217.1 45231.5 47122.8 44158.6 45387.0 46789.8 46893.0 47094.5 40921.6 41032.0 41060.0 41162.8 43520.0 38744.6 41171.6 41489.4 42602.0 43008.0 29929.0 29958.1 30251.5 30393.2 30960.0 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | [#2] jquery.html Cycles:180 Average:28260.61 Median:23647.44 stddev:72860.08 (308.1%) stddev-sans-first:73034.44 02:43:39 INFO - PROCESS | 11718 | Values: 400.5 401.4 423.7 435.5 441.6 18680.5 19716.0 20318.1 20435.7 20772.1 20094.3 20108.9 20287.0 20290.6 20353.8 5690.5 5983.2 5983.8 5990.8 6002.6 5640.6 5779.5 5801.0 5816.6 5898.8 5713.5 5716.3 5719.6 5768.2 5772.8 5545.6 5687.6 5713.0 5725.3 5755.2 5243.2 5283.9 5284.1 5292.3 5292.9 22200.3 23622.9 23672.0 23734.8 23800.2 2390.6 2415.0 2437.8 2530.8 2578.2 14354.5 14571.4 14894.0 15022.6 15207.8 1886.0 1932.9 2002.2 2034.0 2061.7 79727.0 80819.9 82557.6 93841.5 94927.5 11353.3 11630.5 11818.4 12173.6 12190.8 17566.9 17574.9 17584.6 17595.3 17600.7 8893.5 9063.0 9115.4 9186.0 9254.8 8642.2 8698.0 8778.5 8895.6 8943.6 5188.8 5193.1 5198.4 5230.5 5368.2 2023.7 2039.5 2083.2 2104.0 2110.9 948.7 1008.1 1061.5 1089.5 1095.4 18704.6 20640.2 20688.8 20953.4 20956.2 1008.8 1029.8 1064.2 1064.7 1087.7 10704.8 11370.0 11413.8 11513.7 11585.8 426121.1 428136.0 444524.0 447264.0 449492.0 92802.0 93431.0 95182.5 96247.5 98120.0 1056.9 1072.7 1087.2 1118.4 1123.7 17700.7 17841.9 18467.6 18562.6 18614.3 40285.8 40783.4 41198.6 42081.8 42418.8 57502.7 58087.7 59028.0 59845.7 60321.7 8557.0 8636.7 8738.6 8752.5 8757.3 12545.6 13059.3 13200.1 13388.7 14144.3 11163.3 11447.3 11711.2 11864.5 12060.8 11803.8 11815.4 11905.4 11926.7 11935.3 10781.8 11138.9 11562.2 11601.6 11741.0 8366.3 8531.0 8752.8 8873.6 8905.7 10952.8 11124.0 11440.8 11629.9 11999.8 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | [#3] mootools.html Cycles:180 Average:5565.39 Median:4921.23 stddev:3119.03 (63.4%) stddev-sans-first:3111.60 02:43:39 INFO - PROCESS | 11718 | Values: 1337.7 1473.8 1486.6 1630.3 1777.5 7435.4 8168.9 8467.0 8493.9 8707.7 8479.7 8481.8 8503.0 8616.7 8637.0 2401.9 2420.7 2427.2 2431.3 2434.9 2388.1 2408.1 2436.5 2445.2 2445.8 2395.7 2400.4 2420.8 2425.5 2426.8 2339.9 2343.8 2373.8 2374.3 2376.4 2251.3 2278.6 2286.9 2314.6 2319.6 8291.6 8380.4 8439.2 8550.8 8564.9 4979.9 5178.6 5194.4 5200.9 5201.4 3394.6 3503.6 3567.6 3577.9 3589.8 1099.8 1104.2 1107.5 1157.3 1164.5 11764.7 11876.9 11898.8 11916.6 11923.5 4133.3 4395.5 4452.1 4482.2 4486.1 9475.5 9491.2 9497.7 9504.1 9516.2 5156.2 5166.5 5167.5 5167.7 5168.1 4098.0 4295.1 4464.0 4484.0 4857.3 3704.6 3742.3 3823.8 3859.0 3864.1 1174.5 1210.6 1213.6 1214.9 1222.4 952.7 959.6 964.8 965.7 986.6 5678.0 5689.2 5771.7 5804.1 5939.1 468.2 476.6 481.5 489.3 498.3 3824.5 4007.5 4015.8 4032.5 4032.9 10097.3 10435.6 10530.2 10533.6 10561.1 10387.6 10475.6 10479.9 10507.6 10526.3 7981.0 8055.1 8060.8 8066.3 8081.9 5618.6 5685.0 5690.9 5714.0 5717.1 9425.1 9468.5 9532.1 9559.6 9592.8 8350.8 8526.5 9539.3 9706.6 9799.7 7291.5 7458.4 7464.0 7584.1 7619.8 7984.6 8213.0 8299.8 8456.0 8458.9 7329.9 7348.5 7351.5 7470.0 7475.8 7182.4 7198.5 7249.9 7281.6 7373.3 6600.7 6707.8 6782.3 6899.2 6909.3 4707.6 4833.1 4837.0 4866.3 4921.6 4813.1 4873.0 4920.9 4923.9 4955.4 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | [#4] prototype.html Cycles:180 Average:4625.88 Median:5267.57 stddev:1338.60 (25.4%) stddev-sans-first:1302.85 02:43:39 INFO - PROCESS | 11718 | Values: 325.2 333.7 334.6 336.6 338.2 5277.3 5345.2 5355.7 5392.0 5398.3 5015.9 5091.6 5144.4 5207.5 5293.7 4152.9 4153.5 4157.7 4179.5 4188.0 4141.3 4169.6 4183.0 4185.2 4204.7 3920.7 4006.5 4012.9 4146.8 4151.5 4126.6 4128.8 4131.5 4146.0 4150.5 3697.9 3705.4 3721.1 3736.6 3754.1 5078.9 5108.3 5109.7 5234.1 5247.0 4722.8 4727.3 4732.3 4742.6 4757.7 5472.6 5496.7 5508.8 5512.7 5546.7 3940.4 4055.8 4106.0 4120.3 4124.1 5698.7 5700.3 5707.8 5715.2 5728.7 4222.3 4222.5 4224.5 4227.6 4231.4 3872.0 4024.6 4265.9 4278.8 4287.2 4665.2 4676.0 4678.2 4688.4 4691.6 5540.9 5552.7 5560.2 5571.9 5572.4 1317.3 1344.7 1359.9 1362.8 1367.6 936.4 960.3 963.4 964.4 981.4 5172.6 5185.6 5216.1 5220.1 5235.6 5257.8 5441.4 5450.5 5473.4 5484.2 5133.5 5138.5 5147.4 5156.4 5160.4 2822.9 2884.8 2896.5 2902.2 2903.3 5438.3 5490.9 5536.2 5561.5 5575.7 5554.6 5572.8 5591.2 5594.6 5614.0 5303.5 5481.3 5539.3 5548.6 5584.2 5406.5 5432.2 5437.5 5444.5 5451.6 5354.4 5423.2 5426.0 5435.5 5439.7 5486.9 5789.5 5801.9 5822.3 5828.6 4045.5 4054.9 4057.5 4070.7 4076.4 5491.0 5591.7 5600.7 5706.4 5812.0 5561.6 5610.7 5616.2 5619.4 5623.4 5320.9 5589.9 5590.6 5592.2 5628.9 5513.2 5568.4 5574.3 5586.9 5603.0 5620.5 5639.7 5641.2 5656.7 5656.8 5247.8 5435.9 5456.8 5485.2 5509.6 02:43:39 INFO - PROCESS | 11718 | 02:43:39 INFO - PROCESS | 11718 | [#5] yui.html Cycles:180 Average:17852.43 Median:60596.90 stddev:24448.92 (40.3%) stddev-sans-first:24483.62 02:43:39 INFO - PROCESS | 11718 | Values: 709.8 721.4 774.8 829.3 867.3 12505.9 12738.9 12895.9 13142.1 13268.0 13624.2 13713.5 13722.0 13735.5 13756.3 723.2 745.8 852.7 870.4 873.4 860.6 864.7 866.0 866.1 867.1 919.8 921.8 922.5 922.8 923.4 757.1 779.6 883.6 911.2 919.3 674.1 674.4 674.5 675.0 675.2 14866.0 15236.4 15305.4 15327.9 15330.8 12702.5 12943.5 12953.4 13046.8 13155.2 12549.4 12587.0 12839.6 12959.4 13092.9 4438.8 4440.2 4462.4 4473.5 4478.1 60315.0 60391.1 60802.7 60880.0 61376.0 10456.7 10730.4 10811.6 10926.9 11000.8 19761.2 19763.6 19914.1 19965.0 20470.0 8178.5 8241.3 8293.4 8387.8 8480.4 4760.9 4761.1 4763.8 4814.3 4960.4 3262.9 3351.7 3356.9 3364.2 3373.3 595.0 596.7 598.7 609.7 614.7 583.0 618.7 680.0 705.5 718.0 8482.6 8683.6 9079.5 9202.1 9385.2 620.5 678.7 686.6 700.0 712.9 4230.9 4343.2 4394.4 4397.5 4420.7 88586.6 88794.0 89138.6 90381.5 92950.1 77466.6 78546.0 78880.0 81664.6 81821.0 70127.0 71168.6 71206.6 71330.0 72473.6 8340.8 8557.0 8639.6 8721.7 8930.0 50643.5 51060.2 51277.0 51536.5 52405.2 61701.0 67782.7 67818.7 67858.0 68718.3 10648.9 10678.1 10818.4 10852.9 11097.4 11391.7 11497.1 11911.6 12149.6 12922.7 10799.2 10906.5 11040.9 11134.7 11532.7 11922.2 11974.2 12199.3 12233.9 12320.4 11201.9 11359.5 11407.0 11463.9 11842.5 8178.2 8617.7 8648.2 8765.9 8822.6 8547.1 8583.6 8694.8 8695.1 8980.5 02:43:39 INFO - PROCESS | 11718 | -------- Summary: end -------- 02:43:39 INFO - PROCESS | 11718 | 02:43:40 INFO - TEST-INFO | 11718: exit 0 02:43:40 INFO - TEST-OK | dromaeo_css | took 1115189ms 02:43:40 INFO - TEST-START | kraken 02:43:40 INFO - operating with platform_type : linux_ 02:43:40 INFO - Initialising browser for kraken test... 02:43:40 INFO - TEST-INFO | started process 12034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeqqTZ/profile http://localhost:59836/getInfo.html) 02:43:44 INFO - PROCESS | 12034 | __metrics Screen width/height:1600/1200 02:43:44 INFO - PROCESS | 12034 | colorDepth:24 02:43:44 INFO - PROCESS | 12034 | Browser inner width/height: 1024/697 02:43:44 INFO - PROCESS | 12034 | __metrics 02:43:44 INFO - PROCESS | 12034 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:43:44 INFO - PROCESS | 12034 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:45 INFO - PROCESS | 12034 | console.error: PushService: 02:43:45 INFO - PROCESS | 12034 | stateChangeProcessEnqueue: Error transitioning state 02:43:45 INFO - PROCESS | 12034 | UnknownError 02:43:45 INFO - TEST-INFO | 12034: exit 0 02:43:45 INFO - Browser initialized. 02:43:45 INFO - Running cycle 1/1 for kraken test... 02:43:45 INFO - TEST-INFO | started process 12128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeqqTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:57 INFO - PROCESS | 12128 | RSS: Main: 143560704 02:43:57 INFO - PROCESS | 12128 | 02:44:00 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59836/tests/kraken/driver.html?testName=audio-beat-detection) 02:44:01 INFO - PROCESS | 12128 | RSS: Main: 185171968 02:44:01 INFO - PROCESS | 12128 | 02:44:03 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59836/tests/kraken/driver.html?testName=audio-dft) 02:44:04 INFO - PROCESS | 12128 | RSS: Main: 175443968 02:44:04 INFO - PROCESS | 12128 | 02:44:07 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59836/tests/kraken/driver.html?testName=audio-fft) 02:44:07 INFO - PROCESS | 12128 | RSS: Main: 266690560 02:44:07 INFO - PROCESS | 12128 | 02:44:09 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59836/tests/kraken/driver.html?testName=audio-oscillator) 02:44:10 INFO - PROCESS | 12128 | RSS: Main: 173047808 02:44:10 INFO - PROCESS | 12128 | 02:44:12 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59836/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:13 INFO - PROCESS | 12128 | RSS: Main: 175951872 02:44:13 INFO - PROCESS | 12128 | 02:44:16 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59836/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:16 INFO - PROCESS | 12128 | RSS: Main: 214265856 02:44:16 INFO - PROCESS | 12128 | 02:44:19 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59836/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:20 INFO - PROCESS | 12128 | RSS: Main: 212676608 02:44:20 INFO - PROCESS | 12128 | 02:44:23 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59836/tests/kraken/driver.html?testName=json-parse-financial) 02:44:23 INFO - PROCESS | 12128 | RSS: Main: 211353600 02:44:23 INFO - PROCESS | 12128 | 02:44:25 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59836/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:25 INFO - PROCESS | 12128 | RSS: Main: 173600768 02:44:25 INFO - PROCESS | 12128 | 02:44:27 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:28 INFO - PROCESS | 12128 | RSS: Main: 180465664 02:44:28 INFO - PROCESS | 12128 | 02:44:30 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:30 INFO - PROCESS | 12128 | RSS: Main: 189493248 02:44:30 INFO - PROCESS | 12128 | 02:44:33 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:34 INFO - PROCESS | 12128 | RSS: Main: 198377472 02:44:34 INFO - PROCESS | 12128 | 02:44:36 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:37 INFO - PROCESS | 12128 | RSS: Main: 194682880 02:44:37 INFO - PROCESS | 12128 | 02:44:38 INFO - PROCESS | 12128 | Cycle 1(1): loaded http://localhost:59836/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59836/tests/kraken/driver.html?testName=ai-astar) 02:44:39 INFO - PROCESS | 12128 | RSS: Main: 245891072 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | __start_tp_report 02:44:39 INFO - PROCESS | 12128 | _x_x_mozilla_page_load 02:44:39 INFO - PROCESS | 12128 | _x_x_mozilla_page_load_details 02:44:39 INFO - PROCESS | 12128 | |i|pagename|runs| 02:44:39 INFO - PROCESS | 12128 | |0;ai-astar;105;112;113;115;114;114;112;114;113;114 02:44:39 INFO - PROCESS | 12128 | |1;audio-beat-detection;146;119;122;159;120;124;118;119;153;119 02:44:39 INFO - PROCESS | 12128 | |2;audio-dft;162;161;161;163;163;163;162;163;164;162 02:44:39 INFO - PROCESS | 12128 | |3;audio-fft;76;77;74;111;75;75;76;76;101;76 02:44:39 INFO - PROCESS | 12128 | |4;audio-oscillator;81;82;127;81;82;82;99;81;82;117 02:44:39 INFO - PROCESS | 12128 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;117;118 02:44:39 INFO - PROCESS | 12128 | |6;imaging-darkroom;147;147;147;148;146;146;146;148;146;146 02:44:39 INFO - PROCESS | 12128 | |7;imaging-desaturate;86;84;85;86;86;86;84;84;84;84 02:44:39 INFO - PROCESS | 12128 | |8;json-parse-financial;51;52;59;52;52;53;50;50;51;51 02:44:39 INFO - PROCESS | 12128 | |9;json-stringify-tinderbox;59;59;60;60;59;59;58;60;60;60 02:44:39 INFO - PROCESS | 12128 | |10;stanford-crypto-aes;74;77;82;75;76;76;76;75;75;74 02:44:39 INFO - PROCESS | 12128 | |11;stanford-crypto-ccm;133;126;131;121;130;127;126;126;165;123 02:44:39 INFO - PROCESS | 12128 | |12;stanford-crypto-pbkdf2;152;158;155;154;156;153;158;155;158;155 02:44:39 INFO - PROCESS | 12128 | |13;stanford-crypto-sha256-iterative;62;63;64;63;63;64;64;61;62;62 02:44:39 INFO - PROCESS | 12128 | __end_tp_report 02:44:39 INFO - PROCESS | 12128 | __start_cc_report 02:44:39 INFO - PROCESS | 12128 | _x_x_mozilla_cycle_collect,1578 02:44:39 INFO - PROCESS | 12128 | __end_cc_report 02:44:39 INFO - PROCESS | 12128 | __startTimestamp1485168279217__endTimestamp 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | ------- Summary: start ------- 02:44:39 INFO - PROCESS | 12128 | Number of tests: 14 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.84 (2.5%) stddev-sans-first:1.01 02:44:39 INFO - PROCESS | 12128 | Values: 105.0 112.0 113.0 115.0 114.0 114.0 112.0 114.0 113.0 114.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:123.00 stddev:16.10 (13.1%) stddev-sans-first:15.99 02:44:39 INFO - PROCESS | 12128 | Values: 146.0 119.0 122.0 159.0 120.0 124.0 118.0 119.0 153.0 119.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:44:39 INFO - PROCESS | 12128 | Values: 162.0 161.0 161.0 163.0 163.0 163.0 162.0 163.0 164.0 162.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:13.05 (17.2%) stddev-sans-first:13.67 02:44:39 INFO - PROCESS | 12128 | Values: 76.0 77.0 74.0 111.0 75.0 75.0 76.0 76.0 101.0 76.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.00 stddev:17.19 (21.0%) stddev-sans-first:17.81 02:44:39 INFO - PROCESS | 12128 | Values: 81.0 82.0 127.0 81.0 82.0 82.0 99.0 81.0 82.0 117.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:44:39 INFO - PROCESS | 12128 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 02:44:39 INFO - PROCESS | 12128 | Values: 147.0 147.0 147.0 148.0 146.0 146.0 146.0 148.0 146.0 146.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:0.99 (1.2%) stddev-sans-first:0.97 02:44:39 INFO - PROCESS | 12128 | Values: 86.0 84.0 85.0 86.0 86.0 86.0 84.0 84.0 84.0 84.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:2.60 (5.0%) stddev-sans-first:2.73 02:44:39 INFO - PROCESS | 12128 | Values: 51.0 52.0 59.0 52.0 52.0 53.0 50.0 50.0 51.0 51.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 02:44:39 INFO - PROCESS | 12128 | Values: 59.0 59.0 60.0 60.0 59.0 59.0 58.0 60.0 60.0 60.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:2.31 (3.0%) stddev-sans-first:2.33 02:44:39 INFO - PROCESS | 12128 | Values: 74.0 77.0 82.0 75.0 76.0 76.0 76.0 75.0 75.0 74.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:128.50 stddev:12.54 (9.8%) stddev-sans-first:13.28 02:44:39 INFO - PROCESS | 12128 | Values: 133.0 126.0 131.0 121.0 130.0 127.0 126.0 126.0 165.0 123.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:155.50 stddev:2.12 (1.4%) stddev-sans-first:1.86 02:44:39 INFO - PROCESS | 12128 | Values: 152.0 158.0 155.0 154.0 156.0 153.0 158.0 155.0 158.0 155.0 02:44:39 INFO - PROCESS | 12128 | 02:44:39 INFO - PROCESS | 12128 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 02:44:39 INFO - PROCESS | 12128 | Values: 62.0 63.0 64.0 63.0 63.0 64.0 64.0 61.0 62.0 62.0 02:44:39 INFO - PROCESS | 12128 | -------- Summary: end -------- 02:44:39 INFO - PROCESS | 12128 | 02:44:40 INFO - TEST-INFO | 12128: exit 0 02:44:40 INFO - TEST-OK | kraken | took 60119ms 02:44:40 INFO - SUITE-END | took 1175s 02:44:40 INFO - Completed test suite (00:19:35) 02:44:40 INFO - javascript benchmark 02:44:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.5512228288035, 3221.3879362921057, 3241.9027429177117, 3252.2844974105687, 3275.770696051276, 5504.366997795255, 5588.077967135423, 5605.299337582802, 5612.494875461208, 5632.77468901244, 5602.327720673525, 5655.26481557397, 5662.150677398392, 5663.915041274384, 5698.487136157745, 5056.873578160557, 5125.359330083739, 5134.974325128369, 5155.948440515603, 5192.065428222918, 5020.849374518771, 5024.296598476216, 5209.791608335662, 5211.557017653504, 5214.426413094557, 5085.211792172219, 5108.64239503235, 5118.181091025437, 5122.026814905174, 5126.794928202868, 5153.098207813637, 5153.2785410042625, 5224.164133738584, 5233.895322093536, 5243.370795504526, 4789.616830653539, 5116.104681680691, 5144.996725638502, 5188.740562971874, 5200.791968321262, 5332.200169974496, 5428.891422171574, 5476.452354764531, 5483.533899618497, 5490.890182196334, 5833.416658334175, 5920.644761314335, 5944.375840536768, 5945.435183657545, 5952.136940143699, 5829.009068458372, 5986.221791167164, 5993.190919225893, 5998.520118390518, 6021.307549631804, 5502.2296878437455, 5506.449355064502, 5518.696471694096, 5527.751251193706, 5553.944460555424, 6071.605345652519, 6072.210612620331, 6085.1785009023215, 6137.232845894263, 6156.938430615726, 5669.489745922887, 5910.940890591039, 5915.911261331084, 5927.31835838884, 5928.140419639214, 5759.164921086419, 5936.762529498858, 5985.790497332572, 5992.0, 6026.216591843032, 5955.642661440327, 5958.0, 5959.106134079922, 5969.432903874125, 5986.102084687244, 5893.174955506232, 5952.255968003999, 5959.582829201914, 5960.6721630309885, 5982.790602328898, 4471.8658440246845, 4500.437445319335, 4513.232750432434, 4545.250033744395, 4617.953820461752, 4124.154548317588, 4134.37984302351, 4155.91688166235, 4163.562825903297, 4163.937540936889, 5652.3217213934595, 5654.943450565442, 5656.123300888369, 5656.8020119295625, 5658.179563963202, 5848.883022339614, 5893.941060589425, 5919.467247947619, 6035.155078289043, 6037.1246169305205, 5551.611387202857, 5617.269754931915, 5618.887622247532, 5638.746256418471, 5647.943520564741, 5136.614753893473, 5183.45573714762, 5196.402413722395, 5203.505666961632, 5239.73801309933, 5969.76120955157, 6028.487578555872, 6138.1713468681155, 6175.475084617858, 6200.131981522591, 5896.145058966512, 5986.07215881539, 5994.220751302303, 6086.847828804315, 6141.692915354304, 6155.599886007395, 6157.576483266522, 6183.474404675653, 6191.504679625529, 6204.81385558434, 5692.800751973827, 5964.045752679551, 5965.492933100735, 5967.880642387215, 6001.609895356788, 5774.509166720708, 5927.229460170151, 6038.275406951018, 6041.426064523863, 6141.570090093651, 5918.911216331845, 5967.9701601491715, 5972.671503067373, 5977.252843394575, 5988.940110599013, 5894.882102357843, 5905.734241959208, 5906.379830117776, 5909.734061967308, 5958.1658567801405, 5603.663780173202, 5729.770809167587, 5738.454846789548, 5744.396838331915, 5764.769409223752, 5922.170896074467, 5927.673977931255, 5931.258592675916, 5932.940670593239, 5946.108083787466, 5518.558515318685, 5573.331200255995, 5766.509846662912, 5776.075827867521, 5778.653280803165], "value": 5514.547212088629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.5429510686558, 616.5899676714985, 641.3682522715125, 641.9390157934997, 674.1101745695678, 36461.635383646186, 44438.0, 45656.771716141455, 45686.0, 48486.51513484864, 45776.313355299695, 46262.306065408964, 46267.30599041009, 46292.3056154158, 46324.76837615807, 8340.499570025819, 8810.20708136266, 8962.0, 8970.0, 8971.474849275639, 8507.744767656981, 10428.322159059675, 10708.892911070907, 10710.0, 10983.61557345493, 10821.350718956848, 10821.783564328709, 10893.0, 10909.07272881802, 10910.61812836551, 10639.0, 10689.091427228695, 10728.678139655784, 10730.731731706692, 10733.731656708645, 10456.268061235716, 10537.525811338432, 10588.470576471223, 10603.416812075333, 10646.733831654194, 43357.0, 43743.125137497074, 43823.56176438227, 43867.78066109649, 44026.33960490595, 3640.9453858192146, 3677.7425580209397, 3750.774953502799, 3934.980325098385, 4146.357314616239, 33480.665193347995, 33509.0, 33778.49332260018, 33907.0, 34632.30735385304, 4307.806148723315, 4319.157764235975, 4337.501187363462, 4366.956330436687, 4402.8679139625865, 321724.0, 322155.0, 323047.0, 324128.0, 324323.0, 39124.0, 63076.05385919215, 63324.68337658282, 63526.68236658787, 63532.68233658802, 39520.604793951694, 41478.37782433266, 41490.0, 41518.37722434106, 41541.79229103835, 16940.661186776197, 17072.48782536526, 17077.316907323817, 17078.146092695315, 17100.0594967278, 12918.160319579198, 13194.802077968838, 14116.0, 14624.19566923808, 14806.555803325917, 9353.204977576983, 9427.434353938786, 9451.905480945241, 9479.336446448682, 9554.474503902213, 3644.7448678592773, 3655.4151335786146, 3658.6158453362546, 3708.128589781399, 3732.0, 1003.9297249192487, 1009.0867764672836, 1038.3873514626407, 1046.0742243114746, 1131.4738646529404, 32306.676933230836, 34225.48661770076, 34353.76700514458, 34933.0, 36563.817180914455, 1124.9381284029457, 1133.7562424078862, 1150.108665784024, 1151.4588143572507, 1189.5241903238773, 17421.65156696859, 17642.735358969625, 17673.11634418274, 17707.0, 17773.20020599076, 497575.0, 498453.0, 502170.0, 502315.0, 503142.0, 61240.38759612436, 61586.0, 61842.38157618456, 61889.690551546955, 61995.0, 1349.7772867476954, 1408.3803126624252, 1414.7453458377386, 1458.2344269258513, 1491.5450787509697, 31710.36579268448, 35463.69485983506, 35956.28087438289, 36441.81779091088, 36831.81584092062, 58925.70537147287, 59852.10221846589, 63404.0, 63480.365196349296, 63614.36385636085, 447593.0, 451416.0, 452780.0, 452845.0, 454689.0, 42536.361954570086, 42710.359344609235, 43593.0, 48261.0, 49592.504074960234, 50106.0, 51801.48198518117, 51947.48052519577, 52086.47913520816, 55407.722961384934, 42450.36324455074, 42753.0, 44217.107132707795, 45231.54768452405, 47122.76438617785, 44158.55841441544, 45387.0, 46789.76605116953, 46893.0, 47094.52905470901, 40921.59078409297, 41032.0, 41060.0, 41162.79418602888, 43520.0, 38744.64393746205, 41171.58828411797, 41489.37765933574, 42602.0, 43008.0, 29929.0, 29958.08383233533, 30251.546226807055, 30393.24016899595, 30960.0], "value": 20549.595303679795, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.4933758795123, 401.3618346828542, 423.6568379612514, 435.5144014423917, 441.63123791633984, 18680.532986675324, 19716.01419929003, 20318.08568614412, 20435.693464598044, 20772.06525706343, 20094.296699615516, 20108.899455502702, 20287.0, 20290.59418811623, 20353.796462035374, 5690.5447564194765, 5983.222181116449, 5983.790567330145, 5990.790322338719, 6002.579819412643, 5640.576956728261, 5779.479846813786, 5801.0, 5816.563757718167, 5898.7640494380175, 5713.514351280146, 5716.3426205986425, 5719.59962802604, 5768.163616275659, 5772.826815195551, 5545.584081193906, 5687.6303040302455, 5712.971435142839, 5725.312962444513, 5755.223044888929, 5243.187305967581, 5283.920741188886, 5284.101702710548, 5292.338457692788, 5292.947070529284, 22200.333989980325, 23622.881885590636, 23672.0, 23734.76265237343, 23800.166994155294, 2390.557746816827, 2414.9879250603635, 2437.7805997460314, 2530.7975361971, 2578.1878708206855, 14354.49759258421, 14571.417143314255, 14894.0, 15022.624434389118, 15207.771883421647, 1885.981140188608, 1932.8550358723153, 2002.2091273946855, 2034.0236686390467, 2061.711360409544, 79727.0, 80819.9385046124, 82557.58721206416, 93841.5307923456, 94927.52536237275, 11353.318800871974, 11630.53477860893, 11818.409079545989, 12173.573924912762, 12190.756184876253, 17566.91216543909, 17574.945503269846, 17584.648307034044, 17595.296188152588, 17600.735988960176, 8893.4663920165, 9062.954685226663, 9115.407498512575, 9185.95407022974, 9254.768630784285, 8642.178992995656, 8698.0, 8778.517181555077, 8895.599698013604, 8943.552822358855, 5188.844334669966, 5193.091209038404, 5198.402183748917, 5230.476952304815, 5368.221607866837, 2023.6863286190664, 2039.5003224210163, 2083.239617539587, 2104.0, 2110.9366718998454, 948.7248697877538, 1008.1128606825946, 1061.4586560853866, 1089.4824958144818, 1095.4265939701713, 18704.625907481775, 20640.174393024412, 20688.793112068986, 20953.371398857755, 20956.161753529686, 1008.7931973945324, 1029.7888932768765, 1064.1965316186229, 1064.707205518473, 1087.6736978906297, 10704.839427408595, 11370.0, 11413.801550837208, 11513.712157196138, 11585.82621260665, 426121.08576199686, 428136.0, 444524.0, 447264.0, 449492.0, 92802.0, 93431.0, 95182.52408737912, 96247.51876240714, 98120.0, 1056.915446764257, 1072.683558350273, 1087.1628845788698, 1118.3848883114417, 1123.741539445932, 17700.734488982416, 17841.910790445963, 18467.630647387246, 18562.628747424707, 18614.34849780251, 40285.798571006955, 40783.388249175696, 41198.58801412067, 42081.78959105185, 42418.78790606027, 57502.7124864373, 58087.70956145192, 59028.0, 59845.70077149587, 60321.69839150776, 8556.957215213884, 8636.740897773077, 8738.563071846509, 8752.518611476175, 8757.343199259954, 12545.560905368267, 13059.281739504419, 13200.14199077057, 13388.732225355634, 14144.292785360896, 11163.330200188015, 11447.25592836463, 11711.1802173847, 11864.466099025738, 12060.75878482443, 11803.763924721628, 11815.40922953866, 11905.40472976365, 11926.701832454259, 11935.343556104497, 10781.84363127362, 11138.944305278746, 11562.248453850472, 11601.593944211912, 11741.0, 8366.330693544624, 8531.0, 8752.78118047054, 8873.556322183995, 8905.73282801517, 10952.780944381228, 11124.0, 11440.771184576428, 11629.941850290694, 11999.76000480003], "value": 9618.67267137406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.7123918357552, 1473.8231412230534, 1486.6432056306485, 1630.2582325042108, 1777.5467255849765, 7435.442341824364, 8168.91831081689, 8467.0, 8493.872591911118, 8707.695230666928, 8479.703210387623, 8481.78795530112, 8502.95748521258, 8616.698415555442, 8637.0, 2401.867897265654, 2420.7337192908767, 2427.2232885476656, 2431.258466167818, 2434.866082365469, 2388.140269502986, 2408.12103582193, 2436.549238390903, 2445.1930862815316, 2445.755424457549, 2395.7244916834525, 2400.375902265415, 2420.7942324902315, 2425.5391475619663, 2426.8301218914685, 2339.94150146246, 2343.8476499027593, 2373.7863592276776, 2374.347054560001, 2376.4058985253687, 2251.268337790225, 2278.624027035537, 2286.8513546619583, 2314.6065168921323, 2319.5824751544715, 8291.626876790559, 8380.413371064027, 8439.156084391572, 8550.828983420297, 8564.914350856474, 4979.925301120486, 5178.559822415099, 5194.37667479901, 5200.947990520084, 5201.375834899836, 3394.62659107498, 3503.579570451562, 3567.571891373026, 3577.928441431183, 3589.838457269429, 1099.8350247462865, 1104.1884215101893, 1107.457345900503, 1157.317182862107, 1164.5050853387277, 11764.705882352924, 11876.940615296955, 11898.821517677241, 11916.582919597859, 11923.463444144947, 4133.318002529609, 4395.494518130392, 4452.0873220989615, 4482.238019536687, 4486.080353527519, 9475.47884866339, 9491.240700743923, 9497.715068547956, 9504.097110774464, 9516.19112375442, 5156.175011998137, 5166.483351664803, 5167.457416971239, 5167.715775632301, 5168.095583272988, 4097.97951010243, 4295.140971805651, 4464.0402313502755, 4483.977580112144, 4857.319975203474, 3704.592494825567, 3742.3346610757953, 3823.808809559511, 3858.9807050964564, 3864.072622570563, 1174.4514403743897, 1210.5702475621028, 1213.5813144465146, 1214.9331786751814, 1222.3826967381415, 952.7237101240563, 959.6209497248688, 964.7732782796037, 965.6620182936057, 986.6102889358663, 5678.0, 5689.175069614883, 5771.653700777967, 5804.1293805929445, 5939.13882487037, 468.1760102220117, 476.56156336170807, 481.4872161148366, 489.3076297039649, 498.30486471372234, 3824.521934758155, 4007.519097708294, 4015.7590544566833, 4032.475778148822, 4032.91934161321, 10097.293189476666, 10435.634752783617, 10530.15758739299, 10533.631322903662, 10561.102306303897, 10387.636432724817, 10475.580976760997, 10479.94760026195, 10507.632232871965, 10526.263161578616, 7981.04227492693, 8055.113937466874, 8060.798480037929, 8066.314363279187, 8081.878771818545, 5618.550515958796, 5685.033544297562, 5690.9430905690415, 5713.971430142823, 5717.142428635571, 9425.104615061558, 9468.526573671152, 9532.142107210384, 9559.61761529531, 9592.808143836945, 8350.791230219293, 8526.531040792815, 9539.33224674266, 9706.6117355305, 9799.706008819747, 7291.52605080668, 7458.403327733877, 7463.962680186564, 7584.127825300161, 7619.771406857803, 7984.640691169027, 8213.0, 8299.751007469786, 8456.0, 8458.915410845813, 7329.853402932018, 7348.52234604749, 7351.485396022441, 7469.962650186714, 7475.775726728207, 7182.3535881770895, 7198.49610527258, 7249.891251631335, 7281.5631062136445, 7373.262673732584, 6600.669966501751, 6707.798766037026, 6782.321767823179, 6899.241083480712, 6909.2745261748805, 4707.599854012447, 4833.10587541306, 4837.0, 4866.270059490963, 4921.606271498343, 4813.133635945564, 4873.025394920959, 4920.852374428773, 4923.876903077452, 4955.40535135786], "value": 4431.3275139532025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2000079803681, 333.72801167048857, 334.6252197538757, 336.6128951705539, 338.2085918949657, 5277.313949186605, 5345.1982202669615, 5355.6786592804365, 5391.973040134803, 5398.325209348832, 5015.899682006358, 5091.618128640348, 5144.382674079106, 5207.505286997739, 5293.655912365693, 4152.896177595554, 4153.501579810427, 4157.731891773008, 4179.456670632813, 4187.979060104695, 4141.295979683461, 4169.62473377396, 4182.958170418303, 4185.246655601991, 4204.747715137086, 3920.7451515651533, 4006.519217693881, 4012.8595499157536, 4146.8133933972895, 4151.481064866892, 4126.5667104954, 4128.793560321972, 4131.462909821734, 4145.9999999999845, 4150.543440221573, 3697.85208591656, 3705.4256590228556, 3721.106934335767, 3736.626337366242, 3754.1177823211524, 5078.949210507884, 5108.259302401131, 5109.671485413819, 5234.141879632752, 5246.950609878039, 4722.83570008092, 4727.290906364038, 4732.337472753818, 4742.644301677354, 4757.714537127748, 5472.562195024429, 5496.725163741837, 5508.807191748269, 5512.724363781795, 5546.722663866791, 3940.4483372327895, 4055.8174882130374, 4105.958940410587, 4120.320147175742, 4124.123124547537, 5698.7435565399655, 5700.25896633435, 5707.77168913243, 5715.1713001614535, 5728.742206600713, 4222.3244280914905, 4222.4933008038615, 4224.54253282617, 4227.619514243671, 4231.449911511484, 3871.9806400968378, 4024.5774193709826, 4265.936010959838, 4278.807453664593, 4287.164003019381, 4665.183592871234, 4676.0, 4678.228092364721, 4688.390509233778, 4691.601213896789, 5540.9168862467095, 5552.696145793247, 5560.249366335493, 5571.860703482445, 5572.353132262143, 1317.2952470428274, 1344.7041650836995, 1359.945602175902, 1362.8364596248514, 1367.5828872193877, 936.4007035497287, 960.2941837749248, 963.3545524498462, 964.3538828984457, 981.3768257156614, 5172.594743444316, 5185.585153187736, 5216.070054080014, 5220.112580861262, 5235.607329450307, 5257.816991177031, 5441.428649991773, 5450.5367043801725, 5473.397926228112, 5484.204790305464, 5133.486651334912, 5138.505816045051, 5147.422541333812, 5156.375741641371, 5160.355679888131, 2822.943541129207, 2884.793133253063, 2896.5365541513256, 2902.216401571606, 2903.301568582403, 5438.347398312228, 5490.890182196334, 5536.2249285100115, 5561.4716601922755, 5575.665460072409, 5554.638948468418, 5572.832815015556, 5591.245181900473, 5594.636348637326, 5614.0, 5303.520097078712, 5481.287432633732, 5539.279893613804, 5548.639338442988, 5584.190292407578, 5406.540444062299, 5432.239486471976, 5437.504686211323, 5444.537214336826, 5451.591130665137, 5354.411014788292, 5423.186522021729, 5426.0, 5435.456454354533, 5439.673619582838, 5486.862828429162, 5789.45000224978, 5801.897639448492, 5822.272215973004, 5828.562857785599, 4045.5145382554283, 4054.8580799671868, 4057.4928133983253, 4070.6946978976102, 4076.449679293376, 5490.972545137409, 5591.748371323219, 5600.663960162403, 5706.372299047184, 5812.0, 5561.555075593862, 5610.691411972381, 5616.1856530803625, 5619.438056194348, 5623.409541998195, 5320.893582128413, 5589.90996755645, 5590.608657393944, 5592.161175823497, 5628.887422251614, 5513.200585914939, 5568.443155684561, 5574.303212098488, 5586.944130558805, 5603.0, 5620.494155525858, 5639.689817060101, 5641.182028605911, 5656.745446454837, 5656.830295091154, 5247.842564723064, 5435.945640543544, 5456.754446050017, 5485.1624705724025, 5509.641873278224], "value": 4198.268394122502, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.7941596936887, 721.3940290156268, 774.7791879314393, 829.2702421868754, 867.293156077797, 12505.874941250597, 12738.93630531846, 12895.871041289596, 13142.14576052556, 13267.999999999987, 13624.18254904704, 13713.451461941535, 13722.0, 13735.519256826014, 13756.31218439079, 723.1683563901503, 745.7986343687228, 852.7271273192581, 870.4255191573546, 873.4191762477944, 860.6428332242112, 864.7362554420899, 865.9565223905211, 866.1295398124876, 867.089555966236, 919.7562645898843, 921.8340698674236, 922.5479515037616, 922.7508572685371, 923.372106967262, 757.1141764135974, 779.6413649721106, 883.5979629268668, 911.2118017914522, 919.3472634429563, 674.0832467843728, 674.3728332650633, 674.5244602555186, 674.9730010799562, 675.1627981303197, 14866.033707809065, 15236.390544378211, 15305.387784488606, 15327.923360383238, 15330.770038449433, 12702.491900323976, 12943.482260709561, 12953.417096230693, 13046.804297935538, 13155.210687358693, 12549.435275412628, 12587.0, 12839.550615728405, 12959.352032398436, 13092.86907130926, 4438.800253988546, 4440.156370289635, 4462.352958820985, 4473.530279320689, 4478.081993191388, 60315.0, 60391.09413358847, 60802.695986519786, 60880.0, 61376.0, 10456.68629941103, 10730.409827459565, 10811.567537298577, 10926.945365273123, 11000.779984400267, 19761.209551617776, 19763.60472790536, 19914.103865326095, 19965.0, 20470.0, 8178.46839955401, 8241.25828675422, 8293.419460637697, 8387.83224335522, 8480.406371553932, 4760.880977975578, 4761.095391875602, 4763.809447622057, 4814.301926220678, 4960.355153830051, 3262.8531716072835, 3351.6648335166287, 3356.8825091121694, 3364.158960259935, 3373.3421982713626, 594.9643021418728, 596.7225240263299, 598.6886818854172, 609.6616377910302, 614.7233744814852, 582.9708514574254, 618.6690120785448, 680.0, 705.4532737128766, 717.9712811487586, 8482.575871206414, 8683.56582170889, 9079.50062746542, 9202.125798049176, 9385.15533601979, 620.4725982914487, 678.7081554931427, 686.5606012152226, 699.9825004374829, 712.8609921065446, 4230.90320975367, 4343.218220720238, 4394.406755088086, 4397.494288156839, 4420.690551661417, 88586.55706721425, 88794.0, 89138.55430722804, 90381.54809226043, 92950.07049929415, 77466.61266693744, 78546.0, 78880.0, 81664.59167704123, 81821.0, 70127.0, 71168.64415677992, 71206.64396678087, 71330.0, 72473.6376318115, 8340.791480213044, 8556.957215213884, 8639.5609877775, 8721.694740684046, 8930.0, 50643.49356506388, 51060.21289254858, 51277.0, 51536.484635154666, 52405.21392179197, 61701.0, 67782.66108669425, 67818.66090669515, 67858.0, 68718.28204294933, 10648.8935110651, 10678.092362148993, 10818.350898946088, 10852.945735271272, 11097.445127743742, 11391.658250252505, 11497.08023358146, 11911.642650720492, 12149.635510934686, 12922.676933076747, 10799.168299889747, 10906.50920708554, 11040.944795275973, 11134.665960021212, 11532.711682208012, 11922.165448418527, 11974.161808673309, 12199.268043917393, 12233.938830305791, 12320.383980800745, 11201.887981120084, 11359.48882300282, 11407.0, 11463.942680286546, 11842.46708898119, 8178.223068808454, 8617.69838055665, 8648.221660050625, 8765.868511972198, 8822.5588720565, 8547.101953225834, 8583.570821458778, 8694.82610347802, 8695.131624238584, 8980.46117232968], "value": 6984.372359134376, "unit": "score"}], "name": "dromaeo_css", "value": 7219.956427395968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 115.0, 114.0, 114.0, 112.0, 114.0, 113.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 122.0, 159.0, 120.0, 124.0, 118.0, 119.0, 153.0, 119.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0, 163.0, 164.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 111.0, 75.0, 75.0, 76.0, 76.0, 101.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 127.0, 81.0, 82.0, 82.0, 99.0, 81.0, 82.0, 117.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 86.0, 86.0, 86.0, 84.0, 84.0, 84.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 59.0, 52.0, 52.0, 53.0, 50.0, 50.0, 51.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 58.0, 60.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 82.0, 75.0, 76.0, 76.0, 76.0, 75.0, 75.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 126.0, 131.0, 121.0, 130.0, 127.0, 126.0, 126.0, 165.0, 123.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 158.0, 155.0, 154.0, 156.0, 153.0, 158.0, 155.0, 158.0, 155.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 61.0, 62.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1463.5, "alertThreshold": 2.0}]} 02:44:40 INFO - Return code: 0 02:44:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:44:40 INFO - # TBPL SUCCESS # 02:44:40 INFO - Running post-action listener: _resource_record_post_action 02:44:40 INFO - [mozharness: 2017-01-23 10:44:40.547170Z] Finished run-tests step (success) 02:44:40 INFO - Running post-run listener: _resource_record_post_run 02:44:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356933632; Read time: 28; Write time: 250940 02:44:40 INFO - TinderboxPrint: CPU usage
13.0% 02:44:40 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 02:44:40 INFO - TinderboxPrint: I/O write bytes / time
356,933,632 / 250,940 02:44:40 INFO - TinderboxPrint: CPU idle
8,275.0 (87.0%) 02:44:40 INFO - TinderboxPrint: CPU user
1,191.3 (12.5%) 02:44:40 INFO - TinderboxPrint: Swap in / out
0 / 0 02:44:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108040192; Read time: 0; Write time: 73832 02:44:40 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246390784; Read time: 16; Write time: 176792 02:44:41 INFO - Running post-run listener: _upload_blobber_files 02:44:41 INFO - Blob upload gear active. 02:44:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:44:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:44:41 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:44:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:44 INFO - (blobuploader) - INFO - Done attempting. 02:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:45 INFO - (blobuploader) - INFO - Done attempting. 02:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:46 INFO - (blobuploader) - INFO - Done attempting. 02:44:46 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:46 INFO - Return code: 0 02:44:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:44:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9add9e77eeebfd1b23a64b08cbf3962b6aa7b7949770a312d89e5a0bb2b3f1fcd0a3815134f171967a7446be050fd48d2f0bb02a87ee3f012cc6e140ae060e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5999e76ca2cf683474ab3245af5f01d9ddb38f5cace2a59abb1c936552ca4c9bc87bd9beb31f7c398cacf02e99a28a5b631e07995fd742c6d25f808707ea7c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/172e30dcd4efceafd980c78ac2c163a46f20d8fb6d90b529d8d2189fe083f366768e117f96b9ec2cbc66e00162693462bb6932820f1aecb499090c316f2324ea"} 02:44:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:44:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:44:46 INFO - Contents: 02:44:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9add9e77eeebfd1b23a64b08cbf3962b6aa7b7949770a312d89e5a0bb2b3f1fcd0a3815134f171967a7446be050fd48d2f0bb02a87ee3f012cc6e140ae060e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5999e76ca2cf683474ab3245af5f01d9ddb38f5cace2a59abb1c936552ca4c9bc87bd9beb31f7c398cacf02e99a28a5b631e07995fd742c6d25f808707ea7c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/172e30dcd4efceafd980c78ac2c163a46f20d8fb6d90b529d8d2189fe083f366768e117f96b9ec2cbc66e00162693462bb6932820f1aecb499090c316f2324ea"} 02:44:46 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:46 INFO - Copying logs to upload dir... 02:44:46 INFO - mkdir: /builds/slave/test/build/upload/logs 02:44:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.944115 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-23 02:44:43.699835) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 02:44:43.703007) ========= 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=52faae308a556c440401f8e5000001e8-1485167050.63607-915934285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9add9e77eeebfd1b23a64b08cbf3962b6aa7b7949770a312d89e5a0bb2b3f1fcd0a3815134f171967a7446be050fd48d2f0bb02a87ee3f012cc6e140ae060e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5999e76ca2cf683474ab3245af5f01d9ddb38f5cace2a59abb1c936552ca4c9bc87bd9beb31f7c398cacf02e99a28a5b631e07995fd742c6d25f808707ea7c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/172e30dcd4efceafd980c78ac2c163a46f20d8fb6d90b529d8d2189fe083f366768e117f96b9ec2cbc66e00162693462bb6932820f1aecb499090c316f2324ea"} build_url:https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/R3i5OEIGThqAB46x6C07DA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9add9e77eeebfd1b23a64b08cbf3962b6aa7b7949770a312d89e5a0bb2b3f1fcd0a3815134f171967a7446be050fd48d2f0bb02a87ee3f012cc6e140ae060e0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5999e76ca2cf683474ab3245af5f01d9ddb38f5cace2a59abb1c936552ca4c9bc87bd9beb31f7c398cacf02e99a28a5b631e07995fd742c6d25f808707ea7c7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/172e30dcd4efceafd980c78ac2c163a46f20d8fb6d90b529d8d2189fe083f366768e117f96b9ec2cbc66e00162693462bb6932820f1aecb499090c316f2324ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 02:44:43.728557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:44:43.728890) ========= 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=52faae308a556c440401f8e5000001e8-1485167050.63607-915934285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:44:43.812466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 02:44:43.812839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 02:44:43.813175) ========= ========= Total master_lag: 0.15 =========