builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1477390910.27 results: success (0) buildid: 20161025013209 builduid: 2f1c2d45dd2545f3923b7be78313ef81 revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.268704) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.269187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.269479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.284042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.284395) ========= 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=8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 03:21:50-- 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% 46.6M=0s 2016-10-25 03:21:50 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.388686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.388994) ========= 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=8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013669 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.438134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:50.438493) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --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=8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 03:21:50,584 truncating revision to first 12 chars 2016-10-25 03:21:50,584 Setting DEBUG logging. 2016-10-25 03:21:50,584 attempt 1/10 2016-10-25 03:21:50,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78b863e9fcd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 03:21:51,086 unpacking tar archive at: mozilla-central-78b863e9fcd9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:51.277745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:51.278063) ========= script_repo_revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:51.278472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:51.278747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:21:51.286869) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-25 03:21:51.287212) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:51 INFO - MultiFileLogger online at 20161025 03:21:51 in /builds/slave/test 03:21:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:21:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:51 INFO - {'append_to_log': False, 03:21:51 INFO - 'base_work_dir': '/builds/slave/test', 03:21:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:21:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:51 INFO - 'branch': 'Firefox-Non-PGO', 03:21:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:51 INFO - 'config_files': ('talos/linux_config.py',), 03:21:51 INFO - 'default_actions': ('clobber', 03:21:51 INFO - 'read-buildbot-config', 03:21:51 INFO - 'download-and-extract', 03:21:51 INFO - 'populate-webroot', 03:21:51 INFO - 'create-virtualenv', 03:21:51 INFO - 'install', 03:21:51 INFO - 'run-tests'), 03:21:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:51 INFO - 'download_minidump_stackwalk': True, 03:21:51 INFO - 'download_symbols': 'ondemand', 03:21:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:51 INFO - 'installer_path': 'installer.exe', 03:21:51 INFO - 'log_level': 'info', 03:21:51 INFO - 'log_name': 'talos', 03:21:51 INFO - 'log_to_console': True, 03:21:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:51 INFO - 'opt_config_files': (), 03:21:51 INFO - 'pip_index': False, 03:21:51 INFO - 'sps_profile': False, 03:21:51 INFO - 'sps_profile_interval': 0, 03:21:51 INFO - 'suite': 'dromaeojs', 03:21:51 INFO - 'system_bits': '32', 03:21:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:51 INFO - 'title': 'talos-linux64-ix-038', 03:21:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:51 INFO - 'use_talos_json': True, 03:21:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:51 INFO - 'work_dir': 'build'} 03:21:51 INFO - [mozharness: 2016-10-25 10:21:51.525784Z] Running clobber step. 03:21:51 INFO - Running pre-action listener: _resource_record_pre_action 03:21:51 INFO - Running main action method: clobber 03:21:51 INFO - rmtree: /builds/slave/test/build 03:21:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:51 INFO - Running post-action listener: _resource_record_post_action 03:21:51 INFO - [mozharness: 2016-10-25 10:21:51.986208Z] Finished clobber step (success) 03:21:51 INFO - [mozharness: 2016-10-25 10:21:51.986309Z] Running read-buildbot-config step. 03:21:51 INFO - Running pre-action listener: _resource_record_pre_action 03:21:51 INFO - Running main action method: read_buildbot_config 03:21:51 INFO - Using buildbot properties: 03:21:51 INFO - { 03:21:51 INFO - "project": "", 03:21:51 INFO - "product": "firefox", 03:21:51 INFO - "script_repo_revision": "production", 03:21:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:21:51 INFO - "repository": "", 03:21:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:21:51 INFO - "buildid": "20161025013209", 03:21:51 INFO - "pgo_build": "False", 03:21:51 INFO - "basedir": "/builds/slave/test", 03:21:51 INFO - "buildnumber": 266, 03:21:51 INFO - "slavename": "talos-linux64-ix-038", 03:21:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:21:51 INFO - "platform": "ubuntu64_hw", 03:21:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:21:51 INFO - "branch": "mozilla-central", 03:21:51 INFO - "repo_path": "mozilla-central", 03:21:51 INFO - "revision": "78b863e9fcd9d44d75c817b6495b4585167ba255", 03:21:51 INFO - "stage_platform": "linux64", 03:21:51 INFO - "builduid": "2f1c2d45dd2545f3923b7be78313ef81", 03:21:51 INFO - "slavebuilddir": "test" 03:21:51 INFO - } 03:21:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:21:51 INFO - Running post-action listener: _resource_record_post_action 03:21:51 INFO - [mozharness: 2016-10-25 10:21:51.988749Z] Finished read-buildbot-config step (success) 03:21:51 INFO - [mozharness: 2016-10-25 10:21:51.988838Z] Running download-and-extract step. 03:21:51 INFO - Running pre-action listener: _resource_record_pre_action 03:21:51 INFO - Running main action method: download_and_extract 03:21:51 INFO - mkdir: /builds/slave/test/build/tests 03:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:51 INFO - trying https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:21:51 INFO - Downloading https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:21:52 INFO - Downloaded 1361 bytes. 03:21:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:21:52 INFO - Using the following test package requirements: 03:21:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:21:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:21:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'jsshell-linux-x86_64.zip'], 03:21:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:21:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:21:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:21:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:21:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:21:53 INFO - Http code: 200 03:21:53 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 03:21:53 INFO - x-amz-cf-id: GC3hHRmVamIaPiOI49nf7MD_LcBoqBKbem3EpV-pOxCBfk-SmlWu-A== 03:21:53 INFO - x-amz-version-id: .DkEpOBAymk6NG1tXsr0kEy9zMKu_0O3 03:21:53 INFO - Expected file size: 20468007 03:21:53 INFO - Obtained file size: 20468007 03:21:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:21:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:21:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:57 INFO - Fetch https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:21:58 INFO - Http code: 200 03:21:58 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 03:21:58 INFO - x-amz-cf-id: iuXquIzvTuf9qyMXwZJYeqBxAL8UwbzFFySF9tzDlbiR6RJfzK0atA== 03:21:58 INFO - x-amz-version-id: .DkEpOBAymk6NG1tXsr0kEy9zMKu_0O3 03:21:58 INFO - Expected file size: 20468007 03:21:58 INFO - Obtained file size: 20468007 03:22:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:22:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:22:02 INFO - Fetch https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:22:03 INFO - Http code: 200 03:22:03 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 03:22:03 INFO - x-amz-cf-id: NRn2wiWepjwqx54H9U0aDyTsVfnSUcYo4ozwThNyOCFBxW55vJstkg== 03:22:03 INFO - x-amz-version-id: rq6Thrq4qU2yugav4EGjAyJgnd8VRXpl 03:22:03 INFO - Expected file size: 14409028 03:22:03 INFO - Obtained file size: 14409028 03:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:03 INFO - trying https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:22:03 INFO - Downloading https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:22:05 INFO - Downloaded 55575561 bytes. 03:22:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:22:05 INFO - mkdir: /builds/slave/test/properties 03:22:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:05 INFO - Contents: 03:22:05 INFO - build_url:https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:22:05 INFO - Running post-action listener: _resource_record_post_action 03:22:05 INFO - Running post-action listener: set_extra_try_arguments 03:22:05 INFO - [mozharness: 2016-10-25 10:22:05.787694Z] Finished download-and-extract step (success) 03:22:05 INFO - [mozharness: 2016-10-25 10:22:05.787921Z] Running populate-webroot step. 03:22:05 INFO - Running pre-action listener: _resource_record_pre_action 03:22:05 INFO - Running main action method: populate_webroot 03:22:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:05 INFO - '--tppagecycles', 03:22:05 INFO - '7'], 03:22:05 INFO - 'tests': ['tsvgm']}}, 03:22:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['damp', 'tps']}, 03:22:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'tests': ['damp', 'tps']}, 03:22:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['dromaeo_dom']}, 03:22:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['basic_compositor_video']}, 03:22:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:22:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['a11yr', 03:22:05 INFO - 'ts_paint', 03:22:05 INFO - 'tpaint', 03:22:05 INFO - 'sessionrestore', 03:22:05 INFO - 'sessionrestore_no_auto_restore', 03:22:05 INFO - 'tabpaint']}, 03:22:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:05 INFO - 'ts_paint', 03:22:05 INFO - 'tpaint', 03:22:05 INFO - 'sessionrestore', 03:22:05 INFO - 'sessionrestore_no_auto_restore', 03:22:05 INFO - 'tabpaint']}, 03:22:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:05 INFO - 'ts_paint', 03:22:05 INFO - 'tpaint', 03:22:05 INFO - 'sessionrestore', 03:22:05 INFO - 'sessionrestore_no_auto_restore', 03:22:05 INFO - 'tabpaint']}, 03:22:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:05 INFO - 'ts_paint', 03:22:05 INFO - 'tpaint', 03:22:05 INFO - 'sessionrestore', 03:22:05 INFO - 'sessionrestore_no_auto_restore', 03:22:05 INFO - 'tabpaint']}, 03:22:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['a11yr', 03:22:05 INFO - 'ts_paint', 03:22:05 INFO - 'tpaint', 03:22:05 INFO - 'sessionrestore', 03:22:05 INFO - 'sessionrestore_no_auto_restore', 03:22:05 INFO - 'tabpaint']}, 03:22:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['a11yr', 03:22:05 INFO - 'ts_paint', 03:22:05 INFO - 'tpaint', 03:22:05 INFO - 'sessionrestore', 03:22:05 INFO - 'sessionrestore_no_auto_restore', 03:22:05 INFO - 'tabpaint']}, 03:22:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['tsvgx', 03:22:05 INFO - 'tsvgr_opacity', 03:22:05 INFO - 'tart', 03:22:05 INFO - 'tscrollx', 03:22:05 INFO - 'cart']}, 03:22:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:05 INFO - 'tsvgr_opacity', 03:22:05 INFO - 'tart', 03:22:05 INFO - 'tscrollx', 03:22:05 INFO - 'cart']}, 03:22:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'talos_options': ['--disable-e10s'], 03:22:05 INFO - 'tests': ['tp5o']}, 03:22:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'tests': ['tp5o']}, 03:22:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'talos_options': ['--disable-e10s', 03:22:05 INFO - '--xperf_path', 03:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:05 INFO - 'tests': ['tp5n']}, 03:22:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:05 INFO - 'talos_options': ['--xperf_path', 03:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:05 INFO - 'tests': ['tp5n']}}, 03:22:05 INFO - 'talos.zip': {'path': '', 03:22:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:05 INFO - Running post-action listener: _resource_record_post_action 03:22:05 INFO - [mozharness: 2016-10-25 10:22:05.809880Z] Finished populate-webroot step (success) 03:22:05 INFO - [mozharness: 2016-10-25 10:22:05.809969Z] Running create-virtualenv step. 03:22:05 INFO - Running pre-action listener: _resource_record_pre_action 03:22:05 INFO - Running main action method: create_virtualenv 03:22:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:22:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:05 INFO - Using real prefix '/usr' 03:22:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:08 INFO - Installing pip.................done. 03:22:08 INFO - Return code: 0 03:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:22:08 INFO - Reading from file tmpfile_stdout 03:22:08 INFO - Output received: 03:22:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:22:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:22:08 INFO - Using env: {'DISPLAY': ':0', 03:22:08 INFO - 'HOME': '/home/cltbld', 03:22:08 INFO - 'LANG': 'en_US.UTF-8', 03:22:08 INFO - 'LANGUAGE': 'en_US:en', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MAIL': '/var/mail/cltbld', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SHLVL': '1', 03:22:08 INFO - 'TERM': 'linux', 03:22:08 INFO - 'TMOUT': '86400', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - '_': '/tools/buildbot/bin/python'} 03:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:22:08 INFO - Cleaning up... 03:22:08 INFO - Return code: 0 03:22:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:22:08 INFO - Using env: {'DISPLAY': ':0', 03:22:08 INFO - 'HOME': '/home/cltbld', 03:22:08 INFO - 'LANG': 'en_US.UTF-8', 03:22:08 INFO - 'LANGUAGE': 'en_US:en', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MAIL': '/var/mail/cltbld', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SHLVL': '1', 03:22:08 INFO - 'TERM': 'linux', 03:22:08 INFO - 'TMOUT': '86400', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - '_': '/tools/buildbot/bin/python'} 03:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:09 INFO - Downloading/unpacking psutil>=3.1.1 03:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:11 INFO - Installing collected packages: psutil 03:22:11 INFO - Running setup.py install for psutil 03:22:11 INFO - building 'psutil._psutil_linux' extension 03:22:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:22:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:22:11 INFO - building 'psutil._psutil_posix' extension 03:22:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:22:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:22:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:11 INFO - Successfully installed psutil 03:22:11 INFO - Cleaning up... 03:22:11 INFO - Return code: 0 03:22:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:11 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:22:11 INFO - Using env: {'DISPLAY': ':0', 03:22:11 INFO - 'HOME': '/home/cltbld', 03:22:11 INFO - 'LANG': 'en_US.UTF-8', 03:22:11 INFO - 'LANGUAGE': 'en_US:en', 03:22:11 INFO - 'LOGNAME': 'cltbld', 03:22:11 INFO - 'MAIL': '/var/mail/cltbld', 03:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:11 INFO - 'MOZ_NO_REMOTE': '1', 03:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:11 INFO - 'NO_EM_RESTART': '1', 03:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:11 INFO - 'PWD': '/builds/slave/test', 03:22:11 INFO - 'SHELL': '/bin/bash', 03:22:11 INFO - 'SHLVL': '1', 03:22:11 INFO - 'TERM': 'linux', 03:22:11 INFO - 'TMOUT': '86400', 03:22:11 INFO - 'USER': 'cltbld', 03:22:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:11 INFO - '_': '/tools/buildbot/bin/python'} 03:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:13 INFO - Installing collected packages: mozsystemmonitor 03:22:13 INFO - Running setup.py install for mozsystemmonitor 03:22:13 INFO - Successfully installed mozsystemmonitor 03:22:13 INFO - Cleaning up... 03:22:13 INFO - Return code: 0 03:22:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:14 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:22:14 INFO - Using env: {'DISPLAY': ':0', 03:22:14 INFO - 'HOME': '/home/cltbld', 03:22:14 INFO - 'LANG': 'en_US.UTF-8', 03:22:14 INFO - 'LANGUAGE': 'en_US:en', 03:22:14 INFO - 'LOGNAME': 'cltbld', 03:22:14 INFO - 'MAIL': '/var/mail/cltbld', 03:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:14 INFO - 'MOZ_NO_REMOTE': '1', 03:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:14 INFO - 'NO_EM_RESTART': '1', 03:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:14 INFO - 'PWD': '/builds/slave/test', 03:22:14 INFO - 'SHELL': '/bin/bash', 03:22:14 INFO - 'SHLVL': '1', 03:22:14 INFO - 'TERM': 'linux', 03:22:14 INFO - 'TMOUT': '86400', 03:22:14 INFO - 'USER': 'cltbld', 03:22:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:14 INFO - '_': '/tools/buildbot/bin/python'} 03:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:16 INFO - warning: no files found matching '*.txt' 03:22:16 INFO - no previously-included directories found matching 'build' 03:22:16 INFO - no previously-included directories found matching 'dist' 03:22:16 INFO - no previously-included directories found matching '.git*' 03:22:16 INFO - Installing collected packages: jsonschema, functools32 03:22:16 INFO - Running setup.py install for functools32 03:22:16 INFO - warning: no files found matching '*.txt' 03:22:16 INFO - no previously-included directories found matching 'build' 03:22:16 INFO - no previously-included directories found matching 'dist' 03:22:16 INFO - no previously-included directories found matching '.git*' 03:22:16 INFO - Successfully installed jsonschema functools32 03:22:16 INFO - Cleaning up... 03:22:16 INFO - Return code: 0 03:22:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:22:16 INFO - Using env: {'DISPLAY': ':0', 03:22:16 INFO - 'HOME': '/home/cltbld', 03:22:16 INFO - 'LANG': 'en_US.UTF-8', 03:22:16 INFO - 'LANGUAGE': 'en_US:en', 03:22:16 INFO - 'LOGNAME': 'cltbld', 03:22:16 INFO - 'MAIL': '/var/mail/cltbld', 03:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:16 INFO - 'MOZ_NO_REMOTE': '1', 03:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:16 INFO - 'NO_EM_RESTART': '1', 03:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:16 INFO - 'PWD': '/builds/slave/test', 03:22:16 INFO - 'SHELL': '/bin/bash', 03:22:16 INFO - 'SHLVL': '1', 03:22:16 INFO - 'TERM': 'linux', 03:22:16 INFO - 'TMOUT': '86400', 03:22:16 INFO - 'USER': 'cltbld', 03:22:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:16 INFO - '_': '/tools/buildbot/bin/python'} 03:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:22:16 INFO - Cleaning up... 03:22:16 INFO - Return code: 0 03:22:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:22:16 INFO - Using env: {'DISPLAY': ':0', 03:22:16 INFO - 'HOME': '/home/cltbld', 03:22:16 INFO - 'LANG': 'en_US.UTF-8', 03:22:16 INFO - 'LANGUAGE': 'en_US:en', 03:22:16 INFO - 'LOGNAME': 'cltbld', 03:22:16 INFO - 'MAIL': '/var/mail/cltbld', 03:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:16 INFO - 'MOZ_NO_REMOTE': '1', 03:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:16 INFO - 'NO_EM_RESTART': '1', 03:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:16 INFO - 'PWD': '/builds/slave/test', 03:22:16 INFO - 'SHELL': '/bin/bash', 03:22:16 INFO - 'SHLVL': '1', 03:22:16 INFO - 'TERM': 'linux', 03:22:16 INFO - 'TMOUT': '86400', 03:22:16 INFO - 'USER': 'cltbld', 03:22:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:16 INFO - '_': '/tools/buildbot/bin/python'} 03:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:19 INFO - Downloading docopt-0.6.1.tar.gz 03:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:19 INFO - Running setup.py install for blobuploader 03:22:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:19 INFO - Running setup.py install for requests 03:22:20 INFO - Running setup.py install for docopt 03:22:20 INFO - Successfully installed blobuploader requests docopt 03:22:20 INFO - Cleaning up... 03:22:20 INFO - Return code: 0 03:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:20 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:20 INFO - Using env: {'DISPLAY': ':0', 03:22:20 INFO - 'HOME': '/home/cltbld', 03:22:20 INFO - 'LANG': 'en_US.UTF-8', 03:22:20 INFO - 'LANGUAGE': 'en_US:en', 03:22:20 INFO - 'LOGNAME': 'cltbld', 03:22:20 INFO - 'MAIL': '/var/mail/cltbld', 03:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:20 INFO - 'MOZ_NO_REMOTE': '1', 03:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:20 INFO - 'NO_EM_RESTART': '1', 03:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:20 INFO - 'PWD': '/builds/slave/test', 03:22:20 INFO - 'SHELL': '/bin/bash', 03:22:20 INFO - 'SHLVL': '1', 03:22:20 INFO - 'TERM': 'linux', 03:22:20 INFO - 'TMOUT': '86400', 03:22:20 INFO - 'USER': 'cltbld', 03:22:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:20 INFO - '_': '/tools/buildbot/bin/python'} 03:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:20 INFO - Running setup.py (path:/tmp/pip-F4VPvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:20 INFO - Running setup.py (path:/tmp/pip-Mk3OOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:20 INFO - Running setup.py (path:/tmp/pip-uWNxnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:20 INFO - Running setup.py (path:/tmp/pip-bWnvan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:20 INFO - Running setup.py (path:/tmp/pip-ug8SlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:20 INFO - Running setup.py (path:/tmp/pip-0_G44k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:21 INFO - Running setup.py (path:/tmp/pip-5IWyC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:21 INFO - Running setup.py (path:/tmp/pip-q1sSR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:21 INFO - Running setup.py (path:/tmp/pip-dwRHq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:21 INFO - Running setup.py (path:/tmp/pip-_rWuR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:21 INFO - Running setup.py (path:/tmp/pip-eycAKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:21 INFO - Running setup.py (path:/tmp/pip-wO5bny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:21 INFO - Running setup.py (path:/tmp/pip-tU29sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:21 INFO - Running setup.py (path:/tmp/pip-tshOhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:21 INFO - Running setup.py (path:/tmp/pip-O79yiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:21 INFO - Running setup.py (path:/tmp/pip-AcOuvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:21 INFO - Running setup.py (path:/tmp/pip-t5V6dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:21 INFO - Running setup.py install for manifestparser 03:22:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Running setup.py install for mozcrash 03:22:22 INFO - Running setup.py install for mozdebug 03:22:22 INFO - Running setup.py install for mozdevice 03:22:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozfile 03:22:22 INFO - Running setup.py install for mozhttpd 03:22:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozinfo 03:22:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozInstall 03:22:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozleak 03:22:22 INFO - Running setup.py install for mozlog 03:22:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for moznetwork 03:22:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozprocess 03:22:23 INFO - Running setup.py install for mozprofile 03:22:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozrunner 03:22:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Running setup.py install for mozscreenshot 03:22:23 INFO - Running setup.py install for moztest 03:22:23 INFO - Running setup.py install for mozversion 03:22:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:23 INFO - Cleaning up... 03:22:23 INFO - Return code: 0 03:22:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:23 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:23 INFO - Using env: {'DISPLAY': ':0', 03:22:23 INFO - 'HOME': '/home/cltbld', 03:22:23 INFO - 'LANG': 'en_US.UTF-8', 03:22:23 INFO - 'LANGUAGE': 'en_US:en', 03:22:23 INFO - 'LOGNAME': 'cltbld', 03:22:23 INFO - 'MAIL': '/var/mail/cltbld', 03:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:23 INFO - 'MOZ_NO_REMOTE': '1', 03:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:23 INFO - 'NO_EM_RESTART': '1', 03:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:23 INFO - 'PWD': '/builds/slave/test', 03:22:23 INFO - 'SHELL': '/bin/bash', 03:22:23 INFO - 'SHLVL': '1', 03:22:23 INFO - 'TERM': 'linux', 03:22:23 INFO - 'TMOUT': '86400', 03:22:23 INFO - 'USER': 'cltbld', 03:22:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:23 INFO - '_': '/tools/buildbot/bin/python'} 03:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:23 INFO - Running setup.py (path:/tmp/pip-nNxKHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:23 INFO - Running setup.py (path:/tmp/pip-QRUswm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:23 INFO - Running setup.py (path:/tmp/pip-JMkAM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:24 INFO - Running setup.py (path:/tmp/pip-pNYNJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:24 INFO - Running setup.py (path:/tmp/pip-sFgmeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:24 INFO - Running setup.py (path:/tmp/pip-ps4LDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:24 INFO - Running setup.py (path:/tmp/pip-rQBfwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:24 INFO - Running setup.py (path:/tmp/pip-LSQ_cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:24 INFO - Running setup.py (path:/tmp/pip-8DPhns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:24 INFO - Running setup.py (path:/tmp/pip-IJMB1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:24 INFO - Running setup.py (path:/tmp/pip-VJRbbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:24 INFO - Running setup.py (path:/tmp/pip-dHUB1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:24 INFO - Running setup.py (path:/tmp/pip-IIx1aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:24 INFO - Running setup.py (path:/tmp/pip-elUTYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:24 INFO - Running setup.py (path:/tmp/pip-NzZwqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:24 INFO - Running setup.py (path:/tmp/pip-Owqr9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:25 INFO - Running setup.py (path:/tmp/pip-NXaKwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:22:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:27 INFO - Downloading blessings-1.6.tar.gz 03:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:27 INFO - Installing collected packages: blessings 03:22:27 INFO - Running setup.py install for blessings 03:22:27 INFO - Successfully installed blessings 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:27 INFO - Reading from file tmpfile_stdout 03:22:27 INFO - Current package versions: 03:22:27 INFO - argparse == 1.2.1 03:22:27 INFO - blessings == 1.6 03:22:27 INFO - blobuploader == 1.2.4 03:22:27 INFO - docopt == 0.6.1 03:22:27 INFO - functools32 == 3.2.3-2 03:22:27 INFO - jsonschema == 2.5.1 03:22:27 INFO - manifestparser == 1.1 03:22:27 INFO - mozInstall == 1.12 03:22:27 INFO - mozcrash == 0.17 03:22:27 INFO - mozdebug == 0.1 03:22:27 INFO - mozdevice == 0.48 03:22:27 INFO - mozfile == 1.2 03:22:27 INFO - mozhttpd == 0.7 03:22:27 INFO - mozinfo == 0.9 03:22:27 INFO - mozleak == 0.1 03:22:27 INFO - mozlog == 3.4 03:22:27 INFO - moznetwork == 0.27 03:22:27 INFO - mozprocess == 0.23 03:22:27 INFO - mozprofile == 0.28 03:22:27 INFO - mozrunner == 6.12 03:22:27 INFO - mozscreenshot == 0.1 03:22:27 INFO - mozsystemmonitor == 0.3 03:22:27 INFO - moztest == 0.7 03:22:27 INFO - mozversion == 1.4 03:22:27 INFO - psutil == 3.1.1 03:22:27 INFO - requests == 1.2.3 03:22:27 INFO - wsgiref == 0.1.2 03:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:22:27 INFO - Using env: {'DISPLAY': ':0', 03:22:27 INFO - 'HOME': '/home/cltbld', 03:22:27 INFO - 'LANG': 'en_US.UTF-8', 03:22:27 INFO - 'LANGUAGE': 'en_US:en', 03:22:27 INFO - 'LOGNAME': 'cltbld', 03:22:27 INFO - 'MAIL': '/var/mail/cltbld', 03:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:27 INFO - 'MOZ_NO_REMOTE': '1', 03:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:27 INFO - 'NO_EM_RESTART': '1', 03:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:27 INFO - 'PWD': '/builds/slave/test', 03:22:27 INFO - 'SHELL': '/bin/bash', 03:22:27 INFO - 'SHLVL': '1', 03:22:27 INFO - 'TERM': 'linux', 03:22:27 INFO - 'TMOUT': '86400', 03:22:27 INFO - 'USER': 'cltbld', 03:22:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:27 INFO - '_': '/tools/buildbot/bin/python'} 03:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 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 0x7f4eb9b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, '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': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:22:27 INFO - Using env: {'DISPLAY': ':0', 03:22:27 INFO - 'HOME': '/home/cltbld', 03:22:27 INFO - 'LANG': 'en_US.UTF-8', 03:22:27 INFO - 'LANGUAGE': 'en_US:en', 03:22:27 INFO - 'LOGNAME': 'cltbld', 03:22:27 INFO - 'MAIL': '/var/mail/cltbld', 03:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:27 INFO - 'MOZ_NO_REMOTE': '1', 03:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:27 INFO - 'NO_EM_RESTART': '1', 03:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:27 INFO - 'PWD': '/builds/slave/test', 03:22:27 INFO - 'SHELL': '/bin/bash', 03:22:27 INFO - 'SHLVL': '1', 03:22:27 INFO - 'TERM': 'linux', 03:22:27 INFO - 'TMOUT': '86400', 03:22:27 INFO - 'USER': 'cltbld', 03:22:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:27 INFO - '_': '/tools/buildbot/bin/python'} 03:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Running post-action listener: _resource_record_post_action 03:22:27 INFO - Running post-action listener: _start_resource_monitoring 03:22:27 INFO - Starting resource monitoring. 03:22:27 INFO - [mozharness: 2016-10-25 10:22:27.971209Z] Finished create-virtualenv step (success) 03:22:27 INFO - [mozharness: 2016-10-25 10:22:27.971669Z] Running install step. 03:22:27 INFO - Running pre-action listener: _resource_record_pre_action 03:22:27 INFO - Running main action method: install 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:28 INFO - Reading from file tmpfile_stdout 03:22:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:28 INFO - Reading from file tmpfile_stdout 03:22:28 INFO - Output received: 03:22:28 INFO - Usage: mozinstall [options] installer 03:22:28 INFO - Options: 03:22:28 INFO - -h, --help show this help message and exit 03:22:28 INFO - -d DEST, --destination=DEST 03:22:28 INFO - Directory to install application into. [default: 03:22:28 INFO - "/builds/slave/test"] 03:22:28 INFO - --app=APP Application being installed. [default: firefox] 03:22:28 INFO - mkdir: /builds/slave/test/build/application 03:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:22:44 INFO - Reading from file tmpfile_stdout 03:22:44 INFO - Output received: 03:22:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:22:44 INFO - Running post-action listener: _resource_record_post_action 03:22:44 INFO - [mozharness: 2016-10-25 10:22:44.291400Z] Finished install step (success) 03:22:44 INFO - [mozharness: 2016-10-25 10:22:44.291644Z] Running run-tests step. 03:22:44 INFO - Running pre-action listener: _resource_record_pre_action 03:22:44 INFO - Running main action method: run_tests 03:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:44 INFO - Python 2.7.3 03:22:44 INFO - Return code: 0 03:22:44 INFO - grabbing minidump binary from tooltool 03:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:44 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 0x2616f60>, '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 0x2617d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26181d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:22:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:22:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:22:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:44 INFO - Return code: 0 03:22:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:22:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:22:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:22:44 INFO - Using env: {'DISPLAY': ':0', 03:22:44 INFO - 'HOME': '/home/cltbld', 03:22:44 INFO - 'LANG': 'en_US.UTF-8', 03:22:44 INFO - 'LANGUAGE': 'en_US:en', 03:22:44 INFO - 'LOGNAME': 'cltbld', 03:22:44 INFO - 'MAIL': '/var/mail/cltbld', 03:22:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:44 INFO - 'MOZ_NO_REMOTE': '1', 03:22:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:44 INFO - 'NO_EM_RESTART': '1', 03:22:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:44 INFO - 'PWD': '/builds/slave/test', 03:22:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:44 INFO - 'SHELL': '/bin/bash', 03:22:44 INFO - 'SHLVL': '1', 03:22:44 INFO - 'TERM': 'linux', 03:22:44 INFO - 'TMOUT': '86400', 03:22:44 INFO - 'USER': 'cltbld', 03:22:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593', 03:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:44 INFO - '_': '/tools/buildbot/bin/python'} 03:22:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:22:44 INFO - mozversion application_buildid: 20161025013209 03:22:44 INFO - mozversion application_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 03:22:44 INFO - mozversion application_display_name: Nightly 03:22:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:44 INFO - mozversion application_name: Firefox 03:22:44 INFO - mozversion application_remotingname: firefox 03:22:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:22:44 INFO - mozversion application_vendor: Mozilla 03:22:44 INFO - mozversion application_version: 52.0a1 03:22:44 INFO - mozversion platform_buildid: 20161025013209 03:22:44 INFO - mozversion platform_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 03:22:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:22:44 INFO - mozversion platform_version: 52.0a1 03:22:44 INFO - using testdate: 1477390964 03:22:44 INFO - actual date: 1477390964 03:22:44 INFO - starting webserver on 'localhost:60327' 03:22:44 INFO - SUITE-START | Running 2 tests 03:22:44 INFO - TEST-START | dromaeo_css 03:22:44 INFO - operating with platform_type : linux_ 03:22:44 INFO - Initialising browser for dromaeo_css test... 03:22:44 INFO - TEST-INFO | started process 23809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX6ui18/profile http://localhost:60327/getInfo.html) 03:22:48 INFO - PROCESS | 23809 | __metrics Screen width/height:1600/1200 03:22:48 INFO - PROCESS | 23809 | colorDepth:24 03:22:48 INFO - PROCESS | 23809 | Browser inner width/height: 1024/697 03:22:48 INFO - PROCESS | 23809 | __metrics 03:22:49 INFO - PROCESS | 23809 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:22:49 INFO - PROCESS | 23809 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:22:50 INFO - PROCESS | 23809 | console.error: PushService: 03:22:50 INFO - PROCESS | 23809 | stateChangeProcessEnqueue: Error transitioning state 03:22:50 INFO - PROCESS | 23809 | UnknownError 03:22:51 INFO - TEST-INFO | 23809: exit 0 03:22:51 INFO - Browser initialized. 03:22:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:51 INFO - TEST-INFO | started process 23891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX6ui18/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:03 INFO - PROCESS | 23891 | RSS: Main: 173785088 03:23:03 INFO - PROCESS | 23891 | 03:23:55 INFO - PROCESS | 23891 | 1477391035169 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:26:09 INFO - PROCESS | 23891 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60327/tests/dromaeo/cssquery-ext.html) 03:26:10 INFO - PROCESS | 23891 | RSS: Main: 300539904 03:26:10 INFO - PROCESS | 23891 | 03:29:13 INFO - PROCESS | 23891 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-ext.html (next: http://localhost:60327/tests/dromaeo/cssquery-jquery.html) 03:29:14 INFO - PROCESS | 23891 | RSS: Main: 279195648 03:29:14 INFO - PROCESS | 23891 | 03:32:16 INFO - PROCESS | 23891 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60327/tests/dromaeo/cssquery-mootools.html) 03:32:16 INFO - PROCESS | 23891 | RSS: Main: 220069888 03:32:16 INFO - PROCESS | 23891 | 03:35:19 INFO - PROCESS | 23891 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60327/tests/dromaeo/cssquery-prototype.html) 03:35:19 INFO - PROCESS | 23891 | RSS: Main: 220897280 03:35:19 INFO - PROCESS | 23891 | 03:38:23 INFO - PROCESS | 23891 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60327/tests/dromaeo/cssquery-yui.html) 03:38:23 INFO - PROCESS | 23891 | RSS: Main: 220069888 03:38:23 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-yui.html (next: http://localhost:60327/tests/dromaeo/cssquery-dojo.html) 03:41:26 INFO - PROCESS | 23891 | RSS: Main: 307757056 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | __start_tp_report 03:41:26 INFO - PROCESS | 23891 | _x_x_mozilla_page_load 03:41:26 INFO - PROCESS | 23891 | _x_x_mozilla_page_load_details 03:41:26 INFO - PROCESS | 23891 | |i|pagename|runs| 03:41:26 INFO - PROCESS | 23891 | |0;dojo.html;2566.538023155832;2577.445849142434;2602.388438716902;2607.4915391498653;2618.3715908182044;4491.865244042684;4588;4639.164950308943;4656.627469802416;4665.860024199275;4554.089182163564;4559.8404055858055;4563.178627846986;4574.6569007324415;4590.127875703614;4195.706300558954;4223.155368926212;4231.61915427613;4252.787360631972;4304.117655880537;4225.429567008446;4230.788460576974;4239.660827133837;4328.718633288826;4330.870073897772;4308.116836048603;4334.869953901372;4335.241332766769;4364.650827933758;4431.689781715281;4371.934420983688;4375.649948004152;4384;4401.5598440156045;4410.536893626155;4090.529589097262;4113.444684967521;4196.790160491993;4287.399764033038;4295.312749960022;4584.885377865547;4606.101810147023;4609.469910960249;4620.9768951155365;4682.250839865639;4879.951200487985;4897.706137631718;4908.705477671351;4926.3595732554895;4976.328195693572;4821.590164835993;4866.197077482211;4873.415190177201;4923.163062279421;5001.89996200074;4632.004119114406;4677.532246775295;4690.202665546865;4694.835680751157;4752.691075080109;5133.666311689728;5136.075506408808;5136.897262054738;5142.357205349332;5192.221166825007;4737.644676649196;4922;4924.926126108111;4931.58081563064;4990.326305948723;4865.5864251538305;4925.950740492621;4977.253411988158;5027.572656324181;5039.899202015939;4974.403071631427;4977.402711674622;4984.725840078758;5032.446430892599;5039.042581909425;4937.1606826839525;4946.060248552763;4953.72754498506;4956.281339205795;5018.89962200754;4089.2230476209425;4097.7746223957965;4134.524529679065;4213.768242746678;4260.8508702195895;3699.4080947048883;3704.666580007812;3749.5687995880276;3752.887413377603;3763.6236376362695;4254.042840360894;4261.509926358446;4264.87205383839;4267.4025636410925;4291.356296555542;4830.686005409708;4893.266010098442;4999.625028122832;5016.623753218523;5086.059079070384;4210.705250632487;4226.197022565702;4230.175115852441;4230.492340919048;4232.36514522824;4420.359047938031;4460.732356058582;4463.977680111579;4465.397171381886;4466.3523789050405;4599.425071866017;4601.654875884322;4609.4699109602825;4609.93085103717;4610.746408947406;4954.30639710448;4955.132851750857;4955.529224723646;4959.752012399438;4962.454130045764;4588.609968152745;4609.147307748078;4609.953900460952;4610.907781844411;4611.239145540948;4843.2250839865455;4886.218205087169;4888.682235654671;4889.9022019560125;4918.065567542156;4948.727819969792;4992.350994370709;5018.84943451697;5022.849314520424;5029.673071250357;4844;4844.588210002189;4851.345068415719;4852.587530059985;4897.534734200245;4622.168009758276;4681.929771053369;4688.226442637063;4804.615630749462;4852.078105160008;4747.192977193954;4763.7141771493825;4769.689970151929;4785.928211076906;4827.975860120677;4836.903261934812;4872.707637541759;4875.561199492063;4884.633652476007;4920.8769780755765;4626.7455289958025;4677.228257337501;4757;4789.736564488987;4852.927206091982 03:41:26 INFO - PROCESS | 23891 | |1;ext.html;565.5390856451992;572.8653766364904;575.4418214332097;585.0405335250188;590.4449817171856;27724;39405.408918866204;40727.38908916365;40807;44168.3374749379;41147.38278925818;41556.58443415565;41598.79200603993;41609.37585936206;41615;7729.845403091949;7885.763427097197;7886.132525422199;7886.64510097047;7888.053433587948;7718;7810;7817.648205830751;7819.3744500439825;7819.765407037798;7846.921530784676;7885.763427097197;7892.60536973149;7895.341978184588;7896.210378962115;7786.805329866742;7838.608069596497;7841.411894107965;7844.294013538752;7846.215378462137;7752.3410510106705;7817.609119544;7822.804429889241;7828.725994590162;7837.6864925402915;39419.802900985596;39729.40405893914;39766.40350394746;39793.40309895354;39837.601623983675;2974.464596372652;2996.8351740654257;3062.0660698486954;3229.3056992746438;3615.1865830188262;28730.138095857157;28813.42373152525;29320.12039638814;30143.69856301453;30430;3494.2662040971427;3508.842102105386;3624.5469316335457;3676.356637588438;3753.680937120348;244011;244013;244491;244772;244775;50974;51233;53999;55783.442165578635;55787;52973;57069;57242.7137864308;57247.42752572504;57287.427125729046;13079.41142648583;13293.401796919163;13397.06220564551;13398.26309552984;13399.53101641438;9837.065478779505;10075.546600402999;10088.848667269996;10092.192624590016;10094.596216151273;18116.456506304832;18353.7246941296;18475.630487390175;18507.35224267171;18528.536786580444;6948.235694073648;7038.92961070393;7046.859062818818;7209.711611535585;7330.706771729071;771.3906014248681;849.2526576612541;909.3134683314188;910.0444533240071;970.7039352997263;26322.86838565795;28490.85754571255;28533.31468084271;28760.424791504054;29046.12861614155;768.8500742355187;923.0169869089533;930.2743859789375;938.3619138985418;1003.6851724241267;14391.78412323816;15084.472043478425;15135.697286054217;15209.467668631545;15325.693486130214;385160;387330;387735;388271;389779;50581.74709126431;50855.74572127116;50881.74559127181;51039.74480127576;51153.23270150951;1052.273930987616;1094.715374002765;1135.693362792025;1154.261272785418;1182.5742732616252;28214.71785282203;29474.263143421587;29925.55111673283;30185;30619.693803062575;42078.789606051774;42697.14605707806;42763.78618106889;42801.357979629705;42835.143297134506;291598;292761;293344;294291;294495;36669.44995825118;38388.81750963584;38402.807985959895;38443;38481.6151838478;41456.79271603622;41699.166016678886;41729.79135104305;42651.57348426476;42795.786021069696;34924;35263.294734105686;35661.82169089138;36048.27903441969;36598.45102323414;35460;35874.641253588175;35958.64041359553;36015.81992090023;36095.45856812203;35246.71299305022;35628.64371356253;35840.82079589585;36140.63859361373;36398.636013640586;30079.398412032075;32690.346193076482;32743.836280818443;32830;33241.50137747984;24718.382040449134;24966.251012469656;25214.24357269285;25245.242642720747;25623.6156457657 03:41:26 INFO - PROCESS | 23891 | |2;jquery.html;339.73956620936326;356.54362416107375;358.7954865726537;366.8330909436206;380.70875780028285;12798.936005319973;13398.062135650496;13700.451981920736;16767.413140540084;16774.41289554866;14341.498047568337;14447.133172009686;14587.416503339853;14739.263036848168;14934.850651493482;4821.831235906744;5068.3917929848285;5075.974620126913;5077.84766457005;5086.567641750456;3698.315811574854;3912.0219945013746;5733.684647344395;5954.761809527614;5995.550333724967;5781;6052.969735151318;6065.969670151665;6066.787662431816;6067.757289708428;5879.67661778602;5918.4969277611235;5965.135055416984;5993.520518358564;6009.308929473123;5063;5207.739613019372;5218.511544941044;5259.211118332242;5266.657667251617;20438.59122817535;20461;20484.79515204844;20605;20635;2017.6973453981873;2021.2622392826659;2091.518950641361;2103.9368818935454;2314.409825494505;12450.750984980341;12569.937150314281;12931;13146;13171.868281317256;1705.7100292950229;1710.144927536232;1712.546175263556;1758.2439550993067;1814.3286983816072;69850;69872.3012769876;70553;71367;71429.64285178541;9027.548622568846;9114.36199466031;9289.16397524226;9295.628174873065;9554.952225238829;12967.935160324138;12971.740565188833;12980.935095324463;12981.350932453339;12989;6108.908366374508;6268.811935641938;6357.237131544244;6437.259715132726;6468.611883287018;5713.428657134336;5790.189373487715;5799.82600521985;5836.358000619928;6035.939640603538;5771.711414429262;5855.2973643163095;5940.970295148497;5955.40445955401;6116.3883611638485;1688.383739934915;1708.2739835569832;1714.9742753858702;1758.2263803926232;1774.1750086209975;675.3449154320301;817.6647574494428;877.609463788608;886.8182022685334;946.4936259101348;16071.598210044609;16395.672086558203;16608.418705345255;16835.663286734198;17408.39070632547;871.9564021798884;886.4636894678627;898.793277546168;931.1573026411108;933.8272419602396;8969.461832290084;9050.86423703645;10181.74545636365;10187.337823041478;10257.28199026061;389679;390183;392640;399452;399896;79162.6041869787;80273.19726802774;81836;81838;82003.58998204971;909.7134402663007;912.748994026648;939.5818860607101;946.5409276500892;946.7207173883721;15125.243737812845;15129.546113616609;15554.433518469326;15570;15819.288132033857;36746.63253367432;38124.61875381211;38211.61788382192;38353;39251.607483924796;49176;49265.26102108543;51660.22509662433;52276.73861630668;52586.2112068327;7290.671919763729;7329.377002954595;7373.963130184315;7481.214472480311;7553.093628764584;8462.11147829469;11592.420378981185;11757.413369058793;11941.462634181657;12125.81811272814;9780.364276322302;10160.136388407069;10218;10236.692899212738;10688.625898093529;9590.328676992543;9939;10219.284650074424;10332.225083118647;10396.896031039592;10272.486375681037;10309.948450257702;10412.635557755746;10456.529456174643;10735.409552474688;7358.779236622696;7389.593572353358;7588.658510366937;7658.578778167254;7782.727604533814;10127.139193168663;10255.282130250811;10257.435841028517;10262.897371026194;10461.163106951273 03:41:26 INFO - PROCESS | 23891 | |3;mootools.html;1341.745068436997;1386.88904887609;1434.82782066152;1642.9813515620317;1654.420952666566;6346.6826658667;6612.107365505655;6804.387605115545;7434.888476672854;7445.143808462029;6770.289119642441;7000.229974702778;7009.964950175255;7212.593544258872;7222.747203847866;2081.833453323738;2125.851190416664;2130.5738852229615;2130.946726331839;2140.218820130649;1811.139708638393;1872.1855992643175;2041.8672786268844;2092.3095378525127;2149.0866381787755;2040.479677682189;2101.3170719516143;2102.9158833646634;2109.0930899713117;2119.4913220826966;2101.989490052555;2129.0951345678104;2135.914563417454;2148.2695883399565;2155.288754710957;2064.814166725002;2086.95826083479;2088.3108574170637;2094.371688493446;2102.6740855167473;7391.926080739177;7406.333429991327;7465.328120469184;7476.962615186943;7477.5887326197035;4213.9578604213875;4359.80380882861;4378.781060946972;4394.099209662044;4411.404460397869;2871.4687782760047;2877.8992735254374;2958.467475854345;2958.6893376195403;2959.2010157257637;931.6459745296744;932.1843387036344;963.8939716631235;965.7826988927505;973.109604711695;9517.428954262767;9628.90371096294;9629.855552166724;9630.374025688378;9644.517774111337;3690.833912473945;3818.885433437001;3848.634379733977;3873.5545412277947;3876.8061596920043;7718.189590092959;7732.7680169595005;7746.651400686983;7775.416843736629;7801.531908085533;4255.148970205972;4263.147370525907;4266.338717498793;4266.488021437447;4271.978640106841;3845.134844659929;3911.5892831252877;3954.6440820326306;4004.899877503086;4052.756834589934;3022.2621992354484;3086.105029541453;3133.2166958260436;3225.6774322567558;3241.2545114623767;880.295763389286;905.456725964416;930.237205491504;975.8487434447673;985.261054209343;772.8377040821377;780.3873958942316;814.3770015937812;824.7360844529812;871.4684042733927;4846.176150054499;4968.527989841032;5006.349174607278;5158.664686795421;5262.71055091966;415.1883068600878;420.05697209764276;420.52270672785994;428.21636405378706;599.8106909779341;3395.7453191010773;3426.777259478126;3538;3547.3260080584605;3619.8914032579064;8515.361347898808;8729.60716767747;8874.156955089256;8876.689315873913;8889.155530224618;8819.955900220586;8871.245944094824;8874.378793484395;8881.42270752412;8895.332850036144;6714.29499902513;6822.147231596051;6824.6928888200155;6834.316568343126;6840.144981877265;4910.21436570147;4958.45456999737;4976.527229913152;5048.242763585345;5110.540051395392;8021.2379823916635;8096.271335579826;8116.634751436081;8127.959360203161;8198.508089514648;8144.633491492778;8150.225728555778;8170.714025009096;8217.630206640595;8245.546494942835;5805.564582656402;5855.531557475477;5856.765729370777;5861.589688721919;5862.149988251595;6429.517786165963;6445.452136568444;6581.111549940888;6602.60384376939;6633.071370008106;4809.855704328876;5834.970825146017;5912.113183022581;5983.910241346296;6085.66528840918;5875.794347197828;5896.498797602252;5911.408859114054;5915.201447804663;5985.461308482258;5853.2976042875125;5889.087191485327;5965.403459654;6027.969860150672;6031.69841507914;4322.2220000398975;4342.41377414045;4461.732296062247;4469.530699276529;4477.462704475353;4380.167768124046;4427.9114417710825;4451.6661250407;4478.305862591304;4545.568171023748 03:41:26 INFO - PROCESS | 23891 | |4;prototype.html;292.38015407336445;298.9506731389321;301.030681206515;303.8951561711209;306.68871095837727;4859.465458799529;4885.560299573038;4901.460839307673;4902.852914412564;4919.532644398781;4802.399700037496;4806.927896081553;4847.515248475151;4860.538248866361;4868.221084626452;3528.629493903142;3643.9453408198897;3647.963520364789;3767.5290588676417;3810.5427348718194;3804.5054142961376;3816.1378965775666;3818.694504439652;3823.3118038753014;3848.7690738555634;3770.868019619314;3805.2579746949355;3809.1619843634357;3811.7141214408894;3816.6755825754703;3571.4107172316535;3675.2649470105953;3680.245549662313;3751.4747935289083;3774.339490589136;3327.93344133116;3334.683205095512;3342.415077361452;3349.246419555605;3352.094934367707;4694.694844835109;4715.528447155291;4719.5752382285755;4744.4069491313585;4764.737939413331;4258.105143211273;4308.67684923632;4335.804888780012;4351.608355248043;4378.5183629800695;5008.5993120550265;5027.522385373383;5030.01314480778;5038.622103342264;5068.949310506885;3686.705063594906;3700.1489657378684;3702;3710.239400922804;3719.3119272934596;5132.615053870974;5287.9735601321745;5316.654417462892;5344.893102137936;5349.5720342372515;3745.8534830742306;3752.2307926874923;3762.736608437438;3764.642358975893;3786.4888240087785;3803.448499967489;3824.7896365700153;3827.1771569112775;3837.501124853751;3851.171998020439;4317.892052698708;4326.63223625989;4341.218580655513;4346.174226896879;4347;4875.561199492063;5003.2995380646735;5024.974875125674;5036.924446133311;5103.132467480537;1309.3387839141174;1316.861729518406;1322.7817410127413;1324.4172564071778;1328.920264784116;798.7643645124703;825.0800357601352;832.3632421197789;837.351052933981;843.8692002739585;4296.76367799774;4346.282863327516;4492.742032230981;4499.167653984024;4501.842435514807;5268.894622107613;5286.867828304323;5291.470852914677;5291.735413229323;5293.364796224478;4504.076664283814;4507.526709695435;4511.684182107287;4520.796564154621;4525.298578720303;2659.3750468639855;2786.651668541432;2791.6091747155415;2799.790015748827;2812.915612531627;4859.635527335464;4863.927041094386;4865.683730557503;4871.685949174114;4874.122657921537;5277.683338999673;5319.202119682079;5362.329708786402;5389.652586853286;5421.837344879581;4818.662948469989;4822.662413631012;4839.322494850724;4863.489333619989;4866.124097662455;5225.7387130642555;5225.869353266199;5229.947700522946;5263.736813159403;5286.20706893969;4886.411916127202;5130.843502280184;5150.304708864255;5169.922451163311;5171.095058364846;4895.534924182197;4909.607231421549;4912.48418916023;4914.459409465027;4915.927545284198;3699.6300369962787;3725.2363265531044;3747.943780843344;3751.662350388478;3751.7748935063983;5132.5124113209185;5297.867553311198;5320.414754377093;5328.60035497347;5355.491228333302;5085.618578606545;5102.158143906214;5104.2343648453025;5122.615803814803;5145.61407894402;5059.620528460307;5086.186210206497;5099.311592935054;5109.412417572027;5149.871253218699;4717.339572459789;4938.506149385176;5034.899302013866;5035.773390197377;5066.949330506648;4798.328234047306;4966.652334336562;5021.748912554284;5100.5409513143995;5122.257272695513;4992.053099291206;5031.698098114125;5038.823641172541;5057.418396884258;5074.112030394593 03:41:26 INFO - PROCESS | 23891 | |5;yui.html;648.3322178156501;652.386756448938;668.318315318375;719.6941299947521;730.0399974034144;12207.633770986873;13377;13380.799288010663;13406.396712147953;13408.731825363499;12945.482180712761;13001;13006.284654344006;13012.479500819956;13027.478900843978;623.6538721009838;630.9242890853104;752.5860776572877;768.3737753730719;786.4180506425233;779.7348901373532;804.2922228438965;804.3243675312737;804.388664614891;804.8832919226738;848.1349023995521;850.107387243395;850.8298340331959;851.6040041380757;851.7146755836802;639.1371648274838;653.3042309939899;815.8245977114949;840.6805413942724;841.18405147007;609.2840911928511;609.3084349263573;609.8109586028345;610.1244713835616;611.3122736920964;12512.436940337706;12577.11960162789;12581;12583.748325033539;12586.68533286666;11866.626674665102;12057.819132713017;12256.325902075383;12327.506899724;12613.558525451657;11174.497147628375;11179.944100279447;11299.774004519946;11312.717182070432;11553;3142.120206342228;3193.552902593639;3247.7077063064203;3265.885694000722;3902.3951287550476;48139.75930120362;49238.50761492411;49748;49933;51092.489075109144;9200.21798147165;9675.854862177073;9732.951335243279;9821.754456138653;9863.421852503565;16503.83496165047;16559.503214903332;16593;16648.25082871274;16746.49760507187;6488.740450381932;6494.350564943468;6550.377714117151;6577.572457790228;6638.17022872141;3622.3841946869097;3646.6353364663323;3659.1766852457986;3681.631836816297;3725.1245957200035;2874.870630821618;2963.701138543544;2984.701529846998;2989.8505074746613;3015.7587393008507;516.5686651645917;521.7652056574557;521.930043411006;524.8294304351101;531.1952392125933;499.0119563264756;526.1240035341191;527.7070978089765;573.2662192393743;582.7005777117053;7828.725994590162;8120.3503719702285;8180.509169449733;8240;8259.21537453941;576.6568891509545;604.3835288006209;625.74344518748;636.1285039495921;644.9258335291502;3721.627837216257;3782.4893639358334;3820.67524260441;3906.4921560196995;3936.291467535871;72439.63780181065;72703.2729672707;73257.63371183217;74909;75958.62020689972;50633;53899.73050134724;57349;59087.704561477774;64974;52345.7382713084;53691.463085369425;54063.45936540663;54133.188002179995;55439.72280138574;7421.220771818881;7810.804729881798;7870;7883.369330453665;8202.267968074631;25876.223713288633;27061;27177.59233611537;31313.8434307827;34272.82863585666;29834.701652983193;50012;50056.49943500664;50303.245451317525;50997.23504147515;9790.706278811647;9794.35135859053;9845.950770246103;10065.496725163859;10151.543180556744;10963.397013164353;11201.159913006393;11216.327020378803;11220.102391808472;11807.23252988553;11495.655130346104;11673.591424300108;12120.939395302967;12158.209716368408;12279.69300767488;11024.889751102386;11237.831432528683;11556;11817.586384476503;12335.876641233832;11113;11655.941720291345;11895.345755983504;11897.643070707893;11912.34482103458;9411.905880941104;9657.22742180638;9790.804183916423;9859.654912078044;9938.10557049869;8603.881495405558;9511.334206605748;9758.707238782848;9875.654352097643;10395.58417663285 03:41:26 INFO - PROCESS | 23891 | __end_tp_report 03:41:26 INFO - PROCESS | 23891 | __start_cc_report 03:41:26 INFO - PROCESS | 23891 | _x_x_mozilla_cycle_collect,1157 03:41:26 INFO - PROCESS | 23891 | __end_cc_report 03:41:26 INFO - PROCESS | 23891 | __startTimestamp1477392086976__endTimestamp 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | ------- Summary: start ------- 03:41:26 INFO - PROCESS | 23891 | Number of tests: 6 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | [#0] dojo.html Cycles:165 Average:4581.24 Median:4677.23 stddev:479.29 (10.2%) stddev-sans-first:453.95 03:41:26 INFO - PROCESS | 23891 | Values: 2566.5 2577.4 2602.4 2607.5 2618.4 4491.9 4588.0 4639.2 4656.6 4665.9 4554.1 4559.8 4563.2 4574.7 4590.1 4195.7 4223.2 4231.6 4252.8 4304.1 4225.4 4230.8 4239.7 4328.7 4330.9 4308.1 4334.9 4335.2 4364.7 4431.7 4371.9 4375.6 4384.0 4401.6 4410.5 4090.5 4113.4 4196.8 4287.4 4295.3 4584.9 4606.1 4609.5 4621.0 4682.3 4880.0 4897.7 4908.7 4926.4 4976.3 4821.6 4866.2 4873.4 4923.2 5001.9 4632.0 4677.5 4690.2 4694.8 4752.7 5133.7 5136.1 5136.9 5142.4 5192.2 4737.6 4922.0 4924.9 4931.6 4990.3 4865.6 4926.0 4977.3 5027.6 5039.9 4974.4 4977.4 4984.7 5032.4 5039.0 4937.2 4946.1 4953.7 4956.3 5018.9 4089.2 4097.8 4134.5 4213.8 4260.9 3699.4 3704.7 3749.6 3752.9 3763.6 4254.0 4261.5 4264.9 4267.4 4291.4 4830.7 4893.3 4999.6 5016.6 5086.1 4210.7 4226.2 4230.2 4230.5 4232.4 4420.4 4460.7 4464.0 4465.4 4466.4 4599.4 4601.7 4609.5 4609.9 4610.7 4954.3 4955.1 4955.5 4959.8 4962.5 4588.6 4609.1 4610.0 4610.9 4611.2 4843.2 4886.2 4888.7 4889.9 4918.1 4948.7 4992.4 5018.8 5022.8 5029.7 4844.0 4844.6 4851.3 4852.6 4897.5 4622.2 4681.9 4688.2 4804.6 4852.1 4747.2 4763.7 4769.7 4785.9 4828.0 4836.9 4872.7 4875.6 4884.6 4920.9 4626.7 4677.2 4757.0 4789.7 4852.9 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | [#1] ext.html Cycles:180 Average:47066.82 Median:211820.81 stddev:82572.72 (39.0%) stddev-sans-first:82730.54 03:41:26 INFO - PROCESS | 23891 | Values: 565.5 572.9 575.4 585.0 590.4 27724.0 39405.4 40727.4 40807.0 44168.3 41147.4 41556.6 41598.8 41609.4 41615.0 7729.8 7885.8 7886.1 7886.6 7888.1 7718.0 7810.0 7817.6 7819.4 7819.8 7846.9 7885.8 7892.6 7895.3 7896.2 7786.8 7838.6 7841.4 7844.3 7846.2 7752.3 7817.6 7822.8 7828.7 7837.7 39419.8 39729.4 39766.4 39793.4 39837.6 2974.5 2996.8 3062.1 3229.3 3615.2 28730.1 28813.4 29320.1 30143.7 30430.0 3494.3 3508.8 3624.5 3676.4 3753.7 244011.0 244013.0 244491.0 244772.0 244775.0 50974.0 51233.0 53999.0 55783.4 55787.0 52973.0 57069.0 57242.7 57247.4 57287.4 13079.4 13293.4 13397.1 13398.3 13399.5 9837.1 10075.5 10088.8 10092.2 10094.6 18116.5 18353.7 18475.6 18507.4 18528.5 6948.2 7038.9 7046.9 7209.7 7330.7 771.4 849.3 909.3 910.0 970.7 26322.9 28490.9 28533.3 28760.4 29046.1 768.9 923.0 930.3 938.4 1003.7 14391.8 15084.5 15135.7 15209.5 15325.7 385160.0 387330.0 387735.0 388271.0 389779.0 50581.7 50855.7 50881.7 51039.7 51153.2 1052.3 1094.7 1135.7 1154.3 1182.6 28214.7 29474.3 29925.6 30185.0 30619.7 42078.8 42697.1 42763.8 42801.4 42835.1 291598.0 292761.0 293344.0 294291.0 294495.0 36669.4 38388.8 38402.8 38443.0 38481.6 41456.8 41699.2 41729.8 42651.6 42795.8 34924.0 35263.3 35661.8 36048.3 36598.5 35460.0 35874.6 35958.6 36015.8 36095.5 35246.7 35628.6 35840.8 36140.6 36398.6 30079.4 32690.3 32743.8 32830.0 33241.5 24718.4 24966.3 25214.2 25245.2 25623.6 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | [#2] jquery.html Cycles:180 Average:24527.67 Median:202358.92 stddev:65227.76 (32.2%) stddev-sans-first:65385.46 03:41:26 INFO - PROCESS | 23891 | Values: 339.7 356.5 358.8 366.8 380.7 12798.9 13398.1 13700.5 16767.4 16774.4 14341.5 14447.1 14587.4 14739.3 14934.9 4821.8 5068.4 5076.0 5077.8 5086.6 3698.3 3912.0 5733.7 5954.8 5995.6 5781.0 6053.0 6066.0 6066.8 6067.8 5879.7 5918.5 5965.1 5993.5 6009.3 5063.0 5207.7 5218.5 5259.2 5266.7 20438.6 20461.0 20484.8 20605.0 20635.0 2017.7 2021.3 2091.5 2103.9 2314.4 12450.8 12569.9 12931.0 13146.0 13171.9 1705.7 1710.1 1712.5 1758.2 1814.3 69850.0 69872.3 70553.0 71367.0 71429.6 9027.5 9114.4 9289.2 9295.6 9555.0 12967.9 12971.7 12980.9 12981.4 12989.0 6108.9 6268.8 6357.2 6437.3 6468.6 5713.4 5790.2 5799.8 5836.4 6035.9 5771.7 5855.3 5941.0 5955.4 6116.4 1688.4 1708.3 1715.0 1758.2 1774.2 675.3 817.7 877.6 886.8 946.5 16071.6 16395.7 16608.4 16835.7 17408.4 872.0 886.5 898.8 931.2 933.8 8969.5 9050.9 10181.7 10187.3 10257.3 389679.0 390183.0 392640.0 399452.0 399896.0 79162.6 80273.2 81836.0 81838.0 82003.6 909.7 912.7 939.6 946.5 946.7 15125.2 15129.5 15554.4 15570.0 15819.3 36746.6 38124.6 38211.6 38353.0 39251.6 49176.0 49265.3 51660.2 52276.7 52586.2 7290.7 7329.4 7374.0 7481.2 7553.1 8462.1 11592.4 11757.4 11941.5 12125.8 9780.4 10160.1 10218.0 10236.7 10688.6 9590.3 9939.0 10219.3 10332.2 10396.9 10272.5 10309.9 10412.6 10456.5 10735.4 7358.8 7389.6 7588.7 7658.6 7782.7 10127.1 10255.3 10257.4 10262.9 10461.2 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | [#3] mootools.html Cycles:180 Average:4707.78 Median:5820.27 stddev:2577.48 (44.3%) stddev-sans-first:2572.30 03:41:26 INFO - PROCESS | 23891 | Values: 1341.7 1386.9 1434.8 1643.0 1654.4 6346.7 6612.1 6804.4 7434.9 7445.1 6770.3 7000.2 7010.0 7212.6 7222.7 2081.8 2125.9 2130.6 2130.9 2140.2 1811.1 1872.2 2041.9 2092.3 2149.1 2040.5 2101.3 2102.9 2109.1 2119.5 2102.0 2129.1 2135.9 2148.3 2155.3 2064.8 2087.0 2088.3 2094.4 2102.7 7391.9 7406.3 7465.3 7477.0 7477.6 4214.0 4359.8 4378.8 4394.1 4411.4 2871.5 2877.9 2958.5 2958.7 2959.2 931.6 932.2 963.9 965.8 973.1 9517.4 9628.9 9629.9 9630.4 9644.5 3690.8 3818.9 3848.6 3873.6 3876.8 7718.2 7732.8 7746.7 7775.4 7801.5 4255.1 4263.1 4266.3 4266.5 4272.0 3845.1 3911.6 3954.6 4004.9 4052.8 3022.3 3086.1 3133.2 3225.7 3241.3 880.3 905.5 930.2 975.8 985.3 772.8 780.4 814.4 824.7 871.5 4846.2 4968.5 5006.3 5158.7 5262.7 415.2 420.1 420.5 428.2 599.8 3395.7 3426.8 3538.0 3547.3 3619.9 8515.4 8729.6 8874.2 8876.7 8889.2 8820.0 8871.2 8874.4 8881.4 8895.3 6714.3 6822.1 6824.7 6834.3 6840.1 4910.2 4958.5 4976.5 5048.2 5110.5 8021.2 8096.3 8116.6 8128.0 8198.5 8144.6 8150.2 8170.7 8217.6 8245.5 5805.6 5855.5 5856.8 5861.6 5862.1 6429.5 6445.5 6581.1 6602.6 6633.1 4809.9 5835.0 5912.1 5983.9 6085.7 5875.8 5896.5 5911.4 5915.2 5985.5 5853.3 5889.1 5965.4 6028.0 6031.7 4322.2 4342.4 4461.7 4469.5 4477.5 4380.2 4427.9 4451.7 4478.3 4545.6 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | [#4] prototype.html Cycles:180 Average:4224.56 Median:4830.99 stddev:1225.44 (25.4%) stddev-sans-first:1192.81 03:41:26 INFO - PROCESS | 23891 | Values: 292.4 299.0 301.0 303.9 306.7 4859.5 4885.6 4901.5 4902.9 4919.5 4802.4 4806.9 4847.5 4860.5 4868.2 3528.6 3643.9 3648.0 3767.5 3810.5 3804.5 3816.1 3818.7 3823.3 3848.8 3770.9 3805.3 3809.2 3811.7 3816.7 3571.4 3675.3 3680.2 3751.5 3774.3 3327.9 3334.7 3342.4 3349.2 3352.1 4694.7 4715.5 4719.6 4744.4 4764.7 4258.1 4308.7 4335.8 4351.6 4378.5 5008.6 5027.5 5030.0 5038.6 5068.9 3686.7 3700.1 3702.0 3710.2 3719.3 5132.6 5288.0 5316.7 5344.9 5349.6 3745.9 3752.2 3762.7 3764.6 3786.5 3803.4 3824.8 3827.2 3837.5 3851.2 4317.9 4326.6 4341.2 4346.2 4347.0 4875.6 5003.3 5025.0 5036.9 5103.1 1309.3 1316.9 1322.8 1324.4 1328.9 798.8 825.1 832.4 837.4 843.9 4296.8 4346.3 4492.7 4499.2 4501.8 5268.9 5286.9 5291.5 5291.7 5293.4 4504.1 4507.5 4511.7 4520.8 4525.3 2659.4 2786.7 2791.6 2799.8 2812.9 4859.6 4863.9 4865.7 4871.7 4874.1 5277.7 5319.2 5362.3 5389.7 5421.8 4818.7 4822.7 4839.3 4863.5 4866.1 5225.7 5225.9 5229.9 5263.7 5286.2 4886.4 5130.8 5150.3 5169.9 5171.1 4895.5 4909.6 4912.5 4914.5 4915.9 3699.6 3725.2 3747.9 3751.7 3751.8 5132.5 5297.9 5320.4 5328.6 5355.5 5085.6 5102.2 5104.2 5122.6 5145.6 5059.6 5086.2 5099.3 5109.4 5149.9 4717.3 4938.5 5034.9 5035.8 5066.9 4798.3 4966.7 5021.7 5100.5 5122.3 4992.1 5031.7 5038.8 5057.4 5074.1 03:41:26 INFO - PROCESS | 23891 | 03:41:26 INFO - PROCESS | 23891 | [#5] yui.html Cycles:180 Average:14353.94 Median:519.17 stddev:18285.19 (3522.0%) stddev-sans-first:18307.52 03:41:26 INFO - PROCESS | 23891 | Values: 648.3 652.4 668.3 719.7 730.0 12207.6 13377.0 13380.8 13406.4 13408.7 12945.5 13001.0 13006.3 13012.5 13027.5 623.7 630.9 752.6 768.4 786.4 779.7 804.3 804.3 804.4 804.9 848.1 850.1 850.8 851.6 851.7 639.1 653.3 815.8 840.7 841.2 609.3 609.3 609.8 610.1 611.3 12512.4 12577.1 12581.0 12583.7 12586.7 11866.6 12057.8 12256.3 12327.5 12613.6 11174.5 11179.9 11299.8 11312.7 11553.0 3142.1 3193.6 3247.7 3265.9 3902.4 48139.8 49238.5 49748.0 49933.0 51092.5 9200.2 9675.9 9733.0 9821.8 9863.4 16503.8 16559.5 16593.0 16648.3 16746.5 6488.7 6494.4 6550.4 6577.6 6638.2 3622.4 3646.6 3659.2 3681.6 3725.1 2874.9 2963.7 2984.7 2989.9 3015.8 516.6 521.8 521.9 524.8 531.2 499.0 526.1 527.7 573.3 582.7 7828.7 8120.4 8180.5 8240.0 8259.2 576.7 604.4 625.7 636.1 644.9 3721.6 3782.5 3820.7 3906.5 3936.3 72439.6 72703.3 73257.6 74909.0 75958.6 50633.0 53899.7 57349.0 59087.7 64974.0 52345.7 53691.5 54063.5 54133.2 55439.7 7421.2 7810.8 7870.0 7883.4 8202.3 25876.2 27061.0 27177.6 31313.8 34272.8 29834.7 50012.0 50056.5 50303.2 50997.2 9790.7 9794.4 9846.0 10065.5 10151.5 10963.4 11201.2 11216.3 11220.1 11807.2 11495.7 11673.6 12120.9 12158.2 12279.7 11024.9 11237.8 11556.0 11817.6 12335.9 11113.0 11655.9 11895.3 11897.6 11912.3 9411.9 9657.2 9790.8 9859.7 9938.1 8603.9 9511.3 9758.7 9875.7 10395.6 03:41:26 INFO - PROCESS | 23891 | -------- Summary: end -------- 03:41:26 INFO - PROCESS | 23891 | 03:41:27 INFO - TEST-INFO | 23891: exit 0 03:41:27 INFO - TEST-OK | dromaeo_css | took 1123432ms 03:41:27 INFO - TEST-START | kraken 03:41:27 INFO - operating with platform_type : linux_ 03:41:27 INFO - Initialising browser for kraken test... 03:41:28 INFO - TEST-INFO | started process 24193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOpUTDe/profile http://localhost:60327/getInfo.html) 03:41:32 INFO - PROCESS | 24193 | __metrics Screen width/height:1600/1200 03:41:32 INFO - PROCESS | 24193 | colorDepth:24 03:41:32 INFO - PROCESS | 24193 | Browser inner width/height: 1024/697 03:41:32 INFO - PROCESS | 24193 | __metrics 03:41:33 INFO - PROCESS | 24193 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:41:33 INFO - PROCESS | 24193 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:33 INFO - PROCESS | 24193 | console.error: PushService: 03:41:33 INFO - PROCESS | 24193 | stateChangeProcessEnqueue: Error transitioning state 03:41:33 INFO - PROCESS | 24193 | UnknownError 03:41:34 INFO - TEST-INFO | 24193: exit 0 03:41:34 INFO - Browser initialized. 03:41:34 INFO - Running cycle 1/1 for kraken test... 03:41:34 INFO - TEST-INFO | started process 24276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOpUTDe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:46 INFO - PROCESS | 24276 | RSS: Main: 173686784 03:41:46 INFO - PROCESS | 24276 | 03:41:49 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:50 INFO - PROCESS | 24276 | RSS: Main: 228999168 03:41:50 INFO - PROCESS | 24276 | 03:41:53 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-dft) 03:41:53 INFO - PROCESS | 24276 | RSS: Main: 216154112 03:41:53 INFO - PROCESS | 24276 | 03:41:57 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-fft) 03:41:57 INFO - PROCESS | 24276 | RSS: Main: 298184704 03:41:57 INFO - PROCESS | 24276 | 03:41:59 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-oscillator) 03:42:00 INFO - PROCESS | 24276 | RSS: Main: 209838080 03:42:00 INFO - PROCESS | 24276 | 03:42:02 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:03 INFO - PROCESS | 24276 | RSS: Main: 212271104 03:42:03 INFO - PROCESS | 24276 | 03:42:06 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60327/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:07 INFO - PROCESS | 24276 | RSS: Main: 248320000 03:42:07 INFO - PROCESS | 24276 | 03:42:10 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60327/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:11 INFO - PROCESS | 24276 | RSS: Main: 248434688 03:42:11 INFO - PROCESS | 24276 | 03:42:14 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60327/tests/kraken/driver.html?testName=json-parse-financial) 03:42:14 INFO - PROCESS | 24276 | RSS: Main: 247537664 03:42:14 INFO - PROCESS | 24276 | 03:42:16 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:16 INFO - PROCESS | 24276 | RSS: Main: 209907712 03:42:16 INFO - PROCESS | 24276 | 03:42:18 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:19 INFO - PROCESS | 24276 | RSS: Main: 216539136 03:42:19 INFO - PROCESS | 24276 | 03:42:21 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:22 INFO - PROCESS | 24276 | RSS: Main: 226017280 03:42:22 INFO - PROCESS | 24276 | 03:42:25 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:25 INFO - PROCESS | 24276 | RSS: Main: 234237952 03:42:25 INFO - PROCESS | 24276 | 03:42:28 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:29 INFO - PROCESS | 24276 | RSS: Main: 231432192 03:42:29 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60327/tests/kraken/driver.html?testName=ai-astar) 03:42:31 INFO - PROCESS | 24276 | RSS: Main: 282284032 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | __start_tp_report 03:42:31 INFO - PROCESS | 24276 | _x_x_mozilla_page_load 03:42:31 INFO - PROCESS | 24276 | _x_x_mozilla_page_load_details 03:42:31 INFO - PROCESS | 24276 | |i|pagename|runs| 03:42:31 INFO - PROCESS | 24276 | |0;ai-astar;106;116;116;116;116;115;113;115;113;114 03:42:31 INFO - PROCESS | 24276 | |1;audio-beat-detection;152;129;127;163;129;129;127;129;164;134 03:42:31 INFO - PROCESS | 24276 | |2;audio-dft;161;161;163;162;161;162;161;166;161;160 03:42:31 INFO - PROCESS | 24276 | |3;audio-fft;75;76;76;117;77;76;76;76;96;77 03:42:31 INFO - PROCESS | 24276 | |4;audio-oscillator;83;82;114;83;83;85;107;83;83;111 03:42:31 INFO - PROCESS | 24276 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 03:42:31 INFO - PROCESS | 24276 | |6;imaging-darkroom;147;147;146;147;147;147;146;147;148;146 03:42:31 INFO - PROCESS | 24276 | |7;imaging-desaturate;85;86;85;85;85;85;85;84;85;85 03:42:31 INFO - PROCESS | 24276 | |8;json-parse-financial;64;60;60;59;60;61;62;62;61;61 03:42:31 INFO - PROCESS | 24276 | |9;json-stringify-tinderbox;66;66;66;67;67;67;67;66;67;66 03:42:31 INFO - PROCESS | 24276 | |10;stanford-crypto-aes;96;90;86;86;86;89;85;85;84;85 03:42:31 INFO - PROCESS | 24276 | |11;stanford-crypto-ccm;149;140;140;146;139;140;141;138;180;139 03:42:31 INFO - PROCESS | 24276 | |12;stanford-crypto-pbkdf2;180;186;183;181;186;184;187;182;184;182 03:42:31 INFO - PROCESS | 24276 | |13;stanford-crypto-sha256-iterative;70;70;70;71;70;70;69;71;70;69 03:42:31 INFO - PROCESS | 24276 | __end_tp_report 03:42:31 INFO - PROCESS | 24276 | __start_cc_report 03:42:31 INFO - PROCESS | 24276 | _x_x_mozilla_cycle_collect,1919 03:42:31 INFO - PROCESS | 24276 | __end_cc_report 03:42:31 INFO - PROCESS | 24276 | __startTimestamp1477392151505__endTimestamp 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | ------- Summary: start ------- 03:42:31 INFO - PROCESS | 24276 | Number of tests: 14 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:3.06 (2.6%) stddev-sans-first:1.27 03:42:31 INFO - PROCESS | 24276 | Values: 106.0 116.0 116.0 116.0 116.0 115.0 113.0 115.0 113.0 114.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:131.50 stddev:15.20 (11.6%) stddev-sans-first:15.29 03:42:31 INFO - PROCESS | 24276 | Values: 152.0 129.0 127.0 163.0 129.0 129.0 127.0 129.0 164.0 134.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.69 (1.0%) stddev-sans-first:1.76 03:42:31 INFO - PROCESS | 24276 | Values: 161.0 161.0 163.0 162.0 161.0 162.0 161.0 166.0 161.0 160.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.74 (18.1%) stddev-sans-first:14.33 03:42:31 INFO - PROCESS | 24276 | Values: 75.0 76.0 76.0 117.0 77.0 76.0 76.0 76.0 96.0 77.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.00 stddev:13.42 (16.2%) stddev-sans-first:13.88 03:42:31 INFO - PROCESS | 24276 | Values: 83.0 82.0 114.0 83.0 83.0 85.0 107.0 83.0 83.0 111.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:42:31 INFO - PROCESS | 24276 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:42:31 INFO - PROCESS | 24276 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 148.0 146.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 03:42:31 INFO - PROCESS | 24276 | Values: 85.0 86.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:61.00 stddev:1.41 (2.3%) stddev-sans-first:1.00 03:42:31 INFO - PROCESS | 24276 | Values: 64.0 60.0 60.0 59.0 60.0 61.0 62.0 62.0 61.0 61.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 03:42:31 INFO - PROCESS | 24276 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.00 stddev:3.61 (4.2%) stddev-sans-first:1.99 03:42:31 INFO - PROCESS | 24276 | Values: 96.0 90.0 86.0 86.0 86.0 89.0 85.0 85.0 84.0 85.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:140.50 stddev:12.71 (9.0%) stddev-sans-first:13.41 03:42:31 INFO - PROCESS | 24276 | Values: 149.0 140.0 140.0 146.0 139.0 140.0 141.0 138.0 180.0 139.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:184.00 stddev:2.32 (1.3%) stddev-sans-first:2.09 03:42:31 INFO - PROCESS | 24276 | Values: 180.0 186.0 183.0 181.0 186.0 184.0 187.0 182.0 184.0 182.0 03:42:31 INFO - PROCESS | 24276 | 03:42:31 INFO - PROCESS | 24276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:42:31 INFO - PROCESS | 24276 | Values: 70.0 70.0 70.0 71.0 70.0 70.0 69.0 71.0 70.0 69.0 03:42:31 INFO - PROCESS | 24276 | -------- Summary: end -------- 03:42:31 INFO - PROCESS | 24276 | 03:42:32 INFO - TEST-INFO | 24276: exit 0 03:42:32 INFO - TEST-OK | kraken | took 65005ms 03:42:32 INFO - SUITE-END | took 1188s 03:42:33 INFO - Completed test suite (00:19:48) 03:42:33 INFO - javascript benchmark 03:42:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.538023155832, 2577.445849142434, 2602.388438716902, 2607.4915391498653, 2618.3715908182044, 4491.865244042684, 4588.0, 4639.164950308943, 4656.627469802416, 4665.860024199275, 4554.089182163564, 4559.8404055858055, 4563.178627846986, 4574.6569007324415, 4590.127875703614, 4195.706300558954, 4223.155368926212, 4231.61915427613, 4252.787360631972, 4304.117655880537, 4225.429567008446, 4230.788460576974, 4239.660827133837, 4328.718633288826, 4330.870073897772, 4308.116836048603, 4334.869953901372, 4335.241332766769, 4364.650827933758, 4431.689781715281, 4371.934420983688, 4375.649948004152, 4384.0, 4401.5598440156045, 4410.536893626155, 4090.529589097262, 4113.444684967521, 4196.790160491993, 4287.399764033038, 4295.312749960022, 4584.885377865547, 4606.101810147023, 4609.469910960249, 4620.9768951155365, 4682.250839865639, 4879.951200487985, 4897.706137631718, 4908.705477671351, 4926.3595732554895, 4976.328195693572, 4821.590164835993, 4866.197077482211, 4873.415190177201, 4923.163062279421, 5001.89996200074, 4632.004119114406, 4677.532246775295, 4690.202665546865, 4694.835680751157, 4752.691075080109, 5133.666311689728, 5136.075506408808, 5136.897262054738, 5142.357205349332, 5192.221166825007, 4737.644676649196, 4922.0, 4924.926126108111, 4931.58081563064, 4990.326305948723, 4865.5864251538305, 4925.950740492621, 4977.253411988158, 5027.572656324181, 5039.899202015939, 4974.403071631427, 4977.402711674622, 4984.725840078758, 5032.446430892599, 5039.042581909425, 4937.1606826839525, 4946.060248552763, 4953.72754498506, 4956.281339205795, 5018.89962200754, 4089.2230476209425, 4097.7746223957965, 4134.524529679065, 4213.768242746678, 4260.8508702195895, 3699.4080947048883, 3704.666580007812, 3749.5687995880276, 3752.887413377603, 3763.6236376362695, 4254.042840360894, 4261.509926358446, 4264.87205383839, 4267.4025636410925, 4291.356296555542, 4830.686005409708, 4893.266010098442, 4999.625028122832, 5016.623753218523, 5086.059079070384, 4210.705250632487, 4226.197022565702, 4230.175115852441, 4230.492340919048, 4232.36514522824, 4420.359047938031, 4460.732356058582, 4463.977680111579, 4465.397171381886, 4466.3523789050405, 4599.425071866017, 4601.654875884322, 4609.4699109602825, 4609.93085103717, 4610.746408947406, 4954.30639710448, 4955.132851750857, 4955.529224723646, 4959.752012399438, 4962.454130045764, 4588.609968152745, 4609.147307748078, 4609.953900460952, 4610.907781844411, 4611.239145540948, 4843.2250839865455, 4886.218205087169, 4888.682235654671, 4889.9022019560125, 4918.065567542156, 4948.727819969792, 4992.350994370709, 5018.84943451697, 5022.849314520424, 5029.673071250357, 4844.0, 4844.588210002189, 4851.345068415719, 4852.587530059985, 4897.534734200245, 4622.168009758276, 4681.929771053369, 4688.226442637063, 4804.615630749462, 4852.078105160008, 4747.192977193954, 4763.7141771493825, 4769.689970151929, 4785.928211076906, 4827.975860120677, 4836.903261934812, 4872.707637541759, 4875.561199492063, 4884.633652476007, 4920.8769780755765, 4626.7455289958025, 4677.228257337501, 4757.0, 4789.736564488987, 4852.927206091982], "value": 4550.8267646112645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5390856451992, 572.8653766364904, 575.4418214332097, 585.0405335250188, 590.4449817171856, 27724.0, 39405.408918866204, 40727.38908916365, 40807.0, 44168.3374749379, 41147.38278925818, 41556.58443415565, 41598.79200603993, 41609.37585936206, 41615.0, 7729.845403091949, 7885.763427097197, 7886.132525422199, 7886.64510097047, 7888.053433587948, 7718.0, 7810.0, 7817.648205830751, 7819.3744500439825, 7819.765407037798, 7846.921530784676, 7885.763427097197, 7892.60536973149, 7895.341978184588, 7896.210378962115, 7786.805329866742, 7838.608069596497, 7841.411894107965, 7844.294013538752, 7846.215378462137, 7752.3410510106705, 7817.609119544, 7822.804429889241, 7828.725994590162, 7837.6864925402915, 39419.802900985596, 39729.40405893914, 39766.40350394746, 39793.40309895354, 39837.601623983675, 2974.464596372652, 2996.8351740654257, 3062.0660698486954, 3229.3056992746438, 3615.1865830188262, 28730.138095857157, 28813.42373152525, 29320.12039638814, 30143.69856301453, 30430.0, 3494.2662040971427, 3508.842102105386, 3624.5469316335457, 3676.356637588438, 3753.680937120348, 244011.0, 244013.0, 244491.0, 244772.0, 244775.0, 50974.0, 51233.0, 53999.0, 55783.442165578635, 55787.0, 52973.0, 57069.0, 57242.7137864308, 57247.42752572504, 57287.427125729046, 13079.41142648583, 13293.401796919163, 13397.06220564551, 13398.26309552984, 13399.53101641438, 9837.065478779505, 10075.546600402999, 10088.848667269996, 10092.192624590016, 10094.596216151273, 18116.456506304832, 18353.7246941296, 18475.630487390175, 18507.35224267171, 18528.536786580444, 6948.235694073648, 7038.92961070393, 7046.859062818818, 7209.711611535585, 7330.706771729071, 771.3906014248681, 849.2526576612541, 909.3134683314188, 910.0444533240071, 970.7039352997263, 26322.86838565795, 28490.85754571255, 28533.31468084271, 28760.424791504054, 29046.12861614155, 768.8500742355187, 923.0169869089533, 930.2743859789375, 938.3619138985418, 1003.6851724241267, 14391.78412323816, 15084.472043478425, 15135.697286054217, 15209.467668631545, 15325.693486130214, 385160.0, 387330.0, 387735.0, 388271.0, 389779.0, 50581.74709126431, 50855.74572127116, 50881.74559127181, 51039.74480127576, 51153.23270150951, 1052.273930987616, 1094.715374002765, 1135.693362792025, 1154.261272785418, 1182.5742732616252, 28214.71785282203, 29474.263143421587, 29925.55111673283, 30185.0, 30619.693803062575, 42078.789606051774, 42697.14605707806, 42763.78618106889, 42801.357979629705, 42835.143297134506, 291598.0, 292761.0, 293344.0, 294291.0, 294495.0, 36669.44995825118, 38388.81750963584, 38402.807985959895, 38443.0, 38481.6151838478, 41456.79271603622, 41699.166016678886, 41729.79135104305, 42651.57348426476, 42795.786021069696, 34924.0, 35263.294734105686, 35661.82169089138, 36048.27903441969, 36598.45102323414, 35460.0, 35874.641253588175, 35958.64041359553, 36015.81992090023, 36095.45856812203, 35246.71299305022, 35628.64371356253, 35840.82079589585, 36140.63859361373, 36398.636013640586, 30079.398412032075, 32690.346193076482, 32743.836280818443, 32830.0, 33241.50137747984, 24718.382040449134, 24966.251012469656, 25214.24357269285, 25245.242642720747, 25623.6156457657], "value": 17673.084291826846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.73956620936326, 356.54362416107375, 358.7954865726537, 366.8330909436206, 380.70875780028285, 12798.936005319973, 13398.062135650496, 13700.451981920736, 16767.413140540084, 16774.41289554866, 14341.498047568337, 14447.133172009686, 14587.416503339853, 14739.263036848168, 14934.850651493482, 4821.831235906744, 5068.3917929848285, 5075.974620126913, 5077.84766457005, 5086.567641750456, 3698.315811574854, 3912.0219945013746, 5733.684647344395, 5954.761809527614, 5995.550333724967, 5781.0, 6052.969735151318, 6065.969670151665, 6066.787662431816, 6067.757289708428, 5879.67661778602, 5918.4969277611235, 5965.135055416984, 5993.520518358564, 6009.308929473123, 5063.0, 5207.739613019372, 5218.511544941044, 5259.211118332242, 5266.657667251617, 20438.59122817535, 20461.0, 20484.79515204844, 20605.0, 20635.0, 2017.6973453981873, 2021.2622392826659, 2091.518950641361, 2103.9368818935454, 2314.409825494505, 12450.750984980341, 12569.937150314281, 12931.0, 13146.0, 13171.868281317256, 1705.7100292950229, 1710.144927536232, 1712.546175263556, 1758.2439550993067, 1814.3286983816072, 69850.0, 69872.3012769876, 70553.0, 71367.0, 71429.64285178541, 9027.548622568846, 9114.36199466031, 9289.16397524226, 9295.628174873065, 9554.952225238829, 12967.935160324138, 12971.740565188833, 12980.935095324463, 12981.350932453339, 12989.0, 6108.908366374508, 6268.811935641938, 6357.237131544244, 6437.259715132726, 6468.611883287018, 5713.428657134336, 5790.189373487715, 5799.82600521985, 5836.358000619928, 6035.939640603538, 5771.711414429262, 5855.2973643163095, 5940.970295148497, 5955.40445955401, 6116.3883611638485, 1688.383739934915, 1708.2739835569832, 1714.9742753858702, 1758.2263803926232, 1774.1750086209975, 675.3449154320301, 817.6647574494428, 877.609463788608, 886.8182022685334, 946.4936259101348, 16071.598210044609, 16395.672086558203, 16608.418705345255, 16835.663286734198, 17408.39070632547, 871.9564021798884, 886.4636894678627, 898.793277546168, 931.1573026411108, 933.8272419602396, 8969.461832290084, 9050.86423703645, 10181.74545636365, 10187.337823041478, 10257.28199026061, 389679.0, 390183.0, 392640.0, 399452.0, 399896.0, 79162.6041869787, 80273.19726802774, 81836.0, 81838.0, 82003.58998204971, 909.7134402663007, 912.748994026648, 939.5818860607101, 946.5409276500892, 946.7207173883721, 15125.243737812845, 15129.546113616609, 15554.433518469326, 15570.0, 15819.288132033857, 36746.63253367432, 38124.61875381211, 38211.61788382192, 38353.0, 39251.607483924796, 49176.0, 49265.26102108543, 51660.22509662433, 52276.73861630668, 52586.2112068327, 7290.671919763729, 7329.377002954595, 7373.963130184315, 7481.214472480311, 7553.093628764584, 8462.11147829469, 11592.420378981185, 11757.413369058793, 11941.462634181657, 12125.81811272814, 9780.364276322302, 10160.136388407069, 10218.0, 10236.692899212738, 10688.625898093529, 9590.328676992543, 9939.0, 10219.284650074424, 10332.225083118647, 10396.896031039592, 10272.486375681037, 10309.948450257702, 10412.635557755746, 10456.529456174643, 10735.409552474688, 7358.779236622696, 7389.593572353358, 7588.658510366937, 7658.578778167254, 7782.727604533814, 10127.139193168663, 10255.282130250811, 10257.435841028517, 10262.897371026194, 10461.163106951273], "value": 8222.772858542294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.745068436997, 1386.88904887609, 1434.82782066152, 1642.9813515620317, 1654.420952666566, 6346.6826658667, 6612.107365505655, 6804.387605115545, 7434.888476672854, 7445.143808462029, 6770.289119642441, 7000.229974702778, 7009.964950175255, 7212.593544258872, 7222.747203847866, 2081.833453323738, 2125.851190416664, 2130.5738852229615, 2130.946726331839, 2140.218820130649, 1811.139708638393, 1872.1855992643175, 2041.8672786268844, 2092.3095378525127, 2149.0866381787755, 2040.479677682189, 2101.3170719516143, 2102.9158833646634, 2109.0930899713117, 2119.4913220826966, 2101.989490052555, 2129.0951345678104, 2135.914563417454, 2148.2695883399565, 2155.288754710957, 2064.814166725002, 2086.95826083479, 2088.3108574170637, 2094.371688493446, 2102.6740855167473, 7391.926080739177, 7406.333429991327, 7465.328120469184, 7476.962615186943, 7477.5887326197035, 4213.9578604213875, 4359.80380882861, 4378.781060946972, 4394.099209662044, 4411.404460397869, 2871.4687782760047, 2877.8992735254374, 2958.467475854345, 2958.6893376195403, 2959.2010157257637, 931.6459745296744, 932.1843387036344, 963.8939716631235, 965.7826988927505, 973.109604711695, 9517.428954262767, 9628.90371096294, 9629.855552166724, 9630.374025688378, 9644.517774111337, 3690.833912473945, 3818.885433437001, 3848.634379733977, 3873.5545412277947, 3876.8061596920043, 7718.189590092959, 7732.7680169595005, 7746.651400686983, 7775.416843736629, 7801.531908085533, 4255.148970205972, 4263.147370525907, 4266.338717498793, 4266.488021437447, 4271.978640106841, 3845.134844659929, 3911.5892831252877, 3954.6440820326306, 4004.899877503086, 4052.756834589934, 3022.2621992354484, 3086.105029541453, 3133.2166958260436, 3225.6774322567558, 3241.2545114623767, 880.295763389286, 905.456725964416, 930.237205491504, 975.8487434447673, 985.261054209343, 772.8377040821377, 780.3873958942316, 814.3770015937812, 824.7360844529812, 871.4684042733927, 4846.176150054499, 4968.527989841032, 5006.349174607278, 5158.664686795421, 5262.71055091966, 415.1883068600878, 420.05697209764276, 420.52270672785994, 428.21636405378706, 599.8106909779341, 3395.7453191010773, 3426.777259478126, 3538.0, 3547.3260080584605, 3619.8914032579064, 8515.361347898808, 8729.60716767747, 8874.156955089256, 8876.689315873913, 8889.155530224618, 8819.955900220586, 8871.245944094824, 8874.378793484395, 8881.42270752412, 8895.332850036144, 6714.29499902513, 6822.147231596051, 6824.6928888200155, 6834.316568343126, 6840.144981877265, 4910.21436570147, 4958.45456999737, 4976.527229913152, 5048.242763585345, 5110.540051395392, 8021.2379823916635, 8096.271335579826, 8116.634751436081, 8127.959360203161, 8198.508089514648, 8144.633491492778, 8150.225728555778, 8170.714025009096, 8217.630206640595, 8245.546494942835, 5805.564582656402, 5855.531557475477, 5856.765729370777, 5861.589688721919, 5862.149988251595, 6429.517786165963, 6445.452136568444, 6581.111549940888, 6602.60384376939, 6633.071370008106, 4809.855704328876, 5834.970825146017, 5912.113183022581, 5983.910241346296, 6085.66528840918, 5875.794347197828, 5896.498797602252, 5911.408859114054, 5915.201447804663, 5985.461308482258, 5853.2976042875125, 5889.087191485327, 5965.403459654, 6027.969860150672, 6031.69841507914, 4322.2220000398975, 4342.41377414045, 4461.732296062247, 4469.530699276529, 4477.462704475353, 4380.167768124046, 4427.9114417710825, 4451.6661250407, 4478.305862591304, 4545.568171023748], "value": 3784.835880598056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.38015407336445, 298.9506731389321, 301.030681206515, 303.8951561711209, 306.68871095837727, 4859.465458799529, 4885.560299573038, 4901.460839307673, 4902.852914412564, 4919.532644398781, 4802.399700037496, 4806.927896081553, 4847.515248475151, 4860.538248866361, 4868.221084626452, 3528.629493903142, 3643.9453408198897, 3647.963520364789, 3767.5290588676417, 3810.5427348718194, 3804.5054142961376, 3816.1378965775666, 3818.694504439652, 3823.3118038753014, 3848.7690738555634, 3770.868019619314, 3805.2579746949355, 3809.1619843634357, 3811.7141214408894, 3816.6755825754703, 3571.4107172316535, 3675.2649470105953, 3680.245549662313, 3751.4747935289083, 3774.339490589136, 3327.93344133116, 3334.683205095512, 3342.415077361452, 3349.246419555605, 3352.094934367707, 4694.694844835109, 4715.528447155291, 4719.5752382285755, 4744.4069491313585, 4764.737939413331, 4258.105143211273, 4308.67684923632, 4335.804888780012, 4351.608355248043, 4378.5183629800695, 5008.5993120550265, 5027.522385373383, 5030.01314480778, 5038.622103342264, 5068.949310506885, 3686.705063594906, 3700.1489657378684, 3702.0, 3710.239400922804, 3719.3119272934596, 5132.615053870974, 5287.9735601321745, 5316.654417462892, 5344.893102137936, 5349.5720342372515, 3745.8534830742306, 3752.2307926874923, 3762.736608437438, 3764.642358975893, 3786.4888240087785, 3803.448499967489, 3824.7896365700153, 3827.1771569112775, 3837.501124853751, 3851.171998020439, 4317.892052698708, 4326.63223625989, 4341.218580655513, 4346.174226896879, 4347.0, 4875.561199492063, 5003.2995380646735, 5024.974875125674, 5036.924446133311, 5103.132467480537, 1309.3387839141174, 1316.861729518406, 1322.7817410127413, 1324.4172564071778, 1328.920264784116, 798.7643645124703, 825.0800357601352, 832.3632421197789, 837.351052933981, 843.8692002739585, 4296.76367799774, 4346.282863327516, 4492.742032230981, 4499.167653984024, 4501.842435514807, 5268.894622107613, 5286.867828304323, 5291.470852914677, 5291.735413229323, 5293.364796224478, 4504.076664283814, 4507.526709695435, 4511.684182107287, 4520.796564154621, 4525.298578720303, 2659.3750468639855, 2786.651668541432, 2791.6091747155415, 2799.790015748827, 2812.915612531627, 4859.635527335464, 4863.927041094386, 4865.683730557503, 4871.685949174114, 4874.122657921537, 5277.683338999673, 5319.202119682079, 5362.329708786402, 5389.652586853286, 5421.837344879581, 4818.662948469989, 4822.662413631012, 4839.322494850724, 4863.489333619989, 4866.124097662455, 5225.7387130642555, 5225.869353266199, 5229.947700522946, 5263.736813159403, 5286.20706893969, 4886.411916127202, 5130.843502280184, 5150.304708864255, 5169.922451163311, 5171.095058364846, 4895.534924182197, 4909.607231421549, 4912.48418916023, 4914.459409465027, 4915.927545284198, 3699.6300369962787, 3725.2363265531044, 3747.943780843344, 3751.662350388478, 3751.7748935063983, 5132.5124113209185, 5297.867553311198, 5320.414754377093, 5328.60035497347, 5355.491228333302, 5085.618578606545, 5102.158143906214, 5104.2343648453025, 5122.615803814803, 5145.61407894402, 5059.620528460307, 5086.186210206497, 5099.311592935054, 5109.412417572027, 5149.871253218699, 4717.339572459789, 4938.506149385176, 5034.899302013866, 5035.773390197377, 5066.949330506648, 4798.328234047306, 4966.652334336562, 5021.748912554284, 5100.5409513143995, 5122.257272695513, 4992.053099291206, 5031.698098114125, 5038.823641172541, 5057.418396884258, 5074.112030394593], "value": 3832.6153645367885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.3322178156501, 652.386756448938, 668.318315318375, 719.6941299947521, 730.0399974034144, 12207.633770986873, 13377.0, 13380.799288010663, 13406.396712147953, 13408.731825363499, 12945.482180712761, 13001.0, 13006.284654344006, 13012.479500819956, 13027.478900843978, 623.6538721009838, 630.9242890853104, 752.5860776572877, 768.3737753730719, 786.4180506425233, 779.7348901373532, 804.2922228438965, 804.3243675312737, 804.388664614891, 804.8832919226738, 848.1349023995521, 850.107387243395, 850.8298340331959, 851.6040041380757, 851.7146755836802, 639.1371648274838, 653.3042309939899, 815.8245977114949, 840.6805413942724, 841.18405147007, 609.2840911928511, 609.3084349263573, 609.8109586028345, 610.1244713835616, 611.3122736920964, 12512.436940337706, 12577.11960162789, 12581.0, 12583.748325033539, 12586.68533286666, 11866.626674665102, 12057.819132713017, 12256.325902075383, 12327.506899724, 12613.558525451657, 11174.497147628375, 11179.944100279447, 11299.774004519946, 11312.717182070432, 11553.0, 3142.120206342228, 3193.552902593639, 3247.7077063064203, 3265.885694000722, 3902.3951287550476, 48139.75930120362, 49238.50761492411, 49748.0, 49933.0, 51092.489075109144, 9200.21798147165, 9675.854862177073, 9732.951335243279, 9821.754456138653, 9863.421852503565, 16503.83496165047, 16559.503214903332, 16593.0, 16648.25082871274, 16746.49760507187, 6488.740450381932, 6494.350564943468, 6550.377714117151, 6577.572457790228, 6638.17022872141, 3622.3841946869097, 3646.6353364663323, 3659.1766852457986, 3681.631836816297, 3725.1245957200035, 2874.870630821618, 2963.701138543544, 2984.701529846998, 2989.8505074746613, 3015.7587393008507, 516.5686651645917, 521.7652056574557, 521.930043411006, 524.8294304351101, 531.1952392125933, 499.0119563264756, 526.1240035341191, 527.7070978089765, 573.2662192393743, 582.7005777117053, 7828.725994590162, 8120.3503719702285, 8180.509169449733, 8240.0, 8259.21537453941, 576.6568891509545, 604.3835288006209, 625.74344518748, 636.1285039495921, 644.9258335291502, 3721.627837216257, 3782.4893639358334, 3820.67524260441, 3906.4921560196995, 3936.291467535871, 72439.63780181065, 72703.2729672707, 73257.63371183217, 74909.0, 75958.62020689972, 50633.0, 53899.73050134724, 57349.0, 59087.704561477774, 64974.0, 52345.7382713084, 53691.463085369425, 54063.45936540663, 54133.188002179995, 55439.72280138574, 7421.220771818881, 7810.804729881798, 7870.0, 7883.369330453665, 8202.267968074631, 25876.223713288633, 27061.0, 27177.59233611537, 31313.8434307827, 34272.82863585666, 29834.701652983193, 50012.0, 50056.49943500664, 50303.245451317525, 50997.23504147515, 9790.706278811647, 9794.35135859053, 9845.950770246103, 10065.496725163859, 10151.543180556744, 10963.397013164353, 11201.159913006393, 11216.327020378803, 11220.102391808472, 11807.23252988553, 11495.655130346104, 11673.591424300108, 12120.939395302967, 12158.209716368408, 12279.69300767488, 11024.889751102386, 11237.831432528683, 11556.0, 11817.586384476503, 12335.876641233832, 11113.0, 11655.941720291345, 11895.345755983504, 11897.643070707893, 11912.34482103458, 9411.905880941104, 9657.22742180638, 9790.804183916423, 9859.654912078044, 9938.10557049869, 8603.881495405558, 9511.334206605748, 9758.707238782848, 9875.654352097643, 10395.58417663285], "value": 6106.971950168788, "unit": "score"}], "name": "dromaeo_css", "value": 6232.18740699916, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 116.0, 116.0, 115.0, 113.0, 115.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 127.0, 163.0, 129.0, 129.0, 127.0, 129.0, 164.0, 134.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 161.0, 162.0, 161.0, 166.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 117.0, 77.0, 76.0, 76.0, 76.0, 96.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 83.0, 83.0, 85.0, 107.0, 83.0, 83.0, 111.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 60.0, 59.0, 60.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 90.0, 86.0, 86.0, 86.0, 89.0, 85.0, 85.0, 84.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 140.0, 140.0, 146.0, 139.0, 140.0, 141.0, 138.0, 180.0, 139.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 186.0, 183.0, 181.0, 186.0, 184.0, 187.0, 182.0, 184.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 69.0, 71.0, 70.0, 69.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1549.7, "alertThreshold": 2.0}]} 03:42:33 INFO - Return code: 0 03:42:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:42:33 INFO - # TBPL SUCCESS # 03:42:33 INFO - Running post-action listener: _resource_record_post_action 03:42:33 INFO - [mozharness: 2016-10-25 10:42:33.332339Z] Finished run-tests step (success) 03:42:33 INFO - Running post-run listener: _resource_record_post_run 03:42:33 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 401305600; Read time: 0; Write time: 573236 03:42:33 INFO - TinderboxPrint: CPU usage
13.0% 03:42:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:42:33 INFO - TinderboxPrint: I/O write bytes / time
401,305,600 / 573,236 03:42:33 INFO - TinderboxPrint: CPU idle
8,358.6 (86.9%) 03:42:33 INFO - TinderboxPrint: CPU user
1,203.2 (12.5%) 03:42:33 INFO - TinderboxPrint: Swap in / out
0 / 0 03:42:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110333952; Read time: 0; Write time: 127228 03:42:33 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290971648; Read time: 0; Write time: 446008 03:42:33 INFO - Running post-run listener: _upload_blobber_files 03:42:33 INFO - Blob upload gear active. 03:42:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:42:34 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:35 INFO - (blobuploader) - INFO - Done attempting. 03:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:38 INFO - (blobuploader) - INFO - Done attempting. 03:42:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:42:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:39 INFO - (blobuploader) - INFO - Done attempting. 03:42:39 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:39 INFO - Return code: 0 03:42:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ace881304588b0a93f95cd2dba5b4fc5b765ea93dfdc790aa4995ea771066894b7c84524293831dd81d442ee461e34cea242810dca9c35a54d9ea55f346776d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6421283f13238c2275d243e0534f9c698927d95d16aac5e18008a270f0a5b6bb4dee8ccda22c0b57e635b466c0b52789778656874f9b7ee64c8904b382b4abcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78534452c5cf1361889906b97a7fe578f063f22e783844b471fc489d7ad17a00e1d680b9f09654616fc879cdfba71950a4571e0d2862b4a366ceb1e4297b7596"} 03:42:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:39 INFO - Contents: 03:42:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ace881304588b0a93f95cd2dba5b4fc5b765ea93dfdc790aa4995ea771066894b7c84524293831dd81d442ee461e34cea242810dca9c35a54d9ea55f346776d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6421283f13238c2275d243e0534f9c698927d95d16aac5e18008a270f0a5b6bb4dee8ccda22c0b57e635b466c0b52789778656874f9b7ee64c8904b382b4abcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78534452c5cf1361889906b97a7fe578f063f22e783844b471fc489d7ad17a00e1d680b9f09654616fc879cdfba71950a4571e0d2862b4a366ceb1e4297b7596"} 03:42:39 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:39 INFO - Copying logs to upload dir... 03:42:39 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.148157 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-25 03:42:39.452752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:42:39.456730) ========= 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=8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ace881304588b0a93f95cd2dba5b4fc5b765ea93dfdc790aa4995ea771066894b7c84524293831dd81d442ee461e34cea242810dca9c35a54d9ea55f346776d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6421283f13238c2275d243e0534f9c698927d95d16aac5e18008a270f0a5b6bb4dee8ccda22c0b57e635b466c0b52789778656874f9b7ee64c8904b382b4abcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78534452c5cf1361889906b97a7fe578f063f22e783844b471fc489d7ad17a00e1d680b9f09654616fc879cdfba71950a4571e0d2862b4a366ceb1e4297b7596"} build_url:https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011563 build_url: 'https://queue.taskcluster.net/v1/task/cef7NZbbR06kE1EsCjnVsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ace881304588b0a93f95cd2dba5b4fc5b765ea93dfdc790aa4995ea771066894b7c84524293831dd81d442ee461e34cea242810dca9c35a54d9ea55f346776d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6421283f13238c2275d243e0534f9c698927d95d16aac5e18008a270f0a5b6bb4dee8ccda22c0b57e635b466c0b52789778656874f9b7ee64c8904b382b4abcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78534452c5cf1361889906b97a7fe578f063f22e783844b471fc489d7ad17a00e1d680b9f09654616fc879cdfba71950a4571e0d2862b4a366ceb1e4297b7596"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:42:39.482059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:42:39.482398) ========= 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=8783db0840cc980e80bb0bd400000236-1477390909.622103-1467731593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:42:39.566218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:42:39.566544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:42:39.566847) ========= ========= Total master_lag: 0.17 =========