builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1480074280.31 results: success (0) buildid: 20161125004006 builduid: f6a669292bb14189aadc8562cd50e652 revision: 55b599ca3530c8286f6ad15405d99d2bcaecfbd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.310764) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.311303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.311654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.326544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.326858) ========= 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=7de08804244eb36560b44971000001c3-1480074280.430267-1456604095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 03:44:41-- 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% 88.5M=0s 2016-11-25 03:44:41 (88.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.470141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.470527) ========= 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=7de08804244eb36560b44971000001c3-1480074280.430267-1456604095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013494 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.520099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:40.520476) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55b599ca3530c8286f6ad15405d99d2bcaecfbd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55b599ca3530c8286f6ad15405d99d2bcaecfbd1 --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=7de08804244eb36560b44971000001c3-1480074280.430267-1456604095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 03:44:41,365 truncating revision to first 12 chars 2016-11-25 03:44:41,365 Setting DEBUG logging. 2016-11-25 03:44:41,366 attempt 1/10 2016-11-25 03:44:41,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/55b599ca3530?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 03:44:41,867 unpacking tar archive at: mozilla-aurora-55b599ca3530/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:41.360604) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:41.360929) ========= script_repo_revision: 55b599ca3530c8286f6ad15405d99d2bcaecfbd1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:41.361330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:41.361601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:44:41.370382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-25 03:44:41.370677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1480074280.430267-1456604095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:42 INFO - MultiFileLogger online at 20161125 03:44:42 in /builds/slave/test 03:44:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:44:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:42 INFO - {'append_to_log': False, 03:44:42 INFO - 'base_work_dir': '/builds/slave/test', 03:44:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:44:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:42 INFO - 'branch': 'Mozilla-Aurora', 03:44:42 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:42 INFO - 'config_files': ('talos/linux_config.py',), 03:44:42 INFO - 'default_actions': ('clobber', 03:44:42 INFO - 'read-buildbot-config', 03:44:42 INFO - 'download-and-extract', 03:44:42 INFO - 'populate-webroot', 03:44:42 INFO - 'create-virtualenv', 03:44:42 INFO - 'install', 03:44:42 INFO - 'run-tests'), 03:44:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:42 INFO - 'download_minidump_stackwalk': True, 03:44:42 INFO - 'download_symbols': 'ondemand', 03:44:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:42 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:42 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:42 INFO - 'installer_path': 'installer.exe', 03:44:42 INFO - 'log_level': 'info', 03:44:42 INFO - 'log_name': 'talos', 03:44:42 INFO - 'log_to_console': True, 03:44:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:42 INFO - 'opt_config_files': (), 03:44:42 INFO - 'pip_index': False, 03:44:42 INFO - 'sps_profile': False, 03:44:42 INFO - 'sps_profile_interval': 0, 03:44:42 INFO - 'suite': 'dromaeojs', 03:44:42 INFO - 'system_bits': '32', 03:44:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:42 INFO - 'title': 'talos-linux64-ix-003', 03:44:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:42 INFO - 'use_talos_json': True, 03:44:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:42 INFO - 'work_dir': 'build'} 03:44:42 INFO - [mozharness: 2016-11-25 11:44:42.315259Z] Running clobber step. 03:44:42 INFO - Running pre-action listener: _resource_record_pre_action 03:44:42 INFO - Running main action method: clobber 03:44:42 INFO - rmtree: /builds/slave/test/build 03:44:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:42 INFO - Running post-action listener: _resource_record_post_action 03:44:42 INFO - [mozharness: 2016-11-25 11:44:42.778309Z] Finished clobber step (success) 03:44:42 INFO - [mozharness: 2016-11-25 11:44:42.778407Z] Running read-buildbot-config step. 03:44:42 INFO - Running pre-action listener: _resource_record_pre_action 03:44:42 INFO - Running main action method: read_buildbot_config 03:44:42 INFO - Using buildbot properties: 03:44:42 INFO - { 03:44:42 INFO - "project": "", 03:44:42 INFO - "product": "firefox", 03:44:42 INFO - "script_repo_revision": "production", 03:44:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:44:42 INFO - "repository": "", 03:44:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:44:42 INFO - "buildid": "20161125004006", 03:44:42 INFO - "stage_platform": "linux64-pgo", 03:44:42 INFO - "basedir": "/builds/slave/test", 03:44:42 INFO - "nightly_build": "True", 03:44:42 INFO - "buildnumber": 644, 03:44:42 INFO - "slavename": "talos-linux64-ix-003", 03:44:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:44:42 INFO - "platform": "ubuntu64_hw", 03:44:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:44:42 INFO - "branch": "mozilla-aurora", 03:44:42 INFO - "repo_path": "releases/mozilla-aurora", 03:44:42 INFO - "revision": "55b599ca3530c8286f6ad15405d99d2bcaecfbd1", 03:44:42 INFO - "pgo_build": "True", 03:44:42 INFO - "builduid": "f6a669292bb14189aadc8562cd50e652", 03:44:42 INFO - "slavebuilddir": "test" 03:44:42 INFO - } 03:44:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:44:42 INFO - Running post-action listener: _resource_record_post_action 03:44:42 INFO - [mozharness: 2016-11-25 11:44:42.780891Z] Finished read-buildbot-config step (success) 03:44:42 INFO - [mozharness: 2016-11-25 11:44:42.780979Z] Running download-and-extract step. 03:44:42 INFO - Running pre-action listener: _resource_record_pre_action 03:44:42 INFO - Running main action method: download_and_extract 03:44:42 INFO - mkdir: /builds/slave/test/build/tests 03:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:42 INFO - trying https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:44:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:43 INFO - Downloaded 1361 bytes. 03:44:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:44:43 INFO - Using the following test package requirements: 03:44:43 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:43 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:43 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:44:43 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'jsshell-linux-x86_64.zip'], 03:44:43 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:43 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:43 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:44:43 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:44:43 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:43 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:43 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:44:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:44:43 INFO - Http code: 200 03:44:43 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 03:44:43 INFO - x-amz-cf-id: k1yn83tdNiz06Kr0AOX2eUDV4tm_RuzJVi8WhrAZ2Fd-E9UjtY2d5A== 03:44:43 INFO - x-amz-version-id: jrDhMM0HMRWZbTuIuKE8jTVwQgepcHWM 03:44:44 INFO - Expected file size: 21951483 03:44:44 INFO - Obtained file size: 21951483 03:44:48 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:44:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:44:48 INFO - Http code: 200 03:44:48 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 03:44:48 INFO - x-amz-cf-id: hBBCAzyt9KPQkrnMY7l0-gMt5x9EIa0dURI4V92ZT8jqWHAxaTRBfA== 03:44:48 INFO - x-amz-version-id: jrDhMM0HMRWZbTuIuKE8jTVwQgepcHWM 03:44:48 INFO - Expected file size: 21951483 03:44:48 INFO - Obtained file size: 21951483 03:44:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:44:54 INFO - Http code: 200 03:44:54 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 03:44:54 INFO - x-amz-cf-id: hNNvpm2XBX5PP946w3qDQWt2voVhHf2j8pUM11BvGFkP1j0gjLno9A== 03:44:54 INFO - x-amz-version-id: Q_SwChFiPF5jZbFnFIKkDB8NkfAnUSfK 03:44:54 INFO - Expected file size: 14409038 03:44:54 INFO - Obtained file size: 14409038 03:44:55 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:44:55 INFO - trying https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:44:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:44:56 INFO - Downloaded 63956235 bytes. 03:44:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:44:56 INFO - mkdir: /builds/slave/test/properties 03:44:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:56 INFO - Contents: 03:44:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:44:56 INFO - Running post-action listener: _resource_record_post_action 03:44:56 INFO - Running post-action listener: set_extra_try_arguments 03:44:56 INFO - [mozharness: 2016-11-25 11:44:56.804399Z] Finished download-and-extract step (success) 03:44:56 INFO - [mozharness: 2016-11-25 11:44:56.804695Z] Running populate-webroot step. 03:44:56 INFO - Running pre-action listener: _resource_record_pre_action 03:44:56 INFO - Running main action method: populate_webroot 03:44:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:56 INFO - '--tppagecycles', 03:44:56 INFO - '7'], 03:44:56 INFO - 'tests': ['tsvgm']}}, 03:44:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['damp', 'tps']}, 03:44:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'tests': ['damp', 'tps']}, 03:44:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['dromaeo_dom']}, 03:44:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['basic_compositor_video']}, 03:44:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:44:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['a11yr', 03:44:56 INFO - 'ts_paint', 03:44:56 INFO - 'tpaint', 03:44:56 INFO - 'sessionrestore', 03:44:56 INFO - 'sessionrestore_no_auto_restore', 03:44:56 INFO - 'tabpaint']}, 03:44:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:56 INFO - 'ts_paint', 03:44:56 INFO - 'tpaint', 03:44:56 INFO - 'sessionrestore', 03:44:56 INFO - 'sessionrestore_no_auto_restore', 03:44:56 INFO - 'tabpaint']}, 03:44:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:56 INFO - 'ts_paint', 03:44:56 INFO - 'tpaint', 03:44:56 INFO - 'sessionrestore', 03:44:56 INFO - 'sessionrestore_no_auto_restore', 03:44:56 INFO - 'tabpaint']}, 03:44:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:56 INFO - 'ts_paint', 03:44:56 INFO - 'tpaint', 03:44:56 INFO - 'sessionrestore', 03:44:56 INFO - 'sessionrestore_no_auto_restore', 03:44:56 INFO - 'tabpaint']}, 03:44:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['a11yr', 03:44:56 INFO - 'ts_paint', 03:44:56 INFO - 'tpaint', 03:44:56 INFO - 'sessionrestore', 03:44:56 INFO - 'sessionrestore_no_auto_restore', 03:44:56 INFO - 'tabpaint']}, 03:44:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['a11yr', 03:44:56 INFO - 'ts_paint', 03:44:56 INFO - 'tpaint', 03:44:56 INFO - 'sessionrestore', 03:44:56 INFO - 'sessionrestore_no_auto_restore', 03:44:56 INFO - 'tabpaint']}, 03:44:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['tsvgx', 03:44:56 INFO - 'tsvgr_opacity', 03:44:56 INFO - 'tart', 03:44:56 INFO - 'tscrollx', 03:44:56 INFO - 'cart']}, 03:44:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:56 INFO - 'tsvgr_opacity', 03:44:56 INFO - 'tart', 03:44:56 INFO - 'tscrollx', 03:44:56 INFO - 'cart']}, 03:44:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'talos_options': ['--disable-e10s'], 03:44:56 INFO - 'tests': ['tp5o']}, 03:44:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'tests': ['tp5o']}, 03:44:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'talos_options': ['--disable-e10s', 03:44:56 INFO - '--xperf_path', 03:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:56 INFO - 'tests': ['tp5n']}, 03:44:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:56 INFO - 'talos_options': ['--xperf_path', 03:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:56 INFO - 'tests': ['tp5n']}}, 03:44:56 INFO - 'talos.zip': {'path': '', 03:44:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:56 INFO - Running post-action listener: _resource_record_post_action 03:44:56 INFO - [mozharness: 2016-11-25 11:44:56.831339Z] Finished populate-webroot step (success) 03:44:56 INFO - [mozharness: 2016-11-25 11:44:56.831433Z] Running create-virtualenv step. 03:44:56 INFO - Running pre-action listener: _resource_record_pre_action 03:44:56 INFO - Running main action method: create_virtualenv 03:44:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:56 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:44:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:56 INFO - Using real prefix '/usr' 03:44:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:59 INFO - Installing pip.................done. 03:44:59 INFO - Return code: 0 03:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:44:59 INFO - Reading from file tmpfile_stdout 03:44:59 INFO - Output received: 03:44:59 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:44:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:44:59 INFO - Using env: {'DISPLAY': ':0', 03:44:59 INFO - 'HOME': '/home/cltbld', 03:44:59 INFO - 'LANG': 'en_US.UTF-8', 03:44:59 INFO - 'LANGUAGE': 'en_US:en', 03:44:59 INFO - 'LOGNAME': 'cltbld', 03:44:59 INFO - 'MAIL': '/var/mail/cltbld', 03:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:59 INFO - 'MOZ_NO_REMOTE': '1', 03:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:59 INFO - 'NO_EM_RESTART': '1', 03:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:59 INFO - 'PWD': '/builds/slave/test', 03:44:59 INFO - 'SHELL': '/bin/bash', 03:44:59 INFO - 'SHLVL': '1', 03:44:59 INFO - 'TERM': 'linux', 03:44:59 INFO - 'TMOUT': '86400', 03:44:59 INFO - 'USER': 'cltbld', 03:44:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:59 INFO - '_': '/tools/buildbot/bin/python'} 03:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:59 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:44:59 INFO - Cleaning up... 03:44:59 INFO - Return code: 0 03:44:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:44:59 INFO - Using env: {'DISPLAY': ':0', 03:44:59 INFO - 'HOME': '/home/cltbld', 03:44:59 INFO - 'LANG': 'en_US.UTF-8', 03:44:59 INFO - 'LANGUAGE': 'en_US:en', 03:44:59 INFO - 'LOGNAME': 'cltbld', 03:44:59 INFO - 'MAIL': '/var/mail/cltbld', 03:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:59 INFO - 'MOZ_NO_REMOTE': '1', 03:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:59 INFO - 'NO_EM_RESTART': '1', 03:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:59 INFO - 'PWD': '/builds/slave/test', 03:44:59 INFO - 'SHELL': '/bin/bash', 03:44:59 INFO - 'SHLVL': '1', 03:44:59 INFO - 'TERM': 'linux', 03:44:59 INFO - 'TMOUT': '86400', 03:44:59 INFO - 'USER': 'cltbld', 03:44:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:59 INFO - '_': '/tools/buildbot/bin/python'} 03:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:00 INFO - Downloading/unpacking psutil>=3.1.1 03:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:02 INFO - Installing collected packages: psutil 03:45:02 INFO - Running setup.py install for psutil 03:45:02 INFO - building 'psutil._psutil_linux' extension 03:45:02 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:45:02 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:45:02 INFO - building 'psutil._psutil_posix' extension 03:45:02 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:45:02 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:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:02 INFO - Successfully installed psutil 03:45:02 INFO - Cleaning up... 03:45:02 INFO - Return code: 0 03:45:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:02 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:02 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:45:02 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:45:02 INFO - Using env: {'DISPLAY': ':0', 03:45:02 INFO - 'HOME': '/home/cltbld', 03:45:02 INFO - 'LANG': 'en_US.UTF-8', 03:45:02 INFO - 'LANGUAGE': 'en_US:en', 03:45:02 INFO - 'LOGNAME': 'cltbld', 03:45:02 INFO - 'MAIL': '/var/mail/cltbld', 03:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:02 INFO - 'MOZ_NO_REMOTE': '1', 03:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:02 INFO - 'NO_EM_RESTART': '1', 03:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:02 INFO - 'PWD': '/builds/slave/test', 03:45:02 INFO - 'SHELL': '/bin/bash', 03:45:02 INFO - 'SHLVL': '1', 03:45:02 INFO - 'TERM': 'linux', 03:45:02 INFO - 'TMOUT': '86400', 03:45:02 INFO - 'USER': 'cltbld', 03:45:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:02 INFO - '_': '/tools/buildbot/bin/python'} 03:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:02 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:45:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:04 INFO - Installing collected packages: mozsystemmonitor 03:45:04 INFO - Running setup.py install for mozsystemmonitor 03:45:04 INFO - Successfully installed mozsystemmonitor 03:45:04 INFO - Cleaning up... 03:45:05 INFO - Return code: 0 03:45:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45:05 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:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 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:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:05 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:45:05 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:45:05 INFO - Using env: {'DISPLAY': ':0', 03:45:05 INFO - 'HOME': '/home/cltbld', 03:45:05 INFO - 'LANG': 'en_US.UTF-8', 03:45:05 INFO - 'LANGUAGE': 'en_US:en', 03:45:05 INFO - 'LOGNAME': 'cltbld', 03:45:05 INFO - 'MAIL': '/var/mail/cltbld', 03:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:05 INFO - 'MOZ_NO_REMOTE': '1', 03:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:05 INFO - 'NO_EM_RESTART': '1', 03:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:05 INFO - 'PWD': '/builds/slave/test', 03:45:05 INFO - 'SHELL': '/bin/bash', 03:45:05 INFO - 'SHLVL': '1', 03:45:05 INFO - 'TERM': 'linux', 03:45:05 INFO - 'TMOUT': '86400', 03:45:05 INFO - 'USER': 'cltbld', 03:45:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:05 INFO - '_': '/tools/buildbot/bin/python'} 03:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:05 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:07 INFO - warning: no files found matching '*.txt' 03:45:07 INFO - no previously-included directories found matching 'build' 03:45:07 INFO - no previously-included directories found matching 'dist' 03:45:07 INFO - no previously-included directories found matching '.git*' 03:45:07 INFO - Installing collected packages: jsonschema, functools32 03:45:07 INFO - Running setup.py install for functools32 03:45:07 INFO - warning: no files found matching '*.txt' 03:45:07 INFO - no previously-included directories found matching 'build' 03:45:07 INFO - no previously-included directories found matching 'dist' 03:45:07 INFO - no previously-included directories found matching '.git*' 03:45:07 INFO - Successfully installed jsonschema functools32 03:45:07 INFO - Cleaning up... 03:45:07 INFO - Return code: 0 03:45:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:07 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:07 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:45:07 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:45:07 INFO - Using env: {'DISPLAY': ':0', 03:45:07 INFO - 'HOME': '/home/cltbld', 03:45:07 INFO - 'LANG': 'en_US.UTF-8', 03:45:07 INFO - 'LANGUAGE': 'en_US:en', 03:45:07 INFO - 'LOGNAME': 'cltbld', 03:45:07 INFO - 'MAIL': '/var/mail/cltbld', 03:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:07 INFO - 'MOZ_NO_REMOTE': '1', 03:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:07 INFO - 'NO_EM_RESTART': '1', 03:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:07 INFO - 'PWD': '/builds/slave/test', 03:45:07 INFO - 'SHELL': '/bin/bash', 03:45:07 INFO - 'SHLVL': '1', 03:45:07 INFO - 'TERM': 'linux', 03:45:07 INFO - 'TMOUT': '86400', 03:45:07 INFO - 'USER': 'cltbld', 03:45:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:07 INFO - '_': '/tools/buildbot/bin/python'} 03:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:45:07 INFO - Cleaning up... 03:45:07 INFO - Return code: 0 03:45:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:07 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:07 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:45:07 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:45:07 INFO - Using env: {'DISPLAY': ':0', 03:45:07 INFO - 'HOME': '/home/cltbld', 03:45:07 INFO - 'LANG': 'en_US.UTF-8', 03:45:07 INFO - 'LANGUAGE': 'en_US:en', 03:45:07 INFO - 'LOGNAME': 'cltbld', 03:45:07 INFO - 'MAIL': '/var/mail/cltbld', 03:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:07 INFO - 'MOZ_NO_REMOTE': '1', 03:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:07 INFO - 'NO_EM_RESTART': '1', 03:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:07 INFO - 'PWD': '/builds/slave/test', 03:45:07 INFO - 'SHELL': '/bin/bash', 03:45:07 INFO - 'SHLVL': '1', 03:45:07 INFO - 'TERM': 'linux', 03:45:07 INFO - 'TMOUT': '86400', 03:45:07 INFO - 'USER': 'cltbld', 03:45:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:07 INFO - '_': '/tools/buildbot/bin/python'} 03:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:08 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:45:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - Downloading docopt-0.6.1.tar.gz 03:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:10 INFO - Running setup.py install for blobuploader 03:45:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:10 INFO - Running setup.py install for requests 03:45:11 INFO - Running setup.py install for docopt 03:45:11 INFO - Successfully installed blobuploader requests docopt 03:45:11 INFO - Cleaning up... 03:45:11 INFO - Return code: 0 03:45:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45: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:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:11 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:11 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:45:11 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:45:11 INFO - Using env: {'DISPLAY': ':0', 03:45:11 INFO - 'HOME': '/home/cltbld', 03:45:11 INFO - 'LANG': 'en_US.UTF-8', 03:45:11 INFO - 'LANGUAGE': 'en_US:en', 03:45:11 INFO - 'LOGNAME': 'cltbld', 03:45:11 INFO - 'MAIL': '/var/mail/cltbld', 03:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:11 INFO - 'MOZ_NO_REMOTE': '1', 03:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:11 INFO - 'NO_EM_RESTART': '1', 03:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:11 INFO - 'PWD': '/builds/slave/test', 03:45:11 INFO - 'SHELL': '/bin/bash', 03:45:11 INFO - 'SHLVL': '1', 03:45:11 INFO - 'TERM': 'linux', 03:45:11 INFO - 'TMOUT': '86400', 03:45:11 INFO - 'USER': 'cltbld', 03:45:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:11 INFO - '_': '/tools/buildbot/bin/python'} 03:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:11 INFO - Running setup.py (path:/tmp/pip-Vl48o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:11 INFO - Running setup.py (path:/tmp/pip-eXVuI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:11 INFO - Running setup.py (path:/tmp/pip-xIEFlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:11 INFO - Running setup.py (path:/tmp/pip-NvfOsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:11 INFO - Running setup.py (path:/tmp/pip-u4dN8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:11 INFO - Running setup.py (path:/tmp/pip-6wqZM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:12 INFO - Running setup.py (path:/tmp/pip-8k4koF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:12 INFO - Running setup.py (path:/tmp/pip-JVfwTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:12 INFO - Running setup.py (path:/tmp/pip-aDeLDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:12 INFO - Running setup.py (path:/tmp/pip-QIzAVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:12 INFO - Running setup.py (path:/tmp/pip-Tmfumg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:12 INFO - Running setup.py (path:/tmp/pip-SzReHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:12 INFO - Running setup.py (path:/tmp/pip-yXOgM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:12 INFO - Running setup.py (path:/tmp/pip-HcchOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:12 INFO - Running setup.py (path:/tmp/pip-I8Ohav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:12 INFO - Running setup.py (path:/tmp/pip-mBD4_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:12 INFO - Running setup.py (path:/tmp/pip-TruNF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:12 INFO - Running setup.py install for manifestparser 03:45:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:12 INFO - Running setup.py install for mozcrash 03:45:13 INFO - Running setup.py install for mozdebug 03:45:13 INFO - Running setup.py install for mozdevice 03:45:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Running setup.py install for mozfile 03:45:13 INFO - Running setup.py install for mozhttpd 03:45:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Running setup.py install for mozinfo 03:45:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Running setup.py install for mozInstall 03:45:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Running setup.py install for mozleak 03:45:13 INFO - Running setup.py install for mozlog 03:45:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Running setup.py install for moznetwork 03:45:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:13 INFO - Running setup.py install for mozprocess 03:45:14 INFO - Running setup.py install for mozprofile 03:45:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:14 INFO - Running setup.py install for mozrunner 03:45:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:14 INFO - Running setup.py install for mozscreenshot 03:45:14 INFO - Running setup.py install for moztest 03:45:14 INFO - Running setup.py install for mozversion 03:45:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:14 INFO - Cleaning up... 03:45:14 INFO - Return code: 0 03:45:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:14 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:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:14 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:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:14 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:14 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:45:14 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:45:14 INFO - Using env: {'DISPLAY': ':0', 03:45:14 INFO - 'HOME': '/home/cltbld', 03:45:14 INFO - 'LANG': 'en_US.UTF-8', 03:45:14 INFO - 'LANGUAGE': 'en_US:en', 03:45:14 INFO - 'LOGNAME': 'cltbld', 03:45:14 INFO - 'MAIL': '/var/mail/cltbld', 03:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:14 INFO - 'MOZ_NO_REMOTE': '1', 03:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:14 INFO - 'NO_EM_RESTART': '1', 03:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:14 INFO - 'PWD': '/builds/slave/test', 03:45:14 INFO - 'SHELL': '/bin/bash', 03:45:14 INFO - 'SHLVL': '1', 03:45:14 INFO - 'TERM': 'linux', 03:45:14 INFO - 'TMOUT': '86400', 03:45:14 INFO - 'USER': 'cltbld', 03:45:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:14 INFO - '_': '/tools/buildbot/bin/python'} 03:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:14 INFO - Running setup.py (path:/tmp/pip-_FLYuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:14 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:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:14 INFO - Running setup.py (path:/tmp/pip-U7ewCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:15 INFO - Running setup.py (path:/tmp/pip-hbghbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:15 INFO - Running setup.py (path:/tmp/pip-d60IrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:15 INFO - Running setup.py (path:/tmp/pip-I2WsOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:15 INFO - Running setup.py (path:/tmp/pip-wQOrOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:15 INFO - Running setup.py (path:/tmp/pip-4zIk0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:15 INFO - Running setup.py (path:/tmp/pip-OpVSj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:15 INFO - Running setup.py (path:/tmp/pip-0Hnt2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:15 INFO - Running setup.py (path:/tmp/pip-GqnPQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:15 INFO - Running setup.py (path:/tmp/pip-AK3kJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:15 INFO - Running setup.py (path:/tmp/pip-ZtUPtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:15 INFO - Running setup.py (path:/tmp/pip-zAXDqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:15 INFO - Running setup.py (path:/tmp/pip-WulWnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:15 INFO - Running setup.py (path:/tmp/pip-OFi4aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:15 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:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:15 INFO - Running setup.py (path:/tmp/pip-xkVeNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:16 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:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:16 INFO - Running setup.py (path:/tmp/pip-mikuZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:16 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:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:16 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:45:16 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:45:16 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:45:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45: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:45: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:45: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:45: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:45: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:45: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:45:18 INFO - Downloading blessings-1.6.tar.gz 03:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:18 INFO - Installing collected packages: blessings 03:45:18 INFO - Running setup.py install for blessings 03:45:18 INFO - Successfully installed blessings 03:45:18 INFO - Cleaning up... 03:45:18 INFO - Return code: 0 03:45:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:18 INFO - Reading from file tmpfile_stdout 03:45:18 INFO - Current package versions: 03:45:18 INFO - argparse == 1.2.1 03:45:18 INFO - blessings == 1.6 03:45:18 INFO - blobuploader == 1.2.4 03:45:18 INFO - docopt == 0.6.1 03:45:18 INFO - functools32 == 3.2.3-2 03:45:18 INFO - jsonschema == 2.5.1 03:45:18 INFO - manifestparser == 1.1 03:45:18 INFO - mozInstall == 1.12 03:45:18 INFO - mozcrash == 1.0 03:45:18 INFO - mozdebug == 0.1 03:45:18 INFO - mozdevice == 0.48 03:45:18 INFO - mozfile == 1.2 03:45:18 INFO - mozhttpd == 0.7 03:45:18 INFO - mozinfo == 0.9 03:45:18 INFO - mozleak == 0.1 03:45:18 INFO - mozlog == 3.4 03:45:18 INFO - moznetwork == 0.27 03:45:18 INFO - mozprocess == 0.23 03:45:18 INFO - mozprofile == 0.28 03:45:18 INFO - mozrunner == 6.13 03:45:18 INFO - mozscreenshot == 0.1 03:45:18 INFO - mozsystemmonitor == 0.3 03:45:18 INFO - moztest == 0.7 03:45:18 INFO - mozversion == 1.4 03:45:18 INFO - psutil == 3.1.1 03:45:18 INFO - requests == 1.2.3 03:45:18 INFO - wsgiref == 0.1.2 03:45:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:18 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:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:18 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:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:18 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:18 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:45:18 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:45:18 INFO - Using env: {'DISPLAY': ':0', 03:45:18 INFO - 'HOME': '/home/cltbld', 03:45:18 INFO - 'LANG': 'en_US.UTF-8', 03:45:18 INFO - 'LANGUAGE': 'en_US:en', 03:45:18 INFO - 'LOGNAME': 'cltbld', 03:45:18 INFO - 'MAIL': '/var/mail/cltbld', 03:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:18 INFO - 'MOZ_NO_REMOTE': '1', 03:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:18 INFO - 'NO_EM_RESTART': '1', 03:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:18 INFO - 'PWD': '/builds/slave/test', 03:45:18 INFO - 'SHELL': '/bin/bash', 03:45:18 INFO - 'SHLVL': '1', 03:45:18 INFO - 'TERM': 'linux', 03:45:18 INFO - 'TMOUT': '86400', 03:45:18 INFO - 'USER': 'cltbld', 03:45:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:18 INFO - '_': '/tools/buildbot/bin/python'} 03:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 INFO - Cleaning up... 03:45:18 INFO - Return code: 0 03:45:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:18 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:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:18 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:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:18 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 0x7f54e5ca1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, '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': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', '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:45:18 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:45:18 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:45:18 INFO - Using env: {'DISPLAY': ':0', 03:45:18 INFO - 'HOME': '/home/cltbld', 03:45:18 INFO - 'LANG': 'en_US.UTF-8', 03:45:18 INFO - 'LANGUAGE': 'en_US:en', 03:45:18 INFO - 'LOGNAME': 'cltbld', 03:45:18 INFO - 'MAIL': '/var/mail/cltbld', 03:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:18 INFO - 'MOZ_NO_REMOTE': '1', 03:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:18 INFO - 'NO_EM_RESTART': '1', 03:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:18 INFO - 'PWD': '/builds/slave/test', 03:45:18 INFO - 'SHELL': '/bin/bash', 03:45:18 INFO - 'SHLVL': '1', 03:45:18 INFO - 'TERM': 'linux', 03:45:18 INFO - 'TMOUT': '86400', 03:45:18 INFO - 'USER': 'cltbld', 03:45:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:18 INFO - '_': '/tools/buildbot/bin/python'} 03:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:18 INFO - Cleaning up... 03:45:18 INFO - Return code: 0 03:45:18 INFO - Running post-action listener: _resource_record_post_action 03:45:18 INFO - Running post-action listener: _start_resource_monitoring 03:45:19 INFO - Starting resource monitoring. 03:45:19 INFO - [mozharness: 2016-11-25 11:45:19.019108Z] Finished create-virtualenv step (success) 03:45:19 INFO - [mozharness: 2016-11-25 11:45:19.019650Z] Running install step. 03:45:19 INFO - Running pre-action listener: _resource_record_pre_action 03:45:19 INFO - Running main action method: install 03:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:19 INFO - Reading from file tmpfile_stdout 03:45:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:19 INFO - Reading from file tmpfile_stdout 03:45:19 INFO - Output received: 03:45:19 INFO - Usage: mozinstall [options] installer 03:45:19 INFO - Options: 03:45:19 INFO - -h, --help show this help message and exit 03:45:19 INFO - -d DEST, --destination=DEST 03:45:19 INFO - Directory to install application into. [default: 03:45:19 INFO - "/builds/slave/test"] 03:45:19 INFO - --app=APP Application being installed. [default: firefox] 03:45:19 INFO - mkdir: /builds/slave/test/build/application 03:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:45:35 INFO - Reading from file tmpfile_stdout 03:45:35 INFO - Output received: 03:45:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:35 INFO - Running post-action listener: _resource_record_post_action 03:45:35 INFO - [mozharness: 2016-11-25 11:45:35.228878Z] Finished install step (success) 03:45:35 INFO - [mozharness: 2016-11-25 11:45:35.229121Z] Running run-tests step. 03:45:35 INFO - Running pre-action listener: _resource_record_pre_action 03:45:35 INFO - Running main action method: run_tests 03:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:35 INFO - Python 2.7.3 03:45:35 INFO - Return code: 0 03:45:35 INFO - grabbing minidump binary from tooltool 03:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:35 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 0x119bf60>, '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 0x119cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:35 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:45:35 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:45:35 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:45:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:35 INFO - Return code: 0 03:45:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:45:35 INFO - Using env: {'DISPLAY': ':0', 03:45:35 INFO - 'HOME': '/home/cltbld', 03:45:35 INFO - 'LANG': 'en_US.UTF-8', 03:45:35 INFO - 'LANGUAGE': 'en_US:en', 03:45:35 INFO - 'LOGNAME': 'cltbld', 03:45:35 INFO - 'MAIL': '/var/mail/cltbld', 03:45:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:35 INFO - 'MOZ_NO_REMOTE': '1', 03:45:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:35 INFO - 'NO_EM_RESTART': '1', 03:45:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:35 INFO - 'PWD': '/builds/slave/test', 03:45:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:35 INFO - 'SHELL': '/bin/bash', 03:45:35 INFO - 'SHLVL': '1', 03:45:35 INFO - 'TERM': 'linux', 03:45:35 INFO - 'TMOUT': '86400', 03:45:35 INFO - 'USER': 'cltbld', 03:45:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1480074280.430267-1456604095', 03:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:35 INFO - '_': '/tools/buildbot/bin/python'} 03:45:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:45:35 INFO - mozversion application_buildid: 20161125004006 03:45:35 INFO - mozversion application_changeset: 55b599ca3530c8286f6ad15405d99d2bcaecfbd1 03:45:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:45:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:35 INFO - mozversion application_name: Firefox 03:45:35 INFO - mozversion application_remotingname: firefox-dev 03:45:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:45:35 INFO - mozversion application_vendor: Mozilla 03:45:35 INFO - mozversion application_version: 52.0a2 03:45:35 INFO - mozversion platform_buildid: 20161125004006 03:45:35 INFO - mozversion platform_changeset: 55b599ca3530c8286f6ad15405d99d2bcaecfbd1 03:45:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:45:35 INFO - mozversion platform_version: 52.0a2 03:45:35 INFO - using testdate: 1480074335 03:45:35 INFO - actual date: 1480074335 03:45:35 INFO - starting webserver on 'localhost:51503' 03:45:35 INFO - SUITE-START | Running 2 tests 03:45:35 INFO - TEST-START | dromaeo_css 03:45:35 INFO - operating with platform_type : linux_ 03:45:35 INFO - Initialising browser for dromaeo_css test... 03:45:35 INFO - TEST-INFO | started process 22181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTUubfv/profile http://localhost:51503/getInfo.html) 03:45:39 INFO - PROCESS | 22181 | __metrics Screen width/height:1600/1200 03:45:39 INFO - PROCESS | 22181 | colorDepth:24 03:45:39 INFO - PROCESS | 22181 | Browser inner width/height: 1024/697 03:45:39 INFO - PROCESS | 22181 | __metrics 03:45:40 INFO - PROCESS | 22181 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:45:40 INFO - PROCESS | 22181 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:41 INFO - PROCESS | 22181 | console.error: PushService: 03:45:41 INFO - PROCESS | 22181 | stateChangeProcessEnqueue: Error transitioning state 03:45:41 INFO - PROCESS | 22181 | UnknownError 03:45:41 INFO - TEST-INFO | 22181: exit 0 03:45:41 INFO - Browser initialized. 03:45:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:41 INFO - TEST-INFO | started process 22273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTUubfv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:53 INFO - PROCESS | 22273 | RSS: Main: 145203200 03:45:53 INFO - PROCESS | 22273 | 03:46:45 INFO - PROCESS | 22273 | 1480074405253 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:48:55 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51503/tests/dromaeo/cssquery-ext.html) 03:48:56 INFO - PROCESS | 22273 | RSS: Main: 248000512 03:48:56 INFO - PROCESS | 22273 | 03:51:59 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-ext.html (next: http://localhost:51503/tests/dromaeo/cssquery-jquery.html) 03:51:59 INFO - PROCESS | 22273 | RSS: Main: 223268864 03:51:59 INFO - PROCESS | 22273 | 03:55:01 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51503/tests/dromaeo/cssquery-mootools.html) 03:55:02 INFO - PROCESS | 22273 | RSS: Main: 174850048 03:55:02 INFO - PROCESS | 22273 | 03:58:04 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51503/tests/dromaeo/cssquery-prototype.html) 03:58:04 INFO - PROCESS | 22273 | RSS: Main: 225693696 03:58:04 INFO - PROCESS | 22273 | 04:01:07 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51503/tests/dromaeo/cssquery-yui.html) 04:01:08 INFO - PROCESS | 22273 | RSS: Main: 175943680 04:01:08 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | Cycle 1(1): loaded http://localhost:51503/tests/dromaeo/cssquery-yui.html (next: http://localhost:51503/tests/dromaeo/cssquery-dojo.html) 04:04:10 INFO - PROCESS | 22273 | RSS: Main: 256729088 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | __start_tp_report 04:04:10 INFO - PROCESS | 22273 | _x_x_mozilla_page_load 04:04:10 INFO - PROCESS | 22273 | _x_x_mozilla_page_load_details 04:04:10 INFO - PROCESS | 22273 | |i|pagename|runs| 04:04:10 INFO - PROCESS | 22273 | |0;dojo.html;3223.903282901513;3258.9511157332636;3270.8201048942315;3291.0291464018114;3318.2533929865785;5561.777528898844;5619.072852979264;5627.6904770237625;5633.070543360341;5653.886922261558;5595.076812325961;5648.491635752782;5656.179853921179;5662.150677398392;5672.5178359839465;5106.208537676647;5131.307273518083;5134;5159.71621560814;5197;5028.371453568304;5046.369203849519;5209.635325527196;5212;5228.137357336035;5092.28707980883;5100.84697459075;5131.204663277198;5134.229865520183;5149.485051494858;5153.6392452528335;5172.043172013171;5220.556252718524;5230.843074707765;5255.343082114736;4860.3681521401995;5104.489551044903;5129.179331306973;5173.508516690946;5185.662931909414;5404.32445944257;5459.563234941234;5474.343078830526;5504.972475137599;5567.749451274662;5884.205632239678;5884.323302820145;6007.729652165663;6011.909821352683;6013.188219590387;5833.708314584296;6041.577089603729;6061.393860613904;6065.8180254592435;6071.483923866476;5464.672119672792;5578.609497335228;5615.691136987423;5619.831405057855;5661.150827375926;6170.043643235305;6179.969100154471;6184.721687524072;6186.845328866724;6190.597611155261;5766.88466230673;5959.910601340984;5963.9563076461445;5974.074018527135;5974.671393073423;5894.086416605433;5925.229720136441;5972.701364931736;5979.252593425822;6081.087836824512;6023.3073196582955;6034;6034.48706859913;6034.577579569388;6067.393260673897;5966.701664916737;6028.909566356509;6031.185789918392;6036.577439579275;6037.78867739627;4529.980754330315;4552.339910712928;4593.356930029799;4628.375169352162;4637.9536204637525;4151.294279972412;4174.373843923375;4185.895352616148;4199.454070970754;4210.705250632487;5841.4450627190345;5841.795537156179;5848.53211743068;5852;5857.619254748428;5808;5848.298204215522;5870.5890587659305;5937.495312898452;6113.694315284218;5768.2501274834;5774.162746401748;5775.451332123442;5776.133579962955;5810.941890581124;5232.215167724872;5236.1098613235845;5245.26566280721;5247.790088396421;5247.947520524746;6007.729652165663;6068.6358818471035;6147.0779383092895;6248.28144763349;6286.937130628727;5961.850953726192;6084.847878803065;6092.817215483543;6112.541559383153;6120.326764056039;6278.125452629363;6302.9684851577285;6312;6312.905306420315;6326.493880489642;5667.914981275367;5689.601727879009;5946.613470124428;5946.821595352147;5949.2266005419015;6009.789657361971;6049.727762250621;6052.969735151296;6101.145839582551;6137.232845894263;5907.202527658711;5928.822135335947;5951.523878089656;5962.821115366546;5966.970165149147;5635.746391412315;5933.940660593339;5942.821715348547;5962.791302304398;5972.104184372379;5693.202951586864;5725.370209277059;5820.854478637899;5823.621464604787;5924.674142922008;5962.582619216787;5977.7310021050025;5981.491573216325;5981.611195272293;5983;5573.498385145356;5626.043572592587;5627.43725627434;5812.128180772918;5827.125931110198 04:04:10 INFO - PROCESS | 22273 | |1;ext.html;573.3979321712201;609.338867328948;634.1597383466908;635.7425242776676;642.6947200079966;33199.66800331996;36475.63524364756;44627;44915.77542112289;44947.77526112365;46168.76915615426;46673.53326466734;46799;46870.76564617181;46922.53077469224;8309.293710034653;8818.470891746483;8983.281337493017;8985.056569060253;8986.460812351248;8183.836323273531;10514.10630096439;10738.08726258269;10751.677449676523;11178.217524773268;10966.725831854188;11024.889751102506;11033.282836615634;11035.44822758863;11038.11695064397;10827.350358978447;10857.619983300625;10868.402237876913;10880.564777408894;10909.454527273605;10623.681289561326;10679.199060070448;10683.252172347939;10701.732456688567;10717.624883129052;42609.786951065355;42905.35641965342;42982.78508607437;43222.78388608037;43316.56683433157;3623.1123374773088;3788.6211378861894;3903.1022864741267;4073.959260407388;4292.699511034229;31191.688083119105;32194.678053219635;32261.51607725886;32633.347333053443;33119.66880331214;4103.117829666636;4174.791260436966;4176.853810116661;4177.8537751178565;4289.721168124093;499115;499298;504269.99999999633;506597.8020659386;507724;62470.68764656239;62583.37416625866;63043.36956630467;63046.684766575876;63117.68441157765;39321;40025.79987100104;42277;65046.34953650403;65535.34464655388;19034.143463544173;19181.61636767257;19226.8077319225;19232.61534769297;19234.615307693766;13625.795613065811;13860.306984650928;14705.705885882222;14942.103473791607;15095.54713358601;19319.130639121275;19961.401157965283;20122.69815952762;20162.59674806525;20256.696149557767;7123.216446190915;7280.526765760209;7517.736879209311;7604.201558836353;7610.771676849703;985.2167526816198;999.9200063995008;1047.6542740895638;1069.9251052426255;1107.5126944144552;31467.37065258682;33106.66893331084;33321.50017749736;33433;33897;1017.7481697511954;1087.0814162033228;1123.7696272264166;1139.811931031387;1163.5462169753803;14872;17835.910820445813;17841.910790445963;18242.726359104625;18585.44243672692;569382;570140;572020;572628;572701;59895;60606;60690.393096069354;60787;60813.695931520946;1312.3503865586595;1353.0731448957495;1359.8912087033013;1389.4164450930634;1405.0656313551374;29813;34163.65836341605;34840.82579587086;34892.82553587318;35441.0507422084;50891.236631449814;57827.42172578389;58820;58967.41032589619;65918.34081659123;518843;519752;523227;524223;524319;30175.698243018167;30217.848910755307;32058.83970580132;32168;45378.54621453743;48522;48807.26789098237;48853.2672009913;50142.749286254795;50768;40193;41428;41626.167476649694;41761;41821.79089104535;40995.38506922339;41115.383269250386;41234.79382603068;42351;42398.576014240694;41995;42440;43130.35304470373;43528.78235608801;43649.34525982049;34844;36785.04822028841;36933.445998310584;36985.260294793414;37802;28906.42187156287;29034.564481532372;29084.7091529082;29262.26844328909;29361.853190734764 04:04:10 INFO - PROCESS | 22273 | |2;jquery.html;396.6715380715199;432.09937301298254;434.55241101665274;434.88258170294023;449.3551753234111;16383.18084095795;19235.90382048091;19763.70354444681;20459.386218413434;20643.793562064377;20363.694544581842;20612.89693551534;20734.585308293863;20780.68828967563;20975.37073887782;5689.857753556153;5923.437273459036;5926.377730338317;5928.911066334009;5933.762649494015;5667.744951477172;5902.940970590304;5941.584089113764;5999.280086389639;6013.789517366893;5562.916556251659;5984.311804142514;5991.730372133243;5996.790112346069;5997.220361353018;5767.538596912258;5952.017917043682;5952.55355848311;5953.047512398039;5955.13650520672;5623.9437605623825;5775.27809023872;5786.276715410574;5788.913166302509;5820.1560773688;13175.868241317656;13364.465421383133;13366.13120147197;15577.688446231125;23871.403214919592;2333.7666233376694;2410;2410.9999999999823;2524.583443731782;2770.4043630619312;9991.850122248172;10398.844017339747;10492.842607360895;10983.61557345489;10991.120710343153;1963.9509012274807;1998.7201791749167;2071.5753270579494;2102.8107470327745;2136.220279597951;80597.59701201515;83501.16498835056;85457.14542854554;89181.55409223042;89707.55146224292;10653.680389588324;11436.681942896594;11566.843315668366;11810.759870213677;12286.447109880077;16113.194340283173;16130.435434759727;16138.273777680033;16140.35438582467;16144;7371.9262807372315;7926;8707.738767836974;8840.513771742488;8852.38033337673;8280.544570048705;8453.408261421642;8458.154184581615;8544.487330760174;9120.908790912006;5095.643304968617;5151.407588127338;5160.870978225575;5197.506236907488;5275.419703832576;1771.9631562492584;1949.8440124789984;2083.6874468829797;2158.341705779721;2172.6197915364746;971.5190980464715;986.240594742059;998.605550807427;1005.0251256281396;1060.6552870317178;19873.30443434473;19964.60070798576;20047.498812529804;20086.69869951952;20271;988.8071825993862;997.0129571724086;1015.6445244164483;1034.5861655337926;1094.0591091661165;10723.517441715141;11099.668039835271;11261.549538018551;11418.600348987911;11454.713632159095;464533;467409;469270;475561;482084;97576;98709.50645246728;98710.5064474673;98778;102215.48892255491;1013.7110923386799;1037.419045334615;1074.2319241742036;1096.5120521367915;1099.0273607856943;17495.650086997935;17752.64494710073;18191.45425637233;18279.17743701563;18307.633847323246;31716;41184.176316472905;41880.58119418767;43435.78282108569;44196;57753.13370299365;59672.70163649154;61864;62473.37526624675;63954;9004.549772511216;9107.817843643223;9219.677311294072;9225.308101892519;9309.767255818659;10071.34536255141;13272.668183295495;13765.862341376458;13942.093763905314;14207.573772786833;12098.818517722066;12133.514659413524;12154.574589889311;12251.632451026484;12462.252264863775;5751.798687045934;9644.505101709246;10635.680929572125;11859.70350741204;11866.228695134789;12284.262944223376;12308.938455307667;12445.62663120108;12641.115121941375;12906.290154041619;9162.404443711404;9366.625334986524;9527.523623818643;9636;9636.373635713657;11623.418829058344;12465.875341246472;12555.87444125547;12671.936640316739;12954.157979731288 04:04:10 INFO - PROCESS | 22273 | |3;mootools.html;1448.2179623003583;1498.325753410965;1647.5057482755178;1798.7751531058618;1832.9816701832985;8957.507337096456;9356.578953947072;9369.812603747921;9372.437653740762;9378.85931711025;8068.112507624157;8285.171482851712;8691.39160258782;8963.372563920528;9195.264378849693;2486.3038349262238;2519.5842685956795;2523.4196134888894;2527.36815796051;2530.253575195322;2449.1795248591743;2537.3656585853537;2539.7460253974546;2540.8602526861014;2540.9110681126162;2497.67530221071;2506.4235225898055;2511.7739403453684;2520.18094119411;2520.6597109390273;2456.5578195924727;2457.103157347573;2484.366486545919;2486.689163854518;2491.2899823550383;2401.86789726565;2436.7197772256063;2457.5822110241124;2459.9754002459927;2509.0716434919195;9158.49628270445;9338.906610933871;9355.578998945064;9363.906360936371;9372.67195648149;5201.063808514466;5305.867353316159;5315.574754019669;5316.3620365556;5322.973385133049;3335.483000134983;3467.289205712823;3497.5278337424375;3538.062413460435;3548.059764162499;1092.2627226622078;1114.4650567727456;1131.0612191880718;1146.7534480086738;1198.3768440411025;11935.283882967049;11948.701282468008;12015.699607509881;12029.458674359676;12315.322657253848;4758.547937945889;5004.324416203839;5039.44566097729;5075;5152.3044389007;10890.72773180661;10890.782184356269;10897.891021089847;10906.5092070857;10916.563337466412;5652.3217213934595;5656.038473459522;5660.801871934463;5663.348714897839;5663.915041274384;4622.6764126510825;4678.1813182692895;5123.5132662397755;5154.8969020620125;5261.394939581921;4141.804843432986;4195.790210489463;4244.91510169801;4294.3558466230315;4297.742135471882;1388.4515616331491;1445.7469942759974;1448.0515262503077;1449.4492093004592;1453.571196497036;966.5505539923969;978.1245785022365;980.887197972228;990.4997976022063;999.1157825324494;6022.18700475439;6041.154238406627;6107.96946015276;6204.976178930516;6208.4722798562625;442.55081092690943;459.07496394764576;464.2780476359294;466.75728621116826;488.04343486766334;3901.921961560753;4055.8377664893073;4061.4517040199194;4065.6950728695465;4105.548389677133;10831.187660925305;10949.83575246372;11085.168612353944;11178.664640060812;11454.828177577343;11458.656240312637;11493.597724079616;11510.424478776027;11521.539138434537;11539.884601154048;8354.248117669438;8648.394612377073;8648.69729559475;8725.952885653762;8728.127187281349;6058.363871793398;6111.083337499233;6142.78500252489;6163.167972323679;6202.782902598387;9867;9877.851832222379;9977.45124018157;9996.600135994478;10017.098461138532;10227.335223210468;10295.742606434898;10307.072363487323;10402.531886065297;10403.895961040596;7126.2873712628325;7787;8116.75649730509;8200.876986845084;8277.917220827714;8667.393282470166;8856.822863542822;8858.379913406;8865.64537418496;8870.64517419296;7673.923260767321;7838.608069596611;7887.092984306649;7918.722844700408;8164.673413063411;7600.1639819620905;7623.275788800055;7709.113451953097;7776;7857.960710196641;6961.756338528127;7147.53541019832;7155.069840920647;7211.278872112956;7260.382867456326;5204.401493828107;5225.973870130625;5337.839864804062;5372.167314066326;5392.865178370572;5303.4696530346655;5355.410904800391;5388.73056347189;5396.595255355943;5408.972295264045 04:04:10 INFO - PROCESS | 22273 | |4;prototype.html;341.89059500959695;355.1901664205611;356.46708171283916;365.98170091495416;367.9264147170565;5488.4785945335225;5496.790706044669;5497.725113744312;5503.532199763025;5523.7238138093135;5149.536541711245;5281.207818827178;5316.415194328621;5386.515213630772;5420.295361602996;4339.761313127777;4340.283853164224;4345.760983145926;4348.173846969065;4351.542233351815;4334.60988511034;4349.586789255016;4356.083323337722;4361.389405483219;4362.171187474386;4109.5753505431785;4189.434426352449;4240.936385954213;4243.745375277494;4333.739975601458;4194.538600753915;4211.241976444238;4234.87295381139;4240.618344349008;4249.6387807036435;3709.9629003710156;3713.721470889694;3714.201446688975;3716.7769933804057;3726.441033844918;5191.169412893919;5242.6330156889035;5309.4425085365865;5315.813946511854;5322.574194064504;4729.290606409032;4779.187538118494;4792.592629626486;4805.327254184417;4807.038592281523;5672.653134650576;5682.147677848315;5688.203651488795;5690.345610254791;5708.857278568027;3943.743656662308;3999.1201935574127;4009.438678584971;4086.4483294755423;4118.320477121271;5885.911711324334;5911.640322725797;5917.8816423671715;5917.8816423671715;5927.466528012456;4207.516135644379;4227.492700875853;4236.406903033578;4238.788060596958;4240.809163587646;4157.792110394468;4240.533541310453;4259.701820872571;4269.146170765859;4275.508316543637;4853.174960256765;4855.6115510759055;4855.708657480563;4867.245576935581;4871.732054736953;5698.145278208219;5732.283464566929;5733.226014488074;5736.9633780008335;5745.913811292834;1351.1352734250088;1375.9587212383644;1377.8622137786142;1426.2512181104796;1439.784032395149;954.7851733359938;987.5753426026733;990.2672022703292;996.6113215845826;1002.9448380339152;5380.1929710542945;5386.973065134649;5392.7057506198225;5418.376886658006;5419.566434685295;5650.604457688005;5669.801556945487;5669.914951275734;5673.943260567342;5676.120201368794;5134.306868572769;5274.604404669665;5322.4411436799355;5335.759890804923;5399.433059528693;2977.285451491626;2978.9594128022372;2987.4622567937545;2994.8352840593975;3005.3989202159655;5746.770129194785;5749.425057494217;5782.971085144547;5794.391588883106;5819.73811178498;5449.509544141047;5670.914936275959;5699.914501282484;5729.5702822288495;5772.422757724278;5872.473156979217;5888.499477544371;5896.3219229788265;5899.026660601038;5903.527717782653;5601.6358936668985;5667.744951477276;5673;5682.545396368363;5893.263342082239;5849.268841394825;5854.970725146347;5870.414987953314;5886.087656413263;5906.995810712103;6081.209442772411;6092.45167934888;6119.0821376792055;6188.752449901954;6198.256209254918;4016.979915100406;4038.0106873816103;4194.085110847931;4227.408162857264;4246.193223287565;5727.821059312122;5728.567858035492;5731.942680573307;5910.231669882888;5941.346451890375;5754.395788442153;5760.654360738369;5769.624974376652;5775.7400916957995;5777.6822274775295;5623.015318248016;5700.771969121354;5742.224799651994;5756.913646295393;5759.769609215585;5697.829065128053;5706.771729130788;5713.257276554022;5713.571482138773;5714.971425143014;5645.604807663424;5806.622569532967;5808.796692115756;5810.658871149021;5810.767569297181;5604.159376093618;5635.549156067586;5637.238972738792;5642.069058605284;5656.1798539212405 04:04:10 INFO - PROCESS | 22273 | |5;yui.html;700.9439244860412;730.7077169132347;735.6983636708949;765.6478020110749;873.2271939333688;14976.400943962228;15600.219989000561;15632.062076275432;15658.608534786636;15658.765118523232;14345.282735863217;14410.135391876494;14417.78373324401;14418.495352662632;14428.495002674908;712.7968528969245;724.800679813053;823.0781524692353;829.2950991657088;843.5529169540154;834.0616806093145;841.6044459104211;849.8087930215714;849.8300339932007;849.8725191221305;889.7108439757105;890.7906641939139;890.9109089091104;891.189017993626;891.2914233184601;741.0847603210032;756.3873262657265;888.4669198480924;888.6711916590871;889.7375274294099;628.2304177382715;634.7334119669704;642.4474951541671;644.1979735229622;644.5101722690742;14459.060161089601;14484.275786210648;14499.275036248146;14504;14512.201828899406;11832.763344733143;12283.93858030713;12948.15836970594;13040.347982600832;13102.606921792361;11317.264377815416;11465;11557.711057223552;11664.183507154503;11772.88227117735;3946.638409748632;3972.086420123359;3972.304846651853;3989.780562069085;4007.5992400759983;63806;64701;65169.348306516804;65401.34598654;66278.3372166277;9903;9974.451405172786;10135.239857010754;10395;10404.947975260075;17285.91357043232;17328.220230089675;17345.132743363032;17358.218880150424;17377.131143442777;7601.7719468416035;7713.537187768752;7773.3004029637605;7838.764837054898;8049.9597502013285;4333.306670932636;4405.515393306734;4414.646828253732;4447.911041779146;4471.374007638933;3478.095695119287;3573.4103872860687;3576.141725985745;3576.302620988934;3585.695215906625;579.3829571506333;607.6050567131311;614.2536817766435;616.9228846394201;643.2666759893725;671.194566520168;711.3420086420041;722.9674664640104;725.2348772045437;745.7613563659577;8484.872726909101;9237.307201959746;9407.43555386679;9568.234541236685;9644.469554174588;721.6103304215665;727.9090113735783;745.2026331825003;761.303407382239;772.6870617399962;4292.055747735493;4416.470023597189;4639.211334073216;4707.152712511781;4720.103180395714;50467.99064018699;67227;82104.58947705342;91263;91888;75964;76678;76701.61649191719;78746;79113;46951;53198.734006330495;70523.64738176379;70820;72203.63898180476;8707.521086340312;8932.732018039469;8946.37375383743;8953;8996.235319997611;47556;47570.762146189045;48279.27581086357;48629.27056094091;49019.754901225264;57237;58691.70654146702;59128.70435647966;62215.37784622096;65919.67040164769;12489.562865299671;12827.358632068546;13397.665058373228;13979.440822367398;14036.508722194674;13603.387847546686;13723.656908577366;13748.518801841887;14417.495387661382;14563.708725825636;12750.61748147557;12793.744125117259;13406.061575689608;13407.061505694508;13507.864921350661;12362.938185309016;12468.376581170724;12589.874101259236;12740.490380384681;12831.550895718605;12457.501699931901;12787.552435664707;12812.87187128154;12820.294883781482;13114.409851556893;10184.978052187444;10655.627053053106;10852.511636976196;10986.560537578727;11351.943240283746;10075.949620251851;10154.593816247563;10177.745556361151;10180.236482264008;10200 04:04:10 INFO - PROCESS | 22273 | __end_tp_report 04:04:10 INFO - PROCESS | 22273 | __start_cc_report 04:04:10 INFO - PROCESS | 22273 | _x_x_mozilla_cycle_collect,1038 04:04:10 INFO - PROCESS | 22273 | __end_cc_report 04:04:10 INFO - PROCESS | 22273 | __startTimestamp1480075450847__endTimestamp 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | ------- Summary: start ------- 04:04:10 INFO - PROCESS | 22273 | Number of tests: 6 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | [#0] dojo.html Cycles:165 Average:5598.07 Median:5823.62 stddev:627.98 (10.8%) stddev-sans-first:601.65 04:04:10 INFO - PROCESS | 22273 | Values: 3223.9 3259.0 3270.8 3291.0 3318.3 5561.8 5619.1 5627.7 5633.1 5653.9 5595.1 5648.5 5656.2 5662.2 5672.5 5106.2 5131.3 5134.0 5159.7 5197.0 5028.4 5046.4 5209.6 5212.0 5228.1 5092.3 5100.8 5131.2 5134.2 5149.5 5153.6 5172.0 5220.6 5230.8 5255.3 4860.4 5104.5 5129.2 5173.5 5185.7 5404.3 5459.6 5474.3 5505.0 5567.7 5884.2 5884.3 6007.7 6011.9 6013.2 5833.7 6041.6 6061.4 6065.8 6071.5 5464.7 5578.6 5615.7 5619.8 5661.2 6170.0 6180.0 6184.7 6186.8 6190.6 5766.9 5959.9 5964.0 5974.1 5974.7 5894.1 5925.2 5972.7 5979.3 6081.1 6023.3 6034.0 6034.5 6034.6 6067.4 5966.7 6028.9 6031.2 6036.6 6037.8 4530.0 4552.3 4593.4 4628.4 4638.0 4151.3 4174.4 4185.9 4199.5 4210.7 5841.4 5841.8 5848.5 5852.0 5857.6 5808.0 5848.3 5870.6 5937.5 6113.7 5768.3 5774.2 5775.5 5776.1 5810.9 5232.2 5236.1 5245.3 5247.8 5247.9 6007.7 6068.6 6147.1 6248.3 6286.9 5961.9 6084.8 6092.8 6112.5 6120.3 6278.1 6303.0 6312.0 6312.9 6326.5 5667.9 5689.6 5946.6 5946.8 5949.2 6009.8 6049.7 6053.0 6101.1 6137.2 5907.2 5928.8 5951.5 5962.8 5967.0 5635.7 5933.9 5942.8 5962.8 5972.1 5693.2 5725.4 5820.9 5823.6 5924.7 5962.6 5977.7 5981.5 5981.6 5983.0 5573.5 5626.0 5627.4 5812.1 5827.1 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | [#1] ext.html Cycles:180 Average:68789.63 Median:22549.25 stddev:141608.57 (628.0%) stddev-sans-first:141913.19 04:04:10 INFO - PROCESS | 22273 | Values: 573.4 609.3 634.2 635.7 642.7 33199.7 36475.6 44627.0 44915.8 44947.8 46168.8 46673.5 46799.0 46870.8 46922.5 8309.3 8818.5 8983.3 8985.1 8986.5 8183.8 10514.1 10738.1 10751.7 11178.2 10966.7 11024.9 11033.3 11035.4 11038.1 10827.4 10857.6 10868.4 10880.6 10909.5 10623.7 10679.2 10683.3 10701.7 10717.6 42609.8 42905.4 42982.8 43222.8 43316.6 3623.1 3788.6 3903.1 4074.0 4292.7 31191.7 32194.7 32261.5 32633.3 33119.7 4103.1 4174.8 4176.9 4177.9 4289.7 499115.0 499298.0 504270.0 506597.8 507724.0 62470.7 62583.4 63043.4 63046.7 63117.7 39321.0 40025.8 42277.0 65046.3 65535.3 19034.1 19181.6 19226.8 19232.6 19234.6 13625.8 13860.3 14705.7 14942.1 15095.5 19319.1 19961.4 20122.7 20162.6 20256.7 7123.2 7280.5 7517.7 7604.2 7610.8 985.2 999.9 1047.7 1069.9 1107.5 31467.4 33106.7 33321.5 33433.0 33897.0 1017.7 1087.1 1123.8 1139.8 1163.5 14872.0 17835.9 17841.9 18242.7 18585.4 569382.0 570140.0 572020.0 572628.0 572701.0 59895.0 60606.0 60690.4 60787.0 60813.7 1312.4 1353.1 1359.9 1389.4 1405.1 29813.0 34163.7 34840.8 34892.8 35441.1 50891.2 57827.4 58820.0 58967.4 65918.3 518843.0 519752.0 523227.0 524223.0 524319.0 30175.7 30217.8 32058.8 32168.0 45378.5 48522.0 48807.3 48853.3 50142.7 50768.0 40193.0 41428.0 41626.2 41761.0 41821.8 40995.4 41115.4 41234.8 42351.0 42398.6 41995.0 42440.0 43130.4 43528.8 43649.3 34844.0 36785.0 36933.4 36985.3 37802.0 28906.4 29034.6 29084.7 29262.3 29361.9 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | [#2] jquery.html Cycles:180 Average:28945.34 Median:2467.79 stddev:78168.19 (3167.5%) stddev-sans-first:78358.08 04:04:10 INFO - PROCESS | 22273 | Values: 396.7 432.1 434.6 434.9 449.4 16383.2 19235.9 19763.7 20459.4 20643.8 20363.7 20612.9 20734.6 20780.7 20975.4 5689.9 5923.4 5926.4 5928.9 5933.8 5667.7 5902.9 5941.6 5999.3 6013.8 5562.9 5984.3 5991.7 5996.8 5997.2 5767.5 5952.0 5952.6 5953.0 5955.1 5623.9 5775.3 5786.3 5788.9 5820.2 13175.9 13364.5 13366.1 15577.7 23871.4 2333.8 2410.0 2411.0 2524.6 2770.4 9991.9 10398.8 10492.8 10983.6 10991.1 1964.0 1998.7 2071.6 2102.8 2136.2 80597.6 83501.2 85457.1 89181.6 89707.6 10653.7 11436.7 11566.8 11810.8 12286.4 16113.2 16130.4 16138.3 16140.4 16144.0 7371.9 7926.0 8707.7 8840.5 8852.4 8280.5 8453.4 8458.2 8544.5 9120.9 5095.6 5151.4 5160.9 5197.5 5275.4 1772.0 1949.8 2083.7 2158.3 2172.6 971.5 986.2 998.6 1005.0 1060.7 19873.3 19964.6 20047.5 20086.7 20271.0 988.8 997.0 1015.6 1034.6 1094.1 10723.5 11099.7 11261.5 11418.6 11454.7 464533.0 467409.0 469270.0 475561.0 482084.0 97576.0 98709.5 98710.5 98778.0 102215.5 1013.7 1037.4 1074.2 1096.5 1099.0 17495.7 17752.6 18191.5 18279.2 18307.6 31716.0 41184.2 41880.6 43435.8 44196.0 57753.1 59672.7 61864.0 62473.4 63954.0 9004.5 9107.8 9219.7 9225.3 9309.8 10071.3 13272.7 13765.9 13942.1 14207.6 12098.8 12133.5 12154.6 12251.6 12462.3 5751.8 9644.5 10635.7 11859.7 11866.2 12284.3 12308.9 12445.6 12641.1 12906.3 9162.4 9366.6 9527.5 9636.0 9636.4 11623.4 12465.9 12555.9 12671.9 12954.2 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | [#3] mootools.html Cycles:180 Average:5970.23 Median:5057.22 stddev:3361.50 (66.5%) stddev-sans-first:3353.75 04:04:10 INFO - PROCESS | 22273 | Values: 1448.2 1498.3 1647.5 1798.8 1833.0 8957.5 9356.6 9369.8 9372.4 9378.9 8068.1 8285.2 8691.4 8963.4 9195.3 2486.3 2519.6 2523.4 2527.4 2530.3 2449.2 2537.4 2539.7 2540.9 2540.9 2497.7 2506.4 2511.8 2520.2 2520.7 2456.6 2457.1 2484.4 2486.7 2491.3 2401.9 2436.7 2457.6 2460.0 2509.1 9158.5 9338.9 9355.6 9363.9 9372.7 5201.1 5305.9 5315.6 5316.4 5323.0 3335.5 3467.3 3497.5 3538.1 3548.1 1092.3 1114.5 1131.1 1146.8 1198.4 11935.3 11948.7 12015.7 12029.5 12315.3 4758.5 5004.3 5039.4 5075.0 5152.3 10890.7 10890.8 10897.9 10906.5 10916.6 5652.3 5656.0 5660.8 5663.3 5663.9 4622.7 4678.2 5123.5 5154.9 5261.4 4141.8 4195.8 4244.9 4294.4 4297.7 1388.5 1445.7 1448.1 1449.4 1453.6 966.6 978.1 980.9 990.5 999.1 6022.2 6041.2 6108.0 6205.0 6208.5 442.6 459.1 464.3 466.8 488.0 3901.9 4055.8 4061.5 4065.7 4105.5 10831.2 10949.8 11085.2 11178.7 11454.8 11458.7 11493.6 11510.4 11521.5 11539.9 8354.2 8648.4 8648.7 8726.0 8728.1 6058.4 6111.1 6142.8 6163.2 6202.8 9867.0 9877.9 9977.5 9996.6 10017.1 10227.3 10295.7 10307.1 10402.5 10403.9 7126.3 7787.0 8116.8 8200.9 8277.9 8667.4 8856.8 8858.4 8865.6 8870.6 7673.9 7838.6 7887.1 7918.7 8164.7 7600.2 7623.3 7709.1 7776.0 7858.0 6961.8 7147.5 7155.1 7211.3 7260.4 5204.4 5226.0 5337.8 5372.2 5392.9 5303.5 5355.4 5388.7 5396.6 5409.0 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | [#4] prototype.html Cycles:180 Average:4781.17 Median:5434.90 stddev:1401.19 (25.8%) stddev-sans-first:1364.92 04:04:10 INFO - PROCESS | 22273 | Values: 341.9 355.2 356.5 366.0 367.9 5488.5 5496.8 5497.7 5503.5 5523.7 5149.5 5281.2 5316.4 5386.5 5420.3 4339.8 4340.3 4345.8 4348.2 4351.5 4334.6 4349.6 4356.1 4361.4 4362.2 4109.6 4189.4 4240.9 4243.7 4333.7 4194.5 4211.2 4234.9 4240.6 4249.6 3710.0 3713.7 3714.2 3716.8 3726.4 5191.2 5242.6 5309.4 5315.8 5322.6 4729.3 4779.2 4792.6 4805.3 4807.0 5672.7 5682.1 5688.2 5690.3 5708.9 3943.7 3999.1 4009.4 4086.4 4118.3 5885.9 5911.6 5917.9 5917.9 5927.5 4207.5 4227.5 4236.4 4238.8 4240.8 4157.8 4240.5 4259.7 4269.1 4275.5 4853.2 4855.6 4855.7 4867.2 4871.7 5698.1 5732.3 5733.2 5737.0 5745.9 1351.1 1376.0 1377.9 1426.3 1439.8 954.8 987.6 990.3 996.6 1002.9 5380.2 5387.0 5392.7 5418.4 5419.6 5650.6 5669.8 5669.9 5673.9 5676.1 5134.3 5274.6 5322.4 5335.8 5399.4 2977.3 2979.0 2987.5 2994.8 3005.4 5746.8 5749.4 5783.0 5794.4 5819.7 5449.5 5670.9 5699.9 5729.6 5772.4 5872.5 5888.5 5896.3 5899.0 5903.5 5601.6 5667.7 5673.0 5682.5 5893.3 5849.3 5855.0 5870.4 5886.1 5907.0 6081.2 6092.5 6119.1 6188.8 6198.3 4017.0 4038.0 4194.1 4227.4 4246.2 5727.8 5728.6 5731.9 5910.2 5941.3 5754.4 5760.7 5769.6 5775.7 5777.7 5623.0 5700.8 5742.2 5756.9 5759.8 5697.8 5706.8 5713.3 5713.6 5715.0 5645.6 5806.6 5808.8 5810.7 5810.8 5604.2 5635.5 5637.2 5642.1 5656.2 04:04:10 INFO - PROCESS | 22273 | 04:04:10 INFO - PROCESS | 22273 | [#5] yui.html Cycles:180 Average:17305.19 Median:47925.02 stddev:22655.02 (47.3%) stddev-sans-first:22684.26 04:04:10 INFO - PROCESS | 22273 | Values: 700.9 730.7 735.7 765.6 873.2 14976.4 15600.2 15632.1 15658.6 15658.8 14345.3 14410.1 14417.8 14418.5 14428.5 712.8 724.8 823.1 829.3 843.6 834.1 841.6 849.8 849.8 849.9 889.7 890.8 890.9 891.2 891.3 741.1 756.4 888.5 888.7 889.7 628.2 634.7 642.4 644.2 644.5 14459.1 14484.3 14499.3 14504.0 14512.2 11832.8 12283.9 12948.2 13040.3 13102.6 11317.3 11465.0 11557.7 11664.2 11772.9 3946.6 3972.1 3972.3 3989.8 4007.6 63806.0 64701.0 65169.3 65401.3 66278.3 9903.0 9974.5 10135.2 10395.0 10404.9 17285.9 17328.2 17345.1 17358.2 17377.1 7601.8 7713.5 7773.3 7838.8 8050.0 4333.3 4405.5 4414.6 4447.9 4471.4 3478.1 3573.4 3576.1 3576.3 3585.7 579.4 607.6 614.3 616.9 643.3 671.2 711.3 723.0 725.2 745.8 8484.9 9237.3 9407.4 9568.2 9644.5 721.6 727.9 745.2 761.3 772.7 4292.1 4416.5 4639.2 4707.2 4720.1 50468.0 67227.0 82104.6 91263.0 91888.0 75964.0 76678.0 76701.6 78746.0 79113.0 46951.0 53198.7 70523.6 70820.0 72203.6 8707.5 8932.7 8946.4 8953.0 8996.2 47556.0 47570.8 48279.3 48629.3 49019.8 57237.0 58691.7 59128.7 62215.4 65919.7 12489.6 12827.4 13397.7 13979.4 14036.5 13603.4 13723.7 13748.5 14417.5 14563.7 12750.6 12793.7 13406.1 13407.1 13507.9 12362.9 12468.4 12589.9 12740.5 12831.6 12457.5 12787.6 12812.9 12820.3 13114.4 10185.0 10655.6 10852.5 10986.6 11351.9 10075.9 10154.6 10177.7 10180.2 10200.0 04:04:10 INFO - PROCESS | 22273 | -------- Summary: end -------- 04:04:10 INFO - PROCESS | 22273 | 04:04:11 INFO - TEST-INFO | 22273: exit 0 04:04:11 INFO - TEST-OK | dromaeo_css | took 1116052ms 04:04:11 INFO - TEST-START | kraken 04:04:11 INFO - operating with platform_type : linux_ 04:04:11 INFO - Initialising browser for kraken test... 04:04:11 INFO - TEST-INFO | started process 22591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqAFnQ5/profile http://localhost:51503/getInfo.html) 04:04:15 INFO - PROCESS | 22591 | __metrics Screen width/height:1600/1200 04:04:15 INFO - PROCESS | 22591 | colorDepth:24 04:04:15 INFO - PROCESS | 22591 | Browser inner width/height: 1024/697 04:04:15 INFO - PROCESS | 22591 | __metrics 04:04:16 INFO - PROCESS | 22591 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:04:16 INFO - PROCESS | 22591 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:04:16 INFO - PROCESS | 22591 | console.error: PushService: 04:04:16 INFO - PROCESS | 22591 | stateChangeProcessEnqueue: Error transitioning state 04:04:16 INFO - PROCESS | 22591 | UnknownError 04:04:17 INFO - TEST-INFO | 22591: exit 0 04:04:17 INFO - Browser initialized. 04:04:17 INFO - Running cycle 1/1 for kraken test... 04:04:17 INFO - TEST-INFO | started process 22680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqAFnQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:29 INFO - PROCESS | 22680 | RSS: Main: 144756736 04:04:29 INFO - PROCESS | 22680 | 04:04:31 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:32 INFO - PROCESS | 22680 | RSS: Main: 185782272 04:04:32 INFO - PROCESS | 22680 | 04:04:35 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-dft) 04:04:35 INFO - PROCESS | 22680 | RSS: Main: 175824896 04:04:35 INFO - PROCESS | 22680 | 04:04:38 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-fft) 04:04:39 INFO - PROCESS | 22680 | RSS: Main: 266747904 04:04:39 INFO - PROCESS | 22680 | 04:04:41 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51503/tests/kraken/driver.html?testName=audio-oscillator) 04:04:41 INFO - PROCESS | 22680 | RSS: Main: 172625920 04:04:41 INFO - PROCESS | 22680 | 04:04:43 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:44 INFO - PROCESS | 22680 | RSS: Main: 175874048 04:04:44 INFO - PROCESS | 22680 | 04:04:47 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51503/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:48 INFO - PROCESS | 22680 | RSS: Main: 214749184 04:04:48 INFO - PROCESS | 22680 | 04:04:51 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51503/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:51 INFO - PROCESS | 22680 | RSS: Main: 214020096 04:04:51 INFO - PROCESS | 22680 | 04:04:54 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51503/tests/kraken/driver.html?testName=json-parse-financial) 04:04:55 INFO - PROCESS | 22680 | RSS: Main: 210755584 04:04:55 INFO - PROCESS | 22680 | 04:04:56 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:57 INFO - PROCESS | 22680 | RSS: Main: 173686784 04:04:57 INFO - PROCESS | 22680 | 04:04:58 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:59 INFO - PROCESS | 22680 | RSS: Main: 180850688 04:04:59 INFO - PROCESS | 22680 | 04:05:01 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:02 INFO - PROCESS | 22680 | RSS: Main: 190226432 04:05:02 INFO - PROCESS | 22680 | 04:05:04 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:05 INFO - PROCESS | 22680 | RSS: Main: 198131712 04:05:05 INFO - PROCESS | 22680 | 04:05:08 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:08 INFO - PROCESS | 22680 | RSS: Main: 195534848 04:05:08 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | Cycle 1(1): loaded http://localhost:51503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51503/tests/kraken/driver.html?testName=ai-astar) 04:05:10 INFO - PROCESS | 22680 | RSS: Main: 246165504 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | __start_tp_report 04:05:10 INFO - PROCESS | 22680 | _x_x_mozilla_page_load 04:05:10 INFO - PROCESS | 22680 | _x_x_mozilla_page_load_details 04:05:10 INFO - PROCESS | 22680 | |i|pagename|runs| 04:05:10 INFO - PROCESS | 22680 | |0;ai-astar;100;111;109;110;110;111;109;111;109;109 04:05:10 INFO - PROCESS | 22680 | |1;audio-beat-detection;151;125;121;170;128;126;122;120;160;121 04:05:10 INFO - PROCESS | 22680 | |2;audio-dft;160;160;162;160;159;160;161;162;161;160 04:05:10 INFO - PROCESS | 22680 | |3;audio-fft;74;75;74;101;77;74;74;75;100;74 04:05:10 INFO - PROCESS | 22680 | |4;audio-oscillator;81;80;115;82;81;85;98;80;81;111 04:05:10 INFO - PROCESS | 22680 | |5;imaging-gaussian-blur;116;116;116;118;116;117;117;116;117;116 04:05:10 INFO - PROCESS | 22680 | |6;imaging-darkroom;147;150;150;145;147;146;146;146;146;145 04:05:10 INFO - PROCESS | 22680 | |7;imaging-desaturate;85;84;84;85;84;84;84;84;84;84 04:05:10 INFO - PROCESS | 22680 | |8;json-parse-financial;50;50;49;51;49;51;49;50;50;51 04:05:10 INFO - PROCESS | 22680 | |9;json-stringify-tinderbox;59;60;59;60;60;58;59;63;59;59 04:05:10 INFO - PROCESS | 22680 | |10;stanford-crypto-aes;76;75;75;84;80;81;75;75;75;75 04:05:10 INFO - PROCESS | 22680 | |11;stanford-crypto-ccm;137;141;144;130;125;132;123;126;161;129 04:05:10 INFO - PROCESS | 22680 | |12;stanford-crypto-pbkdf2;153;158;159;155;153;163;154;155;153;154 04:05:10 INFO - PROCESS | 22680 | |13;stanford-crypto-sha256-iterative;62;62;61;61;64;62;61;62;60;60 04:05:10 INFO - PROCESS | 22680 | __end_tp_report 04:05:10 INFO - PROCESS | 22680 | __start_cc_report 04:05:10 INFO - PROCESS | 22680 | _x_x_mozilla_cycle_collect,1635 04:05:10 INFO - PROCESS | 22680 | __end_cc_report 04:05:10 INFO - PROCESS | 22680 | __startTimestamp1480075510598__endTimestamp 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | ------- Summary: start ------- 04:05:10 INFO - PROCESS | 22680 | Number of tests: 14 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.25 (3.0%) stddev-sans-first:0.93 04:05:10 INFO - PROCESS | 22680 | Values: 100.0 111.0 109.0 110.0 110.0 111.0 109.0 111.0 109.0 109.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:127.00 stddev:18.61 (14.7%) stddev-sans-first:18.75 04:05:10 INFO - PROCESS | 22680 | Values: 151.0 125.0 121.0 170.0 128.0 126.0 122.0 120.0 160.0 121.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:05:10 INFO - PROCESS | 22680 | Values: 160.0 160.0 162.0 160.0 159.0 160.0 161.0 162.0 161.0 160.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:10.95 (14.8%) stddev-sans-first:11.41 04:05:10 INFO - PROCESS | 22680 | Values: 74.0 75.0 74.0 101.0 77.0 74.0 74.0 75.0 100.0 74.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:81.00 stddev:13.57 (16.8%) stddev-sans-first:14.05 04:05:10 INFO - PROCESS | 22680 | Values: 81.0 80.0 115.0 82.0 81.0 85.0 98.0 80.0 81.0 111.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 04:05:10 INFO - PROCESS | 22680 | Values: 116.0 116.0 116.0 118.0 116.0 117.0 117.0 116.0 117.0 116.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.81 (1.2%) stddev-sans-first:1.92 04:05:10 INFO - PROCESS | 22680 | Values: 147.0 150.0 150.0 145.0 147.0 146.0 146.0 146.0 146.0 145.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 04:05:10 INFO - PROCESS | 22680 | Values: 85.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 04:05:10 INFO - PROCESS | 22680 | Values: 50.0 50.0 49.0 51.0 49.0 51.0 49.0 50.0 50.0 51.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.50 stddev:1.35 (2.3%) stddev-sans-first:1.41 04:05:10 INFO - PROCESS | 22680 | Values: 59.0 60.0 59.0 60.0 60.0 58.0 59.0 63.0 59.0 59.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:75.50 stddev:3.31 (4.4%) stddev-sans-first:3.49 04:05:10 INFO - PROCESS | 22680 | Values: 76.0 75.0 75.0 84.0 80.0 81.0 75.0 75.0 75.0 75.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:134.50 stddev:11.51 (8.6%) stddev-sans-first:12.18 04:05:10 INFO - PROCESS | 22680 | Values: 137.0 141.0 144.0 130.0 125.0 132.0 123.0 126.0 161.0 129.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:155.00 stddev:3.30 (2.1%) stddev-sans-first:3.35 04:05:10 INFO - PROCESS | 22680 | Values: 153.0 158.0 159.0 155.0 153.0 163.0 154.0 155.0 153.0 154.0 04:05:10 INFO - PROCESS | 22680 | 04:05:10 INFO - PROCESS | 22680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.18 (1.9%) stddev-sans-first:1.24 04:05:10 INFO - PROCESS | 22680 | Values: 62.0 62.0 61.0 61.0 64.0 62.0 61.0 62.0 60.0 60.0 04:05:10 INFO - PROCESS | 22680 | -------- Summary: end -------- 04:05:10 INFO - PROCESS | 22680 | 04:05:11 INFO - TEST-INFO | 22680: exit 0 04:05:11 INFO - TEST-OK | kraken | took 60046ms 04:05:11 INFO - SUITE-END | took 1176s 04:05:11 INFO - Completed test suite (00:19:36) 04:05:11 INFO - javascript benchmark 04:05:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3223.903282901513, 3258.9511157332636, 3270.8201048942315, 3291.0291464018114, 3318.2533929865785, 5561.777528898844, 5619.072852979264, 5627.6904770237625, 5633.070543360341, 5653.886922261558, 5595.076812325961, 5648.491635752782, 5656.179853921179, 5662.150677398392, 5672.5178359839465, 5106.208537676647, 5131.307273518083, 5134.0, 5159.71621560814, 5197.0, 5028.371453568304, 5046.369203849519, 5209.635325527196, 5212.0, 5228.137357336035, 5092.28707980883, 5100.84697459075, 5131.204663277198, 5134.229865520183, 5149.485051494858, 5153.6392452528335, 5172.043172013171, 5220.556252718524, 5230.843074707765, 5255.343082114736, 4860.3681521401995, 5104.489551044903, 5129.179331306973, 5173.508516690946, 5185.662931909414, 5404.32445944257, 5459.563234941234, 5474.343078830526, 5504.972475137599, 5567.749451274662, 5884.205632239678, 5884.323302820145, 6007.729652165663, 6011.909821352683, 6013.188219590387, 5833.708314584296, 6041.577089603729, 6061.393860613904, 6065.8180254592435, 6071.483923866476, 5464.672119672792, 5578.609497335228, 5615.691136987423, 5619.831405057855, 5661.150827375926, 6170.043643235305, 6179.969100154471, 6184.721687524072, 6186.845328866724, 6190.597611155261, 5766.88466230673, 5959.910601340984, 5963.9563076461445, 5974.074018527135, 5974.671393073423, 5894.086416605433, 5925.229720136441, 5972.701364931736, 5979.252593425822, 6081.087836824512, 6023.3073196582955, 6034.0, 6034.48706859913, 6034.577579569388, 6067.393260673897, 5966.701664916737, 6028.909566356509, 6031.185789918392, 6036.577439579275, 6037.78867739627, 4529.980754330315, 4552.339910712928, 4593.356930029799, 4628.375169352162, 4637.9536204637525, 4151.294279972412, 4174.373843923375, 4185.895352616148, 4199.454070970754, 4210.705250632487, 5841.4450627190345, 5841.795537156179, 5848.53211743068, 5852.0, 5857.619254748428, 5808.0, 5848.298204215522, 5870.5890587659305, 5937.495312898452, 6113.694315284218, 5768.2501274834, 5774.162746401748, 5775.451332123442, 5776.133579962955, 5810.941890581124, 5232.215167724872, 5236.1098613235845, 5245.26566280721, 5247.790088396421, 5247.947520524746, 6007.729652165663, 6068.6358818471035, 6147.0779383092895, 6248.28144763349, 6286.937130628727, 5961.850953726192, 6084.847878803065, 6092.817215483543, 6112.541559383153, 6120.326764056039, 6278.125452629363, 6302.9684851577285, 6312.0, 6312.905306420315, 6326.493880489642, 5667.914981275367, 5689.601727879009, 5946.613470124428, 5946.821595352147, 5949.2266005419015, 6009.789657361971, 6049.727762250621, 6052.969735151296, 6101.145839582551, 6137.232845894263, 5907.202527658711, 5928.822135335947, 5951.523878089656, 5962.821115366546, 5966.970165149147, 5635.746391412315, 5933.940660593339, 5942.821715348547, 5962.791302304398, 5972.104184372379, 5693.202951586864, 5725.370209277059, 5820.854478637899, 5823.621464604787, 5924.674142922008, 5962.582619216787, 5977.7310021050025, 5981.491573216325, 5981.611195272293, 5983.0, 5573.498385145356, 5626.043572592587, 5627.43725627434, 5812.128180772918, 5827.125931110198], "value": 5556.405281968296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3979321712201, 609.338867328948, 634.1597383466908, 635.7425242776676, 642.6947200079966, 33199.66800331996, 36475.63524364756, 44627.0, 44915.77542112289, 44947.77526112365, 46168.76915615426, 46673.53326466734, 46799.0, 46870.76564617181, 46922.53077469224, 8309.293710034653, 8818.470891746483, 8983.281337493017, 8985.056569060253, 8986.460812351248, 8183.836323273531, 10514.10630096439, 10738.08726258269, 10751.677449676523, 11178.217524773268, 10966.725831854188, 11024.889751102506, 11033.282836615634, 11035.44822758863, 11038.11695064397, 10827.350358978447, 10857.619983300625, 10868.402237876913, 10880.564777408894, 10909.454527273605, 10623.681289561326, 10679.199060070448, 10683.252172347939, 10701.732456688567, 10717.624883129052, 42609.786951065355, 42905.35641965342, 42982.78508607437, 43222.78388608037, 43316.56683433157, 3623.1123374773088, 3788.6211378861894, 3903.1022864741267, 4073.959260407388, 4292.699511034229, 31191.688083119105, 32194.678053219635, 32261.51607725886, 32633.347333053443, 33119.66880331214, 4103.117829666636, 4174.791260436966, 4176.853810116661, 4177.8537751178565, 4289.721168124093, 499115.0, 499298.0, 504269.99999999633, 506597.8020659386, 507724.0, 62470.68764656239, 62583.37416625866, 63043.36956630467, 63046.684766575876, 63117.68441157765, 39321.0, 40025.79987100104, 42277.0, 65046.34953650403, 65535.34464655388, 19034.143463544173, 19181.61636767257, 19226.8077319225, 19232.61534769297, 19234.615307693766, 13625.795613065811, 13860.306984650928, 14705.705885882222, 14942.103473791607, 15095.54713358601, 19319.130639121275, 19961.401157965283, 20122.69815952762, 20162.59674806525, 20256.696149557767, 7123.216446190915, 7280.526765760209, 7517.736879209311, 7604.201558836353, 7610.771676849703, 985.2167526816198, 999.9200063995008, 1047.6542740895638, 1069.9251052426255, 1107.5126944144552, 31467.37065258682, 33106.66893331084, 33321.50017749736, 33433.0, 33897.0, 1017.7481697511954, 1087.0814162033228, 1123.7696272264166, 1139.811931031387, 1163.5462169753803, 14872.0, 17835.910820445813, 17841.910790445963, 18242.726359104625, 18585.44243672692, 569382.0, 570140.0, 572020.0, 572628.0, 572701.0, 59895.0, 60606.0, 60690.393096069354, 60787.0, 60813.695931520946, 1312.3503865586595, 1353.0731448957495, 1359.8912087033013, 1389.4164450930634, 1405.0656313551374, 29813.0, 34163.65836341605, 34840.82579587086, 34892.82553587318, 35441.0507422084, 50891.236631449814, 57827.42172578389, 58820.0, 58967.41032589619, 65918.34081659123, 518843.0, 519752.0, 523227.0, 524223.0, 524319.0, 30175.698243018167, 30217.848910755307, 32058.83970580132, 32168.0, 45378.54621453743, 48522.0, 48807.26789098237, 48853.2672009913, 50142.749286254795, 50768.0, 40193.0, 41428.0, 41626.167476649694, 41761.0, 41821.79089104535, 40995.38506922339, 41115.383269250386, 41234.79382603068, 42351.0, 42398.576014240694, 41995.0, 42440.0, 43130.35304470373, 43528.78235608801, 43649.34525982049, 34844.0, 36785.04822028841, 36933.445998310584, 36985.260294793414, 37802.0, 28906.42187156287, 29034.564481532372, 29084.7091529082, 29262.26844328909, 29361.853190734764], "value": 21472.732838196927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.6715380715199, 432.09937301298254, 434.55241101665274, 434.88258170294023, 449.3551753234111, 16383.18084095795, 19235.90382048091, 19763.70354444681, 20459.386218413434, 20643.793562064377, 20363.694544581842, 20612.89693551534, 20734.585308293863, 20780.68828967563, 20975.37073887782, 5689.857753556153, 5923.437273459036, 5926.377730338317, 5928.911066334009, 5933.762649494015, 5667.744951477172, 5902.940970590304, 5941.584089113764, 5999.280086389639, 6013.789517366893, 5562.916556251659, 5984.311804142514, 5991.730372133243, 5996.790112346069, 5997.220361353018, 5767.538596912258, 5952.017917043682, 5952.55355848311, 5953.047512398039, 5955.13650520672, 5623.9437605623825, 5775.27809023872, 5786.276715410574, 5788.913166302509, 5820.1560773688, 13175.868241317656, 13364.465421383133, 13366.13120147197, 15577.688446231125, 23871.403214919592, 2333.7666233376694, 2410.0, 2410.9999999999823, 2524.583443731782, 2770.4043630619312, 9991.850122248172, 10398.844017339747, 10492.842607360895, 10983.61557345489, 10991.120710343153, 1963.9509012274807, 1998.7201791749167, 2071.5753270579494, 2102.8107470327745, 2136.220279597951, 80597.59701201515, 83501.16498835056, 85457.14542854554, 89181.55409223042, 89707.55146224292, 10653.680389588324, 11436.681942896594, 11566.843315668366, 11810.759870213677, 12286.447109880077, 16113.194340283173, 16130.435434759727, 16138.273777680033, 16140.35438582467, 16144.0, 7371.9262807372315, 7926.0, 8707.738767836974, 8840.513771742488, 8852.38033337673, 8280.544570048705, 8453.408261421642, 8458.154184581615, 8544.487330760174, 9120.908790912006, 5095.643304968617, 5151.407588127338, 5160.870978225575, 5197.506236907488, 5275.419703832576, 1771.9631562492584, 1949.8440124789984, 2083.6874468829797, 2158.341705779721, 2172.6197915364746, 971.5190980464715, 986.240594742059, 998.605550807427, 1005.0251256281396, 1060.6552870317178, 19873.30443434473, 19964.60070798576, 20047.498812529804, 20086.69869951952, 20271.0, 988.8071825993862, 997.0129571724086, 1015.6445244164483, 1034.5861655337926, 1094.0591091661165, 10723.517441715141, 11099.668039835271, 11261.549538018551, 11418.600348987911, 11454.713632159095, 464533.0, 467409.0, 469270.0, 475561.0, 482084.0, 97576.0, 98709.50645246728, 98710.5064474673, 98778.0, 102215.48892255491, 1013.7110923386799, 1037.419045334615, 1074.2319241742036, 1096.5120521367915, 1099.0273607856943, 17495.650086997935, 17752.64494710073, 18191.45425637233, 18279.17743701563, 18307.633847323246, 31716.0, 41184.176316472905, 41880.58119418767, 43435.78282108569, 44196.0, 57753.13370299365, 59672.70163649154, 61864.0, 62473.37526624675, 63954.0, 9004.549772511216, 9107.817843643223, 9219.677311294072, 9225.308101892519, 9309.767255818659, 10071.34536255141, 13272.668183295495, 13765.862341376458, 13942.093763905314, 14207.573772786833, 12098.818517722066, 12133.514659413524, 12154.574589889311, 12251.632451026484, 12462.252264863775, 5751.798687045934, 9644.505101709246, 10635.680929572125, 11859.70350741204, 11866.228695134789, 12284.262944223376, 12308.938455307667, 12445.62663120108, 12641.115121941375, 12906.290154041619, 9162.404443711404, 9366.625334986524, 9527.523623818643, 9636.0, 9636.373635713657, 11623.418829058344, 12465.875341246472, 12555.87444125547, 12671.936640316739, 12954.157979731288], "value": 9462.090301653208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.2179623003583, 1498.325753410965, 1647.5057482755178, 1798.7751531058618, 1832.9816701832985, 8957.507337096456, 9356.578953947072, 9369.812603747921, 9372.437653740762, 9378.85931711025, 8068.112507624157, 8285.171482851712, 8691.39160258782, 8963.372563920528, 9195.264378849693, 2486.3038349262238, 2519.5842685956795, 2523.4196134888894, 2527.36815796051, 2530.253575195322, 2449.1795248591743, 2537.3656585853537, 2539.7460253974546, 2540.8602526861014, 2540.9110681126162, 2497.67530221071, 2506.4235225898055, 2511.7739403453684, 2520.18094119411, 2520.6597109390273, 2456.5578195924727, 2457.103157347573, 2484.366486545919, 2486.689163854518, 2491.2899823550383, 2401.86789726565, 2436.7197772256063, 2457.5822110241124, 2459.9754002459927, 2509.0716434919195, 9158.49628270445, 9338.906610933871, 9355.578998945064, 9363.906360936371, 9372.67195648149, 5201.063808514466, 5305.867353316159, 5315.574754019669, 5316.3620365556, 5322.973385133049, 3335.483000134983, 3467.289205712823, 3497.5278337424375, 3538.062413460435, 3548.059764162499, 1092.2627226622078, 1114.4650567727456, 1131.0612191880718, 1146.7534480086738, 1198.3768440411025, 11935.283882967049, 11948.701282468008, 12015.699607509881, 12029.458674359676, 12315.322657253848, 4758.547937945889, 5004.324416203839, 5039.44566097729, 5075.0, 5152.3044389007, 10890.72773180661, 10890.782184356269, 10897.891021089847, 10906.5092070857, 10916.563337466412, 5652.3217213934595, 5656.038473459522, 5660.801871934463, 5663.348714897839, 5663.915041274384, 4622.6764126510825, 4678.1813182692895, 5123.5132662397755, 5154.8969020620125, 5261.394939581921, 4141.804843432986, 4195.790210489463, 4244.91510169801, 4294.3558466230315, 4297.742135471882, 1388.4515616331491, 1445.7469942759974, 1448.0515262503077, 1449.4492093004592, 1453.571196497036, 966.5505539923969, 978.1245785022365, 980.887197972228, 990.4997976022063, 999.1157825324494, 6022.18700475439, 6041.154238406627, 6107.96946015276, 6204.976178930516, 6208.4722798562625, 442.55081092690943, 459.07496394764576, 464.2780476359294, 466.75728621116826, 488.04343486766334, 3901.921961560753, 4055.8377664893073, 4061.4517040199194, 4065.6950728695465, 4105.548389677133, 10831.187660925305, 10949.83575246372, 11085.168612353944, 11178.664640060812, 11454.828177577343, 11458.656240312637, 11493.597724079616, 11510.424478776027, 11521.539138434537, 11539.884601154048, 8354.248117669438, 8648.394612377073, 8648.69729559475, 8725.952885653762, 8728.127187281349, 6058.363871793398, 6111.083337499233, 6142.78500252489, 6163.167972323679, 6202.782902598387, 9867.0, 9877.851832222379, 9977.45124018157, 9996.600135994478, 10017.098461138532, 10227.335223210468, 10295.742606434898, 10307.072363487323, 10402.531886065297, 10403.895961040596, 7126.2873712628325, 7787.0, 8116.75649730509, 8200.876986845084, 8277.917220827714, 8667.393282470166, 8856.822863542822, 8858.379913406, 8865.64537418496, 8870.64517419296, 7673.923260767321, 7838.608069596611, 7887.092984306649, 7918.722844700408, 8164.673413063411, 7600.1639819620905, 7623.275788800055, 7709.113451953097, 7776.0, 7857.960710196641, 6961.756338528127, 7147.53541019832, 7155.069840920647, 7211.278872112956, 7260.382867456326, 5204.401493828107, 5225.973870130625, 5337.839864804062, 5372.167314066326, 5392.865178370572, 5303.4696530346655, 5355.410904800391, 5388.73056347189, 5396.595255355943, 5408.972295264045], "value": 4725.250189661559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.89059500959695, 355.1901664205611, 356.46708171283916, 365.98170091495416, 367.9264147170565, 5488.4785945335225, 5496.790706044669, 5497.725113744312, 5503.532199763025, 5523.7238138093135, 5149.536541711245, 5281.207818827178, 5316.415194328621, 5386.515213630772, 5420.295361602996, 4339.761313127777, 4340.283853164224, 4345.760983145926, 4348.173846969065, 4351.542233351815, 4334.60988511034, 4349.586789255016, 4356.083323337722, 4361.389405483219, 4362.171187474386, 4109.5753505431785, 4189.434426352449, 4240.936385954213, 4243.745375277494, 4333.739975601458, 4194.538600753915, 4211.241976444238, 4234.87295381139, 4240.618344349008, 4249.6387807036435, 3709.9629003710156, 3713.721470889694, 3714.201446688975, 3716.7769933804057, 3726.441033844918, 5191.169412893919, 5242.6330156889035, 5309.4425085365865, 5315.813946511854, 5322.574194064504, 4729.290606409032, 4779.187538118494, 4792.592629626486, 4805.327254184417, 4807.038592281523, 5672.653134650576, 5682.147677848315, 5688.203651488795, 5690.345610254791, 5708.857278568027, 3943.743656662308, 3999.1201935574127, 4009.438678584971, 4086.4483294755423, 4118.320477121271, 5885.911711324334, 5911.640322725797, 5917.8816423671715, 5917.8816423671715, 5927.466528012456, 4207.516135644379, 4227.492700875853, 4236.406903033578, 4238.788060596958, 4240.809163587646, 4157.792110394468, 4240.533541310453, 4259.701820872571, 4269.146170765859, 4275.508316543637, 4853.174960256765, 4855.6115510759055, 4855.708657480563, 4867.245576935581, 4871.732054736953, 5698.145278208219, 5732.283464566929, 5733.226014488074, 5736.9633780008335, 5745.913811292834, 1351.1352734250088, 1375.9587212383644, 1377.8622137786142, 1426.2512181104796, 1439.784032395149, 954.7851733359938, 987.5753426026733, 990.2672022703292, 996.6113215845826, 1002.9448380339152, 5380.1929710542945, 5386.973065134649, 5392.7057506198225, 5418.376886658006, 5419.566434685295, 5650.604457688005, 5669.801556945487, 5669.914951275734, 5673.943260567342, 5676.120201368794, 5134.306868572769, 5274.604404669665, 5322.4411436799355, 5335.759890804923, 5399.433059528693, 2977.285451491626, 2978.9594128022372, 2987.4622567937545, 2994.8352840593975, 3005.3989202159655, 5746.770129194785, 5749.425057494217, 5782.971085144547, 5794.391588883106, 5819.73811178498, 5449.509544141047, 5670.914936275959, 5699.914501282484, 5729.5702822288495, 5772.422757724278, 5872.473156979217, 5888.499477544371, 5896.3219229788265, 5899.026660601038, 5903.527717782653, 5601.6358936668985, 5667.744951477276, 5673.0, 5682.545396368363, 5893.263342082239, 5849.268841394825, 5854.970725146347, 5870.414987953314, 5886.087656413263, 5906.995810712103, 6081.209442772411, 6092.45167934888, 6119.0821376792055, 6188.752449901954, 6198.256209254918, 4016.979915100406, 4038.0106873816103, 4194.085110847931, 4227.408162857264, 4246.193223287565, 5727.821059312122, 5728.567858035492, 5731.942680573307, 5910.231669882888, 5941.346451890375, 5754.395788442153, 5760.654360738369, 5769.624974376652, 5775.7400916957995, 5777.6822274775295, 5623.015318248016, 5700.771969121354, 5742.224799651994, 5756.913646295393, 5759.769609215585, 5697.829065128053, 5706.771729130788, 5713.257276554022, 5713.571482138773, 5714.971425143014, 5645.604807663424, 5806.622569532967, 5808.796692115756, 5810.658871149021, 5810.767569297181, 5604.159376093618, 5635.549156067586, 5637.238972738792, 5642.069058605284, 5656.1798539212405], "value": 4337.831765713575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9439244860412, 730.7077169132347, 735.6983636708949, 765.6478020110749, 873.2271939333688, 14976.400943962228, 15600.219989000561, 15632.062076275432, 15658.608534786636, 15658.765118523232, 14345.282735863217, 14410.135391876494, 14417.78373324401, 14418.495352662632, 14428.495002674908, 712.7968528969245, 724.800679813053, 823.0781524692353, 829.2950991657088, 843.5529169540154, 834.0616806093145, 841.6044459104211, 849.8087930215714, 849.8300339932007, 849.8725191221305, 889.7108439757105, 890.7906641939139, 890.9109089091104, 891.189017993626, 891.2914233184601, 741.0847603210032, 756.3873262657265, 888.4669198480924, 888.6711916590871, 889.7375274294099, 628.2304177382715, 634.7334119669704, 642.4474951541671, 644.1979735229622, 644.5101722690742, 14459.060161089601, 14484.275786210648, 14499.275036248146, 14504.0, 14512.201828899406, 11832.763344733143, 12283.93858030713, 12948.15836970594, 13040.347982600832, 13102.606921792361, 11317.264377815416, 11465.0, 11557.711057223552, 11664.183507154503, 11772.88227117735, 3946.638409748632, 3972.086420123359, 3972.304846651853, 3989.780562069085, 4007.5992400759983, 63806.0, 64701.0, 65169.348306516804, 65401.34598654, 66278.3372166277, 9903.0, 9974.451405172786, 10135.239857010754, 10395.0, 10404.947975260075, 17285.91357043232, 17328.220230089675, 17345.132743363032, 17358.218880150424, 17377.131143442777, 7601.7719468416035, 7713.537187768752, 7773.3004029637605, 7838.764837054898, 8049.9597502013285, 4333.306670932636, 4405.515393306734, 4414.646828253732, 4447.911041779146, 4471.374007638933, 3478.095695119287, 3573.4103872860687, 3576.141725985745, 3576.302620988934, 3585.695215906625, 579.3829571506333, 607.6050567131311, 614.2536817766435, 616.9228846394201, 643.2666759893725, 671.194566520168, 711.3420086420041, 722.9674664640104, 725.2348772045437, 745.7613563659577, 8484.872726909101, 9237.307201959746, 9407.43555386679, 9568.234541236685, 9644.469554174588, 721.6103304215665, 727.9090113735783, 745.2026331825003, 761.303407382239, 772.6870617399962, 4292.055747735493, 4416.470023597189, 4639.211334073216, 4707.152712511781, 4720.103180395714, 50467.99064018699, 67227.0, 82104.58947705342, 91263.0, 91888.0, 75964.0, 76678.0, 76701.61649191719, 78746.0, 79113.0, 46951.0, 53198.734006330495, 70523.64738176379, 70820.0, 72203.63898180476, 8707.521086340312, 8932.732018039469, 8946.37375383743, 8953.0, 8996.235319997611, 47556.0, 47570.762146189045, 48279.27581086357, 48629.27056094091, 49019.754901225264, 57237.0, 58691.70654146702, 59128.70435647966, 62215.37784622096, 65919.67040164769, 12489.562865299671, 12827.358632068546, 13397.665058373228, 13979.440822367398, 14036.508722194674, 13603.387847546686, 13723.656908577366, 13748.518801841887, 14417.495387661382, 14563.708725825636, 12750.61748147557, 12793.744125117259, 13406.061575689608, 13407.061505694508, 13507.864921350661, 12362.938185309016, 12468.376581170724, 12589.874101259236, 12740.490380384681, 12831.550895718605, 12457.501699931901, 12787.552435664707, 12812.87187128154, 12820.294883781482, 13114.409851556893, 10184.978052187444, 10655.627053053106, 10852.511636976196, 10986.560537578727, 11351.943240283746, 10075.949620251851, 10154.593816247563, 10177.745556361151, 10180.236482264008, 10200.0], "value": 7066.339002685091, "unit": "score"}], "name": "dromaeo_css", "value": 7394.933661037433, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 109.0, 110.0, 110.0, 111.0, 109.0, 111.0, 109.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 121.0, 170.0, 128.0, 126.0, 122.0, 120.0, 160.0, 121.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 159.0, 160.0, 161.0, 162.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 101.0, 77.0, 74.0, 74.0, 75.0, 100.0, 74.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 115.0, 82.0, 81.0, 85.0, 98.0, 80.0, 81.0, 111.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 150.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 49.0, 51.0, 49.0, 51.0, 49.0, 50.0, 50.0, 51.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 58.0, 59.0, 63.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 84.0, 80.0, 81.0, 75.0, 75.0, 75.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 144.0, 130.0, 125.0, 132.0, 123.0, 126.0, 161.0, 129.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 159.0, 155.0, 153.0, 163.0, 154.0, 155.0, 153.0, 154.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 64.0, 62.0, 61.0, 62.0, 60.0, 60.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1459.1999999999998, "alertThreshold": 2.0}]} 04:05:11 INFO - Return code: 0 04:05:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:11 INFO - # TBPL SUCCESS # 04:05:11 INFO - Running post-action listener: _resource_record_post_action 04:05:11 INFO - [mozharness: 2016-11-25 12:05:11.911985Z] Finished run-tests step (success) 04:05:11 INFO - Running post-run listener: _resource_record_post_run 04:05:11 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355770368; Read time: 16; Write time: 216516 04:05:11 INFO - TinderboxPrint: CPU usage
13.0% 04:05:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:05:11 INFO - TinderboxPrint: I/O write bytes / time
355,770,368 / 216,516 04:05:11 INFO - TinderboxPrint: CPU idle
8,277.3 (87.0%) 04:05:11 INFO - TinderboxPrint: CPU user
1,190.7 (12.5%) 04:05:11 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107286528; Read time: 0; Write time: 67220 04:05:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 248483840; Read time: 0; Write time: 149296 04:05:12 INFO - Running post-run listener: _upload_blobber_files 04:05:12 INFO - Blob upload gear active. 04:05:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:12 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 04:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:05:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:05:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:05:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:13 INFO - (blobuploader) - INFO - Done attempting. 04:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:14 INFO - (blobuploader) - INFO - Done attempting. 04:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:17 INFO - (blobuploader) - INFO - Done attempting. 04:05:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:17 INFO - Return code: 0 04:05:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5694e481ca39e60ff48ac7551cc0455c7d21bba1a26bfc9acd222a1dac56fd0990f6bb7e13f851734e777bef2c35586e82cfe436f489494594d3d59b2f0708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54c67ea23e69e1928ba1f5772266231280e760052f7cf629acef70acbff191dd29e1a434acb4abba56f4439fcdc7a55d3cdca3f2ed0be2230982d957e578407f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8cffd6ddafbbad9c36daa7a539119c3268775614e7cec38124c8262a1c3ef5336046b78b92defa61d26365666b874b73c99781a6a5d8ac1b3f4add63ca7bffa"} 04:05:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:17 INFO - Contents: 04:05:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5694e481ca39e60ff48ac7551cc0455c7d21bba1a26bfc9acd222a1dac56fd0990f6bb7e13f851734e777bef2c35586e82cfe436f489494594d3d59b2f0708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54c67ea23e69e1928ba1f5772266231280e760052f7cf629acef70acbff191dd29e1a434acb4abba56f4439fcdc7a55d3cdca3f2ed0be2230982d957e578407f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8cffd6ddafbbad9c36daa7a539119c3268775614e7cec38124c8262a1c3ef5336046b78b92defa61d26365666b874b73c99781a6a5d8ac1b3f4add63ca7bffa"} 04:05:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:17 INFO - Copying logs to upload dir... 04:05:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.354236 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-25 04:05:16.741784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:05:16.745698) ========= 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=7de08804244eb36560b44971000001c3-1480074280.430267-1456604095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5694e481ca39e60ff48ac7551cc0455c7d21bba1a26bfc9acd222a1dac56fd0990f6bb7e13f851734e777bef2c35586e82cfe436f489494594d3d59b2f0708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54c67ea23e69e1928ba1f5772266231280e760052f7cf629acef70acbff191dd29e1a434acb4abba56f4439fcdc7a55d3cdca3f2ed0be2230982d957e578407f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8cffd6ddafbbad9c36daa7a539119c3268775614e7cec38124c8262a1c3ef5336046b78b92defa61d26365666b874b73c99781a6a5d8ac1b3f4add63ca7bffa"} build_url:https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011944 build_url: 'https://queue.taskcluster.net/v1/task/Z12aV4xsSwWSl0IhNGZLXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d5694e481ca39e60ff48ac7551cc0455c7d21bba1a26bfc9acd222a1dac56fd0990f6bb7e13f851734e777bef2c35586e82cfe436f489494594d3d59b2f0708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54c67ea23e69e1928ba1f5772266231280e760052f7cf629acef70acbff191dd29e1a434acb4abba56f4439fcdc7a55d3cdca3f2ed0be2230982d957e578407f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8cffd6ddafbbad9c36daa7a539119c3268775614e7cec38124c8262a1c3ef5336046b78b92defa61d26365666b874b73c99781a6a5d8ac1b3f4add63ca7bffa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:05:16.771595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:05:16.771939) ========= 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=7de08804244eb36560b44971000001c3-1480074280.430267-1456604095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:05:16.854527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:05:16.854908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:05:16.855222) ========= ========= Total master_lag: 0.17 =========