builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1480088621.59 results: success (0) buildid: 20161125062719 builduid: 3b1b2fe0421645f0ad9b330503bcc8a3 revision: c41dab3b9a7230a377d68d30244bd201258ce10d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.588476) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.589428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.590123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.606371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.607018) ========= 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=32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 07:43:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-11-25 07:43:42 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.718762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.719224) ========= 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=32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:41.774763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 07:43:41.775477) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c41dab3b9a7230a377d68d30244bd201258ce10d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c41dab3b9a7230a377d68d30244bd201258ce10d --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=32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 07:43:42,207 truncating revision to first 12 chars 2016-11-25 07:43:42,208 Setting DEBUG logging. 2016-11-25 07:43:42,208 attempt 1/10 2016-11-25 07:43:42,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c41dab3b9a72?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 07:43:43,501 unpacking tar archive at: mozilla-central-c41dab3b9a72/testing/mozharness/ program finished with exit code 0 elapsedTime=1.689005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 07:43:43.480211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:43.480590) ========= script_repo_revision: c41dab3b9a7230a377d68d30244bd201258ce10d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:43.481084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:43.481410) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 07:43:43.492493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-25 07:43:43.492830) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:44 INFO - MultiFileLogger online at 20161125 07:43:44 in /builds/slave/test 07:43:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:43:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:44 INFO - {'append_to_log': False, 07:43:44 INFO - 'base_work_dir': '/builds/slave/test', 07:43:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:43:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:44 INFO - 'branch': 'Firefox-Non-PGO', 07:43:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:44 INFO - 'config_files': ('talos/linux_config.py',), 07:43:44 INFO - 'default_actions': ('clobber', 07:43:44 INFO - 'read-buildbot-config', 07:43:44 INFO - 'download-and-extract', 07:43:44 INFO - 'populate-webroot', 07:43:44 INFO - 'create-virtualenv', 07:43:44 INFO - 'install', 07:43:44 INFO - 'run-tests'), 07:43:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:44 INFO - 'download_minidump_stackwalk': True, 07:43:44 INFO - 'download_symbols': 'ondemand', 07:43:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:43:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:43:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:43:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:43:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:44 INFO - 'installer_path': 'installer.exe', 07:43:44 INFO - 'log_level': 'info', 07:43:44 INFO - 'log_name': 'talos', 07:43:44 INFO - 'log_to_console': True, 07:43:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:44 INFO - 'opt_config_files': (), 07:43:44 INFO - 'pip_index': False, 07:43:44 INFO - 'sps_profile': False, 07:43:44 INFO - 'sps_profile_interval': 0, 07:43:44 INFO - 'suite': 'dromaeojs', 07:43:44 INFO - 'system_bits': '32', 07:43:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:44 INFO - 'title': 'talos-linux64-ix-008', 07:43:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:44 INFO - 'use_talos_json': True, 07:43:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:44 INFO - 'work_dir': 'build'} 07:43:44 INFO - [mozharness: 2016-11-25 15:43:44.023626Z] Running clobber step. 07:43:44 INFO - Running pre-action listener: _resource_record_pre_action 07:43:44 INFO - Running main action method: clobber 07:43:44 INFO - rmtree: /builds/slave/test/build 07:43:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:44 INFO - Running post-action listener: _resource_record_post_action 07:43:44 INFO - [mozharness: 2016-11-25 15:43:44.986087Z] Finished clobber step (success) 07:43:44 INFO - [mozharness: 2016-11-25 15:43:44.986184Z] Running read-buildbot-config step. 07:43:44 INFO - Running pre-action listener: _resource_record_pre_action 07:43:44 INFO - Running main action method: read_buildbot_config 07:43:44 INFO - Using buildbot properties: 07:43:44 INFO - { 07:43:44 INFO - "project": "", 07:43:44 INFO - "product": "firefox", 07:43:44 INFO - "script_repo_revision": "production", 07:43:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:43:44 INFO - "repository": "", 07:43:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:43:44 INFO - "buildid": "20161125062719", 07:43:44 INFO - "pgo_build": "False", 07:43:44 INFO - "basedir": "/builds/slave/test", 07:43:44 INFO - "buildnumber": 831, 07:43:44 INFO - "slavename": "talos-linux64-ix-008", 07:43:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:43:44 INFO - "platform": "ubuntu64_hw", 07:43:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:43:44 INFO - "branch": "mozilla-central", 07:43:44 INFO - "repo_path": "mozilla-central", 07:43:44 INFO - "revision": "c41dab3b9a7230a377d68d30244bd201258ce10d", 07:43:44 INFO - "stage_platform": "linux64", 07:43:44 INFO - "builduid": "3b1b2fe0421645f0ad9b330503bcc8a3", 07:43:44 INFO - "slavebuilddir": "test" 07:43:44 INFO - } 07:43:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:43:44 INFO - Running post-action listener: _resource_record_post_action 07:43:44 INFO - [mozharness: 2016-11-25 15:43:44.988587Z] Finished read-buildbot-config step (success) 07:43:44 INFO - [mozharness: 2016-11-25 15:43:44.988673Z] Running download-and-extract step. 07:43:44 INFO - Running pre-action listener: _resource_record_pre_action 07:43:44 INFO - Running main action method: download_and_extract 07:43:44 INFO - mkdir: /builds/slave/test/build/tests 07:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:44 INFO - trying https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:43:44 INFO - Downloading https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:43:45 INFO - Downloaded 1361 bytes. 07:43:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:43:45 INFO - Using the following test package requirements: 07:43:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:43:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:43:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:43:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'jsshell-linux-x86_64.zip'], 07:43:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:43:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:43:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:43:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:43:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:43:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:43:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:43:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:43:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:43:45 INFO - Fetch https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:43:46 INFO - Http code: 200 07:43:46 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 07:43:46 INFO - x-amz-cf-id: azkxk3BK8C5wD-wV9IUPZCOSrcAAOZyCh5h5AKjBBHpR_MJmH70GSg== 07:43:46 INFO - x-amz-version-id: uDiC7.8V4_tOEkmta9EepmNmbT8MBI0Y 07:43:46 INFO - Expected file size: 20204441 07:43:46 INFO - Obtained file size: 20204441 07:43:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:43:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:43:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:43:50 INFO - Fetch https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:43:50 INFO - Http code: 200 07:43:50 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 07:43:50 INFO - x-amz-cf-id: JWb17Qh9J04WEArKR1IhHU23SjVP_25V1Xnmqba0bMjYtXK_Y7rcSg== 07:43:50 INFO - x-amz-version-id: uDiC7.8V4_tOEkmta9EepmNmbT8MBI0Y 07:43:51 INFO - Expected file size: 20204441 07:43:51 INFO - Obtained file size: 20204441 07:43:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:43:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:43:55 INFO - Fetch https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:43:56 INFO - Http code: 200 07:43:56 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 07:43:56 INFO - x-amz-cf-id: _N8U3QR_mMLvEyVrJFsVsALBY65iRjXEpDKum9J4y8B3-HLUi5DIsA== 07:43:56 INFO - x-amz-version-id: xCmAdYw2feQgeU1Sz9tgbcpYaI4u_LHO 07:43:56 INFO - Expected file size: 14409749 07:43:56 INFO - Obtained file size: 14409749 07:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:56 INFO - trying https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:43:56 INFO - Downloading https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:43:57 INFO - Downloaded 55648187 bytes. 07:43:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:43:57 INFO - mkdir: /builds/slave/test/properties 07:43:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:43:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:43:57 INFO - Contents: 07:43:57 INFO - build_url:https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:43:58 INFO - Running post-action listener: _resource_record_post_action 07:43:58 INFO - Running post-action listener: set_extra_try_arguments 07:43:58 INFO - [mozharness: 2016-11-25 15:43:58.230603Z] Finished download-and-extract step (success) 07:43:58 INFO - [mozharness: 2016-11-25 15:43:58.230827Z] Running populate-webroot step. 07:43:58 INFO - Running pre-action listener: _resource_record_pre_action 07:43:58 INFO - Running main action method: populate_webroot 07:43:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:43:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:43:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:43:58 INFO - '--tppagecycles', 07:43:58 INFO - '7'], 07:43:58 INFO - 'tests': ['tsvgm']}}, 07:43:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:43:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:43:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['damp', 'tps']}, 07:43:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'tests': ['damp', 'tps']}, 07:43:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['dromaeo_dom']}, 07:43:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['basic_compositor_video']}, 07:43:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:43:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['a11yr', 07:43:58 INFO - 'ts_paint', 07:43:58 INFO - 'tpaint', 07:43:58 INFO - 'sessionrestore', 07:43:58 INFO - 'sessionrestore_no_auto_restore', 07:43:58 INFO - 'tabpaint']}, 07:43:58 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:58 INFO - 'ts_paint', 07:43:58 INFO - 'tpaint', 07:43:58 INFO - 'sessionrestore', 07:43:58 INFO - 'sessionrestore_no_auto_restore', 07:43:58 INFO - 'tabpaint']}, 07:43:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:43:58 INFO - 'ts_paint', 07:43:58 INFO - 'tpaint', 07:43:58 INFO - 'sessionrestore', 07:43:58 INFO - 'sessionrestore_no_auto_restore', 07:43:58 INFO - 'tabpaint']}, 07:43:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:43:58 INFO - 'ts_paint', 07:43:58 INFO - 'tpaint', 07:43:58 INFO - 'sessionrestore', 07:43:58 INFO - 'sessionrestore_no_auto_restore', 07:43:58 INFO - 'tabpaint']}, 07:43:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['a11yr', 07:43:58 INFO - 'ts_paint', 07:43:58 INFO - 'tpaint', 07:43:58 INFO - 'sessionrestore', 07:43:58 INFO - 'sessionrestore_no_auto_restore', 07:43:58 INFO - 'tabpaint']}, 07:43:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['a11yr', 07:43:58 INFO - 'ts_paint', 07:43:58 INFO - 'tpaint', 07:43:58 INFO - 'sessionrestore', 07:43:58 INFO - 'sessionrestore_no_auto_restore', 07:43:58 INFO - 'tabpaint']}, 07:43:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['tsvgx', 07:43:58 INFO - 'tsvgr_opacity', 07:43:58 INFO - 'tart', 07:43:58 INFO - 'tscrollx', 07:43:58 INFO - 'cart', 07:43:58 INFO - 'tsvg_static']}, 07:43:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:58 INFO - 'tsvgr_opacity', 07:43:58 INFO - 'tart', 07:43:58 INFO - 'tscrollx', 07:43:58 INFO - 'cart', 07:43:58 INFO - 'tsvg_static']}, 07:43:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'talos_options': ['--disable-e10s'], 07:43:58 INFO - 'tests': ['tp5o']}, 07:43:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:43:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'talos_options': ['--disable-e10s', 07:43:58 INFO - '--xperf_path', 07:43:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:58 INFO - 'tests': ['tp5n']}, 07:43:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:43:58 INFO - 'talos_options': ['--xperf_path', 07:43:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:58 INFO - 'tests': ['tp5n']}}, 07:43:58 INFO - 'talos.zip': {'path': '', 07:43:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:43:58 INFO - Running post-action listener: _resource_record_post_action 07:43:58 INFO - [mozharness: 2016-11-25 15:43:58.249530Z] Finished populate-webroot step (success) 07:43:58 INFO - [mozharness: 2016-11-25 15:43:58.249616Z] Running create-virtualenv step. 07:43:58 INFO - Running pre-action listener: _resource_record_pre_action 07:43:58 INFO - Running main action method: create_virtualenv 07:43:58 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:58 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 07:43:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:43:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:58 INFO - Using real prefix '/usr' 07:43:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:00 INFO - Installing pip.................done. 07:44:00 INFO - Return code: 0 07:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:44:01 INFO - Reading from file tmpfile_stdout 07:44:01 INFO - Output received: 07:44:01 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) 07:44:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:01 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')]} 07:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:01 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')]} 07:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:01 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:01 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 07:44:01 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 07:44:01 INFO - Using env: {'DISPLAY': ':0', 07:44:01 INFO - 'HOME': '/home/cltbld', 07:44:01 INFO - 'LANG': 'en_US.UTF-8', 07:44:01 INFO - 'LANGUAGE': 'en_US:en', 07:44:01 INFO - 'LOGNAME': 'cltbld', 07:44:01 INFO - 'MAIL': '/var/mail/cltbld', 07:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:01 INFO - 'MOZ_NO_REMOTE': '1', 07:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:01 INFO - 'NO_EM_RESTART': '1', 07:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:01 INFO - 'PWD': '/builds/slave/test', 07:44:01 INFO - 'SHELL': '/bin/bash', 07:44:01 INFO - 'SHLVL': '1', 07:44:01 INFO - 'TERM': 'linux', 07:44:01 INFO - 'TMOUT': '86400', 07:44:01 INFO - 'USER': 'cltbld', 07:44:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:01 INFO - '_': '/tools/buildbot/bin/python'} 07:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:01 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 07:44:01 INFO - Cleaning up... 07:44:01 INFO - Return code: 0 07:44:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:01 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')]} 07:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:01 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')]} 07:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:01 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:01 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 07:44:01 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 07:44:01 INFO - Using env: {'DISPLAY': ':0', 07:44:01 INFO - 'HOME': '/home/cltbld', 07:44:01 INFO - 'LANG': 'en_US.UTF-8', 07:44:01 INFO - 'LANGUAGE': 'en_US:en', 07:44:01 INFO - 'LOGNAME': 'cltbld', 07:44:01 INFO - 'MAIL': '/var/mail/cltbld', 07:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:01 INFO - 'MOZ_NO_REMOTE': '1', 07:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:01 INFO - 'NO_EM_RESTART': '1', 07:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:01 INFO - 'PWD': '/builds/slave/test', 07:44:01 INFO - 'SHELL': '/bin/bash', 07:44:01 INFO - 'SHLVL': '1', 07:44:01 INFO - 'TERM': 'linux', 07:44:01 INFO - 'TMOUT': '86400', 07:44:01 INFO - 'USER': 'cltbld', 07:44:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:01 INFO - '_': '/tools/buildbot/bin/python'} 07:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:01 INFO - Downloading/unpacking psutil>=3.1.1 07:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:03 INFO - Installing collected packages: psutil 07:44:03 INFO - Running setup.py install for psutil 07:44:03 INFO - building 'psutil._psutil_linux' extension 07:44:03 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 07:44:03 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 07:44:03 INFO - building 'psutil._psutil_posix' extension 07:44:03 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 07:44:03 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 07:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:04 INFO - Successfully installed psutil 07:44:04 INFO - Cleaning up... 07:44:04 INFO - Return code: 0 07:44:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:04 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:04 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 07:44:04 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 07:44:04 INFO - Using env: {'DISPLAY': ':0', 07:44:04 INFO - 'HOME': '/home/cltbld', 07:44:04 INFO - 'LANG': 'en_US.UTF-8', 07:44:04 INFO - 'LANGUAGE': 'en_US:en', 07:44:04 INFO - 'LOGNAME': 'cltbld', 07:44:04 INFO - 'MAIL': '/var/mail/cltbld', 07:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:04 INFO - 'MOZ_NO_REMOTE': '1', 07:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:04 INFO - 'NO_EM_RESTART': '1', 07:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:04 INFO - 'PWD': '/builds/slave/test', 07:44:04 INFO - 'SHELL': '/bin/bash', 07:44:04 INFO - 'SHLVL': '1', 07:44:04 INFO - 'TERM': 'linux', 07:44:04 INFO - 'TMOUT': '86400', 07:44:04 INFO - 'USER': 'cltbld', 07:44:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:04 INFO - '_': '/tools/buildbot/bin/python'} 07:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44:04 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 07:44:04 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 07:44:04 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 07:44:04 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 07:44:04 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 07:44:04 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 07:44:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:06 INFO - Installing collected packages: mozsystemmonitor 07:44:06 INFO - Running setup.py install for mozsystemmonitor 07:44:06 INFO - Successfully installed mozsystemmonitor 07:44:06 INFO - Cleaning up... 07:44:06 INFO - Return code: 0 07:44:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:06 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:06 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 07:44:06 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 07:44:06 INFO - Using env: {'DISPLAY': ':0', 07:44:06 INFO - 'HOME': '/home/cltbld', 07:44:06 INFO - 'LANG': 'en_US.UTF-8', 07:44:06 INFO - 'LANGUAGE': 'en_US:en', 07:44:06 INFO - 'LOGNAME': 'cltbld', 07:44:06 INFO - 'MAIL': '/var/mail/cltbld', 07:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:06 INFO - 'MOZ_NO_REMOTE': '1', 07:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:06 INFO - 'NO_EM_RESTART': '1', 07:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:06 INFO - 'PWD': '/builds/slave/test', 07:44:06 INFO - 'SHELL': '/bin/bash', 07:44:06 INFO - 'SHLVL': '1', 07:44:06 INFO - 'TERM': 'linux', 07:44:06 INFO - 'TMOUT': '86400', 07:44:06 INFO - 'USER': 'cltbld', 07:44:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:06 INFO - '_': '/tools/buildbot/bin/python'} 07:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:06 INFO - Downloading/unpacking jsonschema==2.5.1 07:44:06 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 07:44:06 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 07:44:06 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 07:44:06 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 07:44:06 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 07:44:06 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 07:44:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:08 INFO - warning: no files found matching '*.txt' 07:44:08 INFO - no previously-included directories found matching 'build' 07:44:08 INFO - no previously-included directories found matching 'dist' 07:44:08 INFO - no previously-included directories found matching '.git*' 07:44:08 INFO - Installing collected packages: jsonschema, functools32 07:44:08 INFO - Running setup.py install for functools32 07:44:08 INFO - warning: no files found matching '*.txt' 07:44:08 INFO - no previously-included directories found matching 'build' 07:44:08 INFO - no previously-included directories found matching 'dist' 07:44:08 INFO - no previously-included directories found matching '.git*' 07:44:09 INFO - Successfully installed jsonschema functools32 07:44:09 INFO - Cleaning up... 07:44:09 INFO - Return code: 0 07:44:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:44:09 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')]} 07:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:09 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')]} 07:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:09 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:09 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 07:44:09 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 07:44:09 INFO - Using env: {'DISPLAY': ':0', 07:44:09 INFO - 'HOME': '/home/cltbld', 07:44:09 INFO - 'LANG': 'en_US.UTF-8', 07:44:09 INFO - 'LANGUAGE': 'en_US:en', 07:44:09 INFO - 'LOGNAME': 'cltbld', 07:44:09 INFO - 'MAIL': '/var/mail/cltbld', 07:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:09 INFO - 'MOZ_NO_REMOTE': '1', 07:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:09 INFO - 'NO_EM_RESTART': '1', 07:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:09 INFO - 'PWD': '/builds/slave/test', 07:44:09 INFO - 'SHELL': '/bin/bash', 07:44:09 INFO - 'SHLVL': '1', 07:44:09 INFO - 'TERM': 'linux', 07:44:09 INFO - 'TMOUT': '86400', 07:44:09 INFO - 'USER': 'cltbld', 07:44:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:09 INFO - '_': '/tools/buildbot/bin/python'} 07:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:44:09 INFO - Cleaning up... 07:44:09 INFO - Return code: 0 07:44:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:09 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')]} 07:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:09 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')]} 07:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:09 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:09 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 07:44:09 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 07:44:09 INFO - Using env: {'DISPLAY': ':0', 07:44:09 INFO - 'HOME': '/home/cltbld', 07:44:09 INFO - 'LANG': 'en_US.UTF-8', 07:44:09 INFO - 'LANGUAGE': 'en_US:en', 07:44:09 INFO - 'LOGNAME': 'cltbld', 07:44:09 INFO - 'MAIL': '/var/mail/cltbld', 07:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:09 INFO - 'MOZ_NO_REMOTE': '1', 07:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:09 INFO - 'NO_EM_RESTART': '1', 07:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:09 INFO - 'PWD': '/builds/slave/test', 07:44:09 INFO - 'SHELL': '/bin/bash', 07:44:09 INFO - 'SHLVL': '1', 07:44:09 INFO - 'TERM': 'linux', 07:44:09 INFO - 'TMOUT': '86400', 07:44:09 INFO - 'USER': 'cltbld', 07:44:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:09 INFO - '_': '/tools/buildbot/bin/python'} 07:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:12 INFO - Downloading docopt-0.6.1.tar.gz 07:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:12 INFO - Running setup.py install for blobuploader 07:44:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:12 INFO - Running setup.py install for requests 07:44:12 INFO - Running setup.py install for docopt 07:44:12 INFO - Successfully installed blobuploader requests docopt 07:44:12 INFO - Cleaning up... 07:44:12 INFO - Return code: 0 07:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:12 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:12 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 07:44:12 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 07:44:12 INFO - Using env: {'DISPLAY': ':0', 07:44:12 INFO - 'HOME': '/home/cltbld', 07:44:12 INFO - 'LANG': 'en_US.UTF-8', 07:44:12 INFO - 'LANGUAGE': 'en_US:en', 07:44:12 INFO - 'LOGNAME': 'cltbld', 07:44:12 INFO - 'MAIL': '/var/mail/cltbld', 07:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:12 INFO - 'MOZ_NO_REMOTE': '1', 07:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:12 INFO - 'NO_EM_RESTART': '1', 07:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:12 INFO - 'PWD': '/builds/slave/test', 07:44:12 INFO - 'SHELL': '/bin/bash', 07:44:12 INFO - 'SHLVL': '1', 07:44:12 INFO - 'TERM': 'linux', 07:44:12 INFO - 'TMOUT': '86400', 07:44:12 INFO - 'USER': 'cltbld', 07:44:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:12 INFO - '_': '/tools/buildbot/bin/python'} 07:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:13 INFO - Running setup.py (path:/tmp/pip-jHrE5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:13 INFO - Running setup.py (path:/tmp/pip-RWpcOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:13 INFO - Running setup.py (path:/tmp/pip-iYuhH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:13 INFO - Running setup.py (path:/tmp/pip-wNKZdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:13 INFO - Running setup.py (path:/tmp/pip-2PjZDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:13 INFO - Running setup.py (path:/tmp/pip-qrIdAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:13 INFO - Running setup.py (path:/tmp/pip-x53bf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:13 INFO - Running setup.py (path:/tmp/pip-VdXC2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:13 INFO - Running setup.py (path:/tmp/pip-L40yvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:13 INFO - Running setup.py (path:/tmp/pip-YCJSpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:13 INFO - Running setup.py (path:/tmp/pip-gq4vc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:13 INFO - Running setup.py (path:/tmp/pip-rJsv5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:13 INFO - Running setup.py (path:/tmp/pip-npIqcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:13 INFO - Running setup.py (path:/tmp/pip-mZfIdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:14 INFO - Running setup.py (path:/tmp/pip-MDKI_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:14 INFO - Running setup.py (path:/tmp/pip-wB2oLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:14 INFO - Running setup.py (path:/tmp/pip-XX7AGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:14 INFO - Running setup.py install for manifestparser 07:44:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:14 INFO - Running setup.py install for mozcrash 07:44:14 INFO - Running setup.py install for mozdebug 07:44:14 INFO - Running setup.py install for mozdevice 07:44:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:14 INFO - Running setup.py install for mozfile 07:44:14 INFO - Running setup.py install for mozhttpd 07:44:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:14 INFO - Running setup.py install for mozinfo 07:44:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:14 INFO - Running setup.py install for mozInstall 07:44:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Running setup.py install for mozleak 07:44:15 INFO - Running setup.py install for mozlog 07:44:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Running setup.py install for moznetwork 07:44:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Running setup.py install for mozprocess 07:44:15 INFO - Running setup.py install for mozprofile 07:44:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Running setup.py install for mozrunner 07:44:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:15 INFO - Running setup.py install for mozscreenshot 07:44:15 INFO - Running setup.py install for moztest 07:44:15 INFO - Running setup.py install for mozversion 07:44:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:16 INFO - Cleaning up... 07:44:16 INFO - Return code: 0 07:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:16 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:16 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 07:44:16 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 07:44:16 INFO - Using env: {'DISPLAY': ':0', 07:44:16 INFO - 'HOME': '/home/cltbld', 07:44:16 INFO - 'LANG': 'en_US.UTF-8', 07:44:16 INFO - 'LANGUAGE': 'en_US:en', 07:44:16 INFO - 'LOGNAME': 'cltbld', 07:44:16 INFO - 'MAIL': '/var/mail/cltbld', 07:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:16 INFO - 'MOZ_NO_REMOTE': '1', 07:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:16 INFO - 'NO_EM_RESTART': '1', 07:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:16 INFO - 'PWD': '/builds/slave/test', 07:44:16 INFO - 'SHELL': '/bin/bash', 07:44:16 INFO - 'SHLVL': '1', 07:44:16 INFO - 'TERM': 'linux', 07:44:16 INFO - 'TMOUT': '86400', 07:44:16 INFO - 'USER': 'cltbld', 07:44:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:16 INFO - '_': '/tools/buildbot/bin/python'} 07:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:16 INFO - Running setup.py (path:/tmp/pip-zAHsWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:16 INFO - Running setup.py (path:/tmp/pip-N3fH6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:16 INFO - Running setup.py (path:/tmp/pip-EJDhPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:16 INFO - Running setup.py (path:/tmp/pip-wgsg0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:16 INFO - Running setup.py (path:/tmp/pip-Hwj0au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:16 INFO - Running setup.py (path:/tmp/pip-OglG_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:16 INFO - Running setup.py (path:/tmp/pip-ZvfZqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:16 INFO - Running setup.py (path:/tmp/pip-TD1DLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:16 INFO - Running setup.py (path:/tmp/pip-K7P8ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:16 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)) 07:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:16 INFO - Running setup.py (path:/tmp/pip-Rso9qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:17 INFO - Running setup.py (path:/tmp/pip-ZDnqtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:17 INFO - Running setup.py (path:/tmp/pip-3hWZfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:17 INFO - Running setup.py (path:/tmp/pip-beoPHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:17 INFO - Running setup.py (path:/tmp/pip-gufM8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:17 INFO - Running setup.py (path:/tmp/pip-xY3rcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:17 INFO - Running setup.py (path:/tmp/pip-ul_D3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:17 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)) 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:17 INFO - Running setup.py (path:/tmp/pip-ttR25Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:17 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)) 07:44:17 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)) 07:44:17 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)) 07:44:17 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)) 07:44:17 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:44:17 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:44:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:19 INFO - Downloading blessings-1.6.tar.gz 07:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:19 INFO - Installing collected packages: blessings 07:44:19 INFO - Running setup.py install for blessings 07:44:19 INFO - Successfully installed blessings 07:44:19 INFO - Cleaning up... 07:44:19 INFO - Return code: 0 07:44:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:19 INFO - Reading from file tmpfile_stdout 07:44:19 INFO - Current package versions: 07:44:19 INFO - argparse == 1.2.1 07:44:19 INFO - blessings == 1.6 07:44:19 INFO - blobuploader == 1.2.4 07:44:19 INFO - docopt == 0.6.1 07:44:19 INFO - functools32 == 3.2.3-2 07:44:19 INFO - jsonschema == 2.5.1 07:44:19 INFO - manifestparser == 1.1 07:44:19 INFO - mozInstall == 1.12 07:44:19 INFO - mozcrash == 1.0 07:44:19 INFO - mozdebug == 0.1 07:44:19 INFO - mozdevice == 0.49 07:44:19 INFO - mozfile == 1.2 07:44:19 INFO - mozhttpd == 0.7 07:44:19 INFO - mozinfo == 0.9 07:44:19 INFO - mozleak == 0.1 07:44:19 INFO - mozlog == 3.4 07:44:19 INFO - moznetwork == 0.27 07:44:19 INFO - mozprocess == 0.23 07:44:19 INFO - mozprofile == 0.28 07:44:19 INFO - mozrunner == 6.13 07:44:19 INFO - mozscreenshot == 0.1 07:44:19 INFO - mozsystemmonitor == 0.3 07:44:19 INFO - moztest == 0.7 07:44:19 INFO - mozversion == 1.4 07:44:19 INFO - psutil == 3.1.1 07:44:19 INFO - requests == 1.2.3 07:44:19 INFO - wsgiref == 0.1.2 07:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:19 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')]} 07:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:19 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')]} 07:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:19 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:19 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 07:44:19 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 07:44:19 INFO - Using env: {'DISPLAY': ':0', 07:44:19 INFO - 'HOME': '/home/cltbld', 07:44:19 INFO - 'LANG': 'en_US.UTF-8', 07:44:19 INFO - 'LANGUAGE': 'en_US:en', 07:44:19 INFO - 'LOGNAME': 'cltbld', 07:44:19 INFO - 'MAIL': '/var/mail/cltbld', 07:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:19 INFO - 'MOZ_NO_REMOTE': '1', 07:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:19 INFO - 'NO_EM_RESTART': '1', 07:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:19 INFO - 'PWD': '/builds/slave/test', 07:44:19 INFO - 'SHELL': '/bin/bash', 07:44:19 INFO - 'SHLVL': '1', 07:44:19 INFO - 'TERM': 'linux', 07:44:19 INFO - 'TMOUT': '86400', 07:44:19 INFO - 'USER': 'cltbld', 07:44:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:19 INFO - '_': '/tools/buildbot/bin/python'} 07:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 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)) 07:44:20 INFO - Cleaning up... 07:44:20 INFO - Return code: 0 07:44:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:20 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 0x7fabeec6be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, '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': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', '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 07:44:20 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 07:44:20 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 07:44:20 INFO - Using env: {'DISPLAY': ':0', 07:44:20 INFO - 'HOME': '/home/cltbld', 07:44:20 INFO - 'LANG': 'en_US.UTF-8', 07:44:20 INFO - 'LANGUAGE': 'en_US:en', 07:44:20 INFO - 'LOGNAME': 'cltbld', 07:44:20 INFO - 'MAIL': '/var/mail/cltbld', 07:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:20 INFO - 'MOZ_NO_REMOTE': '1', 07:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:20 INFO - 'NO_EM_RESTART': '1', 07:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:20 INFO - 'PWD': '/builds/slave/test', 07:44:20 INFO - 'SHELL': '/bin/bash', 07:44:20 INFO - 'SHLVL': '1', 07:44:20 INFO - 'TERM': 'linux', 07:44:20 INFO - 'TMOUT': '86400', 07:44:20 INFO - 'USER': 'cltbld', 07:44:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:20 INFO - '_': '/tools/buildbot/bin/python'} 07:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:44:20 INFO - Cleaning up... 07:44:20 INFO - Return code: 0 07:44:20 INFO - Running post-action listener: _resource_record_post_action 07:44:20 INFO - Running post-action listener: _start_resource_monitoring 07:44:20 INFO - Starting resource monitoring. 07:44:20 INFO - [mozharness: 2016-11-25 15:44:20.421225Z] Finished create-virtualenv step (success) 07:44:20 INFO - [mozharness: 2016-11-25 15:44:20.421739Z] Running install step. 07:44:20 INFO - Running pre-action listener: _resource_record_pre_action 07:44:20 INFO - Running main action method: install 07:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:20 INFO - Reading from file tmpfile_stdout 07:44:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:20 INFO - Reading from file tmpfile_stdout 07:44:20 INFO - Output received: 07:44:20 INFO - Usage: mozinstall [options] installer 07:44:20 INFO - Options: 07:44:20 INFO - -h, --help show this help message and exit 07:44:20 INFO - -d DEST, --destination=DEST 07:44:20 INFO - Directory to install application into. [default: 07:44:20 INFO - "/builds/slave/test"] 07:44:20 INFO - --app=APP Application being installed. [default: firefox] 07:44:20 INFO - mkdir: /builds/slave/test/build/application 07:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:44:37 INFO - Reading from file tmpfile_stdout 07:44:37 INFO - Output received: 07:44:37 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:37 INFO - Running post-action listener: _resource_record_post_action 07:44:37 INFO - [mozharness: 2016-11-25 15:44:37.179515Z] Finished install step (success) 07:44:37 INFO - [mozharness: 2016-11-25 15:44:37.179753Z] Running run-tests step. 07:44:37 INFO - Running pre-action listener: _resource_record_pre_action 07:44:37 INFO - Running main action method: run_tests 07:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:37 INFO - Python 2.7.3 07:44:37 INFO - Return code: 0 07:44:37 INFO - grabbing minidump binary from tooltool 07:44:37 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')]} 07:44:37 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 0x12f2fc0>, '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 0x12f3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f4350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:37 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 07:44:37 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 07:44:37 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 07:44:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:37 INFO - Return code: 0 07:44:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 07:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 07:44:37 INFO - Using env: {'DISPLAY': ':0', 07:44:37 INFO - 'HOME': '/home/cltbld', 07:44:37 INFO - 'LANG': 'en_US.UTF-8', 07:44:37 INFO - 'LANGUAGE': 'en_US:en', 07:44:37 INFO - 'LOGNAME': 'cltbld', 07:44:37 INFO - 'MAIL': '/var/mail/cltbld', 07:44:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:37 INFO - 'MOZ_NO_REMOTE': '1', 07:44:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:37 INFO - 'NO_EM_RESTART': '1', 07:44:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:37 INFO - 'PWD': '/builds/slave/test', 07:44:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:37 INFO - 'SHELL': '/bin/bash', 07:44:37 INFO - 'SHLVL': '1', 07:44:37 INFO - 'TERM': 'linux', 07:44:37 INFO - 'TMOUT': '86400', 07:44:37 INFO - 'USER': 'cltbld', 07:44:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854', 07:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:37 INFO - '_': '/tools/buildbot/bin/python'} 07:44:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 07:44:37 INFO - mozversion application_buildid: 20161125062719 07:44:37 INFO - mozversion application_changeset: c41dab3b9a7230a377d68d30244bd201258ce10d 07:44:37 INFO - mozversion application_display_name: Nightly 07:44:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:37 INFO - mozversion application_name: Firefox 07:44:37 INFO - mozversion application_remotingname: firefox 07:44:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:44:37 INFO - mozversion application_vendor: Mozilla 07:44:37 INFO - mozversion application_version: 53.0a1 07:44:37 INFO - mozversion platform_buildid: 20161125062719 07:44:37 INFO - mozversion platform_changeset: c41dab3b9a7230a377d68d30244bd201258ce10d 07:44:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:44:37 INFO - mozversion platform_version: 53.0a1 07:44:37 INFO - using testdate: 1480088677 07:44:37 INFO - actual date: 1480088677 07:44:37 INFO - starting webserver on 'localhost:38625' 07:44:37 INFO - SUITE-START | Running 2 tests 07:44:37 INFO - TEST-START | dromaeo_css 07:44:37 INFO - operating with platform_type : linux_ 07:44:37 INFO - Initialising browser for dromaeo_css test... 07:44:37 INFO - TEST-INFO | started process 24167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppyRdrI/profile http://localhost:38625/getInfo.html) 07:44:41 INFO - PROCESS | 24167 | __metrics Screen width/height:1600/1200 07:44:41 INFO - PROCESS | 24167 | colorDepth:24 07:44:41 INFO - PROCESS | 24167 | Browser inner width/height: 1024/697 07:44:41 INFO - PROCESS | 24167 | __metrics 07:44:42 INFO - PROCESS | 24167 | 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" 07:44:42 INFO - PROCESS | 24167 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:44:43 INFO - TEST-INFO | 24167: exit 0 07:44:43 INFO - Browser initialized. 07:44:43 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:43 INFO - TEST-INFO | started process 24250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppyRdrI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:55 INFO - PROCESS | 24250 | RSS: Main: 174710784 07:44:55 INFO - PROCESS | 24250 | 07:45:47 INFO - PROCESS | 24250 | 1480088747490 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] 07:48:01 INFO - PROCESS | 24250 | Cycle 1(1): loaded http://localhost:38625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38625/tests/dromaeo/cssquery-ext.html) 07:48:02 INFO - PROCESS | 24250 | RSS: Main: 289599488 07:48:02 INFO - PROCESS | 24250 | 07:51:05 INFO - PROCESS | 24250 | Cycle 1(1): loaded http://localhost:38625/tests/dromaeo/cssquery-ext.html (next: http://localhost:38625/tests/dromaeo/cssquery-jquery.html) 07:51:06 INFO - PROCESS | 24250 | RSS: Main: 277856256 07:51:06 INFO - PROCESS | 24250 | 07:54:08 INFO - PROCESS | 24250 | Cycle 1(1): loaded http://localhost:38625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38625/tests/dromaeo/cssquery-mootools.html) 07:54:09 INFO - PROCESS | 24250 | RSS: Main: 255877120 07:54:09 INFO - PROCESS | 24250 | 07:57:11 INFO - PROCESS | 24250 | Cycle 1(1): loaded http://localhost:38625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38625/tests/dromaeo/cssquery-prototype.html) 07:57:12 INFO - PROCESS | 24250 | RSS: Main: 222883840 07:57:12 INFO - PROCESS | 24250 | 08:00:15 INFO - PROCESS | 24250 | Cycle 1(1): loaded http://localhost:38625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38625/tests/dromaeo/cssquery-yui.html) 08:00:16 INFO - PROCESS | 24250 | RSS: Main: 227291136 08:00:16 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | Cycle 1(1): loaded http://localhost:38625/tests/dromaeo/cssquery-yui.html (next: http://localhost:38625/tests/dromaeo/cssquery-dojo.html) 08:03:19 INFO - PROCESS | 24250 | RSS: Main: 298848256 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | __start_tp_report 08:03:19 INFO - PROCESS | 24250 | _x_x_mozilla_page_load 08:03:19 INFO - PROCESS | 24250 | _x_x_mozilla_page_load_details 08:03:19 INFO - PROCESS | 24250 | |i|pagename|runs| 08:03:19 INFO - PROCESS | 24250 | |0;dojo.html;2547.477767057753;2592.325995241237;2608.4391855751014;2622.4755048990196;2637.617545455909;4583.427071616048;4647.558481944214;4648.65135114866;4686.531346865316;4686.695364801286;4667.416572928384;4667.996380778132;4679.087577922306;4679.344891715163;4690.624750019999;4252.702310838243;4281.67887408444;4288.69979101463;4315.978420107895;4350.608445239928;4238.533761286256;4239.3852891330735;4255.255330317182;4256.787160641956;4262.019735460846;4207.516135644394;4233.851815186469;4264.701470897038;4290.785460726966;4298.161858437606;4347.087111706545;4347.174036933005;4352.7605981670995;4355.128974205171;4362.8036738346855;4170.645495132917;4208.347706105558;4222.408862759216;4263.104748002923;4265.253580623378;4639.025804581042;4659.114768194032;4661.044485880387;4667.649926255544;4729.0541891621815;4941.975290123526;4979.825706100305;4990.725510096943;4992.82525111623;5022;4839.927401088987;4872.488388719169;4873.220284754458;5003.574696150831;5057.772400241961;4647.070585882837;4666.136764698542;4682.648801339913;4710.882227944328;4755.738434386142;5139.974300128475;5149.819756308511;5154.9484505155215;5156.613254005964;5201.011807756589;4742.976285118552;4914.140025495524;4930.901381972412;4932.408111026628;4975.004999000214;4857.101436234238;4914.140025495524;4939.950600493949;4967.850964471072;4969.652124351261;4933.531314525115;4934.876628084255;4935.851924442272;4972.403311602631;4978.502149785065;4914.950850491521;4928.507149285043;4929.950700493021;4930;4965.702057876539;4036.1524079942956;4038.0510580013674;4081.91836163281;4119.7940102994735;4132.462779838602;3597.9460308094876;3608.9278214435562;3633.691136253448;3644.8177591120866;3662.9816850915577;4303.419038429772;4304;4312.978435107804;4321.222180007566;4339.500957389878;4959.82640607577;4965.875853103701;4966.925496117561;4967.925481117786;5036.32009678696;4220.198162349144;4267.8292868284925;4287.485501739811;4294.892627684333;4328.220920234388;4391.077873646506;4415.51429342772;4423.225935461282;4432.069265454291;4437.2234858899565;4704.0356726870905;4709.670323077352;4709.81160753566;4712.057588482248;4714.7406892619865;4925.704457732548;4959.380077490314;4968.080905032436;4971.900561988812;4977.129002424634;4706.599939005086;4707.246840505502;4708.92936605958;4710.340552322609;4710.858674239778;4862.6839255449695;4873.074115917964;4876.341693871424;4876.829310974099;4878.121938051043;4927.778249978688;4932.062908047459;4934.18585933317;4953.455119936732;4954.603631709527;4808.158572249912;4882.389701287339;4885.487023862585;4885.853424397274;4930.285108659296;4862.4651288357545;4870.147724148331;4876.341693871282;4878.390201224847;4922.630802689741;4600.677952543289;4645.465771436328;4718.575328220477;4758.547937945889;4758.666893317434;4866.124097662455;4868.440129385166;4876.4392094909535;4921.557059864629;4940.110780059624;4752.833650822205;4766.451858036232;4769.14155452022;4773.9761301193275;4821.54195351441 08:03:19 INFO - PROCESS | 24250 | |1;ext.html;537.0842713174038;548.9917651235231;549.1488193300384;560.2548610348236;574.2420005592619;27511;37643.435348469764;39004.60995390045;39020;42428;38392.80803595985;38845.22309553807;38883.805580972126;38892.02769930753;38896.611033889654;7376.594287314196;7470.813229669247;7495.625218739068;7531.585762783045;7531.661075251627;7434.219406962272;7631.847363052736;9459.432434053944;9679.95160024199;9684.806303873918;9595.616175352978;9645.131938125567;9649.614015439409;9660.082292182267;9662.855057174113;9673.661421850236;9721.902780972241;9727.367721098106;9733.22134229267;9741.756456088619;9619.759506012335;9633.807323853554;9697.612095516242;9700.417974921527;9713.66002189927;34857.30285394303;35108.473372899425;35151.1212219694;35152.82423587866;35190.82404587986;3132.592762940826;3270.7546933979806;3395.2021275000357;3576.9821150894077;3636.054625797285;28605.42789144226;28799.856000720072;29281.41437171266;30717.846410768027;31943.840280798446;3009.458297506448;3047.3905218956074;3077.2306923269184;3092.335147943203;3134.5925029746213;220506;221020;221478;222055;222985;50583;50885.23672144921;50906;51048.234276485884;51049.744751276005;52672.473275267526;52718;52750.73624631852;52795.47204527982;52798.73600631972;13410.664733381744;13872.930635346758;13890.652733681738;13897.513587024405;13901.096428732302;9765.755856103513;10073.899261007442;10825.350478971286;10963.122950164126;10968.725781855517;16451;16996.490105296612;16996.745048824276;17724.734128988075;17755.46733597994;6584.341565843473;6714.764983225564;6717.865642687118;6732.7643532477105;6822.897656535156;767.3247542162861;844.8310337932438;872.0059132588854;914.8216097860986;932.9300302477342;25278.873605632223;27070.86464567704;27177.72822271752;27394.45211095767;27533.86233068862;907.6687009241712;943.0757857299884;986.4722373530127;1005.8541511480794;1021.0300214795825;14177.362018709182;14463.27683615815;14525.854741452662;14691.632709182357;14871.18208498543;109491.45254273836;109583.45208273908;109594.45202773935;109867.45066274618;314733;47026.5297347029;47575.28637070447;47648.28527572089;47652;47661.52338476571;1039.7816458543791;1089.493385575711;1123.2754873106965;1153.9307641541534;1193.3734789235373;25979.350516237246;27317.45365092727;28023.439531209668;28218.46033856963;28506.42987140287;39071.41392879166;39538.80230598828;39558.604413955494;39598.60401396064;39653.405198921464;235293;236356;237080;237157;237162;23772.64341034851;24607.261782146565;24629.13798017061;25737.227883162785;25951.61072583875;38830.4175437363;39254;39306.803465982484;40132.79933600313;40521.392179117924;33510;33522.49716254307;33697;33890.830545847115;34450.310993780484;32689;33042.66957330396;33389.83305083459;34295.31409371849;34605.30789384249;32811.50782738309;33282.16794580155;33390.83304583462;33862.492062619574;34016.82991585125;29778.702212977594;30634.693653063183;30680.693193067782;30688.232794180323;30898;23329.18347857817;23966.88016559976;23982.52034959256;24163.395915102265;24305.14931977372 08:03:19 INFO - PROCESS | 24250 | |2;jquery.html;322.7901863788539;325.1302765103348;332.4746899898161;334.0657592539198;335.46325878594246;12223.205491643037;15172.468963586263;15321.70174473828;16677.91661041696;16957.3217071317;14423.63940901478;14939.850601493981;15020.573045560654;16237.26932288047;16607.91696041518;4473.776311184444;4533.863984080483;4595.379623750801;4675.018246168309;4683.437987441512;3476.2004738910064;4552.203364411214;4630.907381852361;4635.304704294366;4636.235021221494;3637.199816040467;5133.666311689747;5373.113436283028;5414.160805075219;5493.587980901429;5196.142636464979;5423.403425623178;5428.75570599322;5439.972800135974;5461.317335333083;5257.922125964168;5369.436209198017;5374.167004114369;5374.48942350476;5374.973125134388;12233.755324893542;12359.75280494394;12375.876241237562;12435.316057616827;12466.314352710597;1780.1811166863258;1823.7629108215979;1828.4423250908467;1911.1877452082808;1949.6198241342943;8734.563271836383;8796.076411976714;9009;9080.31897607682;9605.18355939746;1664.4840099569171;1707.5560354307845;1737.1589942973042;1748.8163742806948;1764.9558761030949;55701;61631.76130028908;63303;64413.355866441205;65321.346786532;9654.469004204837;9660.613575456902;9832.901670983341;9864.408135511892;9999.650012249536;13349.66625834362;13401.396937137852;13408.262545559894;13413.731725365438;13457.798133028013;7085.92914070863;7309.9429816452375;7316.670749816271;7395.556266624019;7404.222556631584;6482.643454609947;6671.232808227019;6789.6605169741315;7157.821054473576;7160.677769500281;4212.873613791591;4264.974137284827;4315.201687687788;4414.911701765946;4435.401220835211;1765.1262625000707;1877.3616970230187;1882.7740671119554;1895.336632178754;1924.9615007699767;756.528551966431;765.5330248548381;795.6021989005498;807.6930766308765;811.4157806379397;15744.527664170093;15963;15967.201639917957;16334.264958076916;16904.830951690572;892.4511425473287;896.8027034052498;901.6348378906554;908.3550679017972;909.508865212791;8847.778805529913;8941.687040953535;9192;9222.53887305632;9254.4910029949;313925;319377;319797;325876;326860;69571.65214173897;70841.93737093947;71700;73534.26465735381;74090;841.6507149532998;864.8745931839974;872.0233338660614;873.0178549132099;873.8033942363045;14152.646183845074;14419.78370324467;14855.851441485447;14862.580230105299;14886.255687215813;32428;33186;33470;33813.15467113243;34324.656753432144;45011;46879.76560117178;46940.53059469361;48675;52947;7467.663955121924;7567.167611562833;7703.53778773253;7713.498622589514;7750.496217745828;8960.731178064669;11240.269382490113;11250.718732031764;11702.719898202491;11932.70168245766;9824.901750982684;9990.400575965465;10137.341072830242;10215.233857460571;10522.31604945676;9978.550965206437;10002.899971000488;10106.242031847494;10273.229507786797;10364.481775911023;9774.413535187912;10038.247131465316;10055.29612927088;10452.68641940743;10914.96307850753;7522.247775222434;7545.7358992435;7547.99978005818;7628.351590114902;7965.601719914097;7961.6019199040975;9249;9913.107820296207;10140.492975351055;10423.166146708094 08:03:19 INFO - PROCESS | 24250 | |3;mootools.html;1197.4491733802452;1303.8826505614495;1330.773768459362;1352.1954437109923;1591.8986937242844;5713.542916566675;6183.258009038916;6415.069814876846;6433.774817881364;6573.605583664984;6359.68201589921;6403.263624683163;6405.26339470961;6415.839604009902;6418.775342863;1731.3420900058022;1785.8571314294825;1969.0450131686157;2003.5592169722638;2004.368623883472;1957.9510512237166;2006.6388050150968;2006.9096890639883;2019.8081182287658;2030.0661695620033;1974.3682021753045;1978.5251539630458;1980.3167907072036;1983.7917018713044;1986.275009621485;1988.2941555747645;2004.4287378097317;2009.859309848311;2011.8692285001428;2013.1444136242185;1954.355062829263;1969.359958013637;1994.311962372979;1996.5607566335384;2004.3185316992292;6718.3953444189765;6777.085093512412;6793.898091528631;6795.014722865157;6800.727970881158;4011.13760541485;4112.712110152291;4132.070284186064;4134.937975930364;4138.110306284133;2527.4692314613953;2652.8938842446278;2658.6410834537282;2681.6647919010124;2762.986185069082;836.6318819719365;889.817587394589;897.228383590112;908.4821651658557;916.4363916191561;8577.52823594702;8623.31013518917;8632.956835215846;8643.65425382984;8660.177283158153;3567.8761190224996;3583.928321433557;3661.2494438640015;3738.925221495555;3745.2883952049024;7466.85066298671;7481.9251807482315;7486.962565187139;7491.550506969599;7506.662200201004;4062.1266427718183;4062.878113656595;4065.8170382332864;4067.3695577185586;4069.715119941635;3255.6256030556788;3353.178471274505;3607.585127710347;3632.582253040934;3687.981560092236;3171.698688624577;3173.809571425722;3249.8050116993054;3284.6186514776596;3305.2067503798917;1055.6832950114936;1062.4793851012948;1075.8924107589178;1078.1751959750798;1079.6599071292517;782.2021538031177;792.6076592086839;801.3909428834128;809.874469457235;819.1603606303587;4507.842225522157;4540.387047748578;4686.250199967989;4793.1372352976105;4922.704637721748;850.9829803404022;853.6926706385697;930.2093220762298;932.1424289653535;938.2306508662967;3524.22467057247;3669.5779985301497;3684.1710615111388;3726.142987112925;3742.550893892696;7913.802154946057;7975.84048319042;8092.757217283491;8100.068492123363;8103.432759706764;8025.357971362277;8027.317677997436;8030.397720170894;8040.477368970998;8040.678372865137;6247.281562620356;6428.19647544057;6431.710573024225;6434.581752186093;6436.324185960407;4651.837185698484;4770.976145119253;4772.771533149274;4858.125537403302;5119.28330033803;7182.138143422822;7307.3058059484265;7312.670929808065;7333.230010848784;7370.336669699753;7008.264132266038;7349.191588925107;7351.26487351282;7357.889631655637;7366.789963010968;5138.997895410359;5480.534154596904;5722.0272553665145;5756.3380211276235;5767.653940763567;5846.912296315644;6141.293751218488;6380.138681277968;6389.073584330153;6502.739890404331;5839.0949402842625;5860.648361098348;5878.088896221093;5894.882102357843;5988.520918326611;5652.434756524314;5724.74238659253;5809.390014048633;5826.242588463642;5910.054391297372;5516.806911758069;5524.4199359066715;5533.667979921218;5544.251526044094;5581.804636837691;4047.9392809108476;4080.6123418275215;4096.5903409658795;4128.793560322032;4140.068484590943;4256.404103425461;4300.698951073395;4337.436133302651;4409.272470042407;4497.392851964943 08:03:19 INFO - PROCESS | 24250 | |4;prototype.html;262.26957922186716;266.62672258837637;270.8970591175354;272.1020631914681;277.1187623357722;4718.292256161578;4751.2873069039615;4753.33453316536;4753.786079626417;4774.618030557555;4649.209634362158;4666.929996050054;4667.6732628716;4671.322658214557;4681.133990211813;3481.7736847104984;3523.5947865995354;3589.5513060867393;3592.1738000259957;3679.632036796326;3627.6372362763777;3631.7276204284653;3649.3066317399744;3651.7991510466913;3653.433717773736;3623.8912832615065;3625.111847597342;3642.8178591070473;3644.7084233261407;3653.908652283701;3461.2904354607244;3545.3263879862743;3556.146524834047;3594.388953877847;3659.652333028358;3111.9533207001914;3142.3872344892757;3196.488561830096;3197.216681912923;3220.855061522237;4490.685652004361;4501.189785838547;4504.747626186907;4514.097180563867;4534.274516077412;4026.4564283821896;4126.855560055384;4132.855350062763;4146.751194928283;4151.4395556599775;4803.591694705954;4812.350332705075;4823.564100129447;4829.3721816164025;4852.078105160008;3478.739094567892;3489.70337521311;3493.598236202844;3536.257385948954;3546.3616549021167;5137.229415587654;5156.845294641129;5179.119549676564;5184.5593124584075;5200.245964335188;3311.2880730642546;3442.569678790151;3469.098034511045;3481.1993241554583;3650.5397840863866;3503.8948831534585;3509.701675357623;3513.894583162509;3519.665631764978;3528.400171970771;4079.632833044981;4084.7949854792905;4086.8773936781945;4100.733452325649;4116.521539299288;4761.928571071437;4978.2034874419915;4994.750262486861;4997.350344455198;4998.500149985045;1168.9357085360216;1188.7028242939266;1192.9880701192876;1193.8925496705165;1199.9380548214717;783.7452827830978;806.5967016491754;818.4475479051616;821.1542111624916;825.3067423364403;4255.510616279105;4269.466316710411;4276.444062271885;4281.7582900959;4372.726182385142;5003.722561722077;5095.401345313842;5096.694198348111;5109.080365534165;5133.25567792668;4390.143921935192;4413.293872980308;4420.226460369422;4425.336199570026;4441.400410944481;2508.5735424977797;2587.974120258811;2607.9478410432066;2610.838177011212;2611.595202743578;4628.884277893012;4634.328022436795;4641.234196357631;4648.605967926521;4720.362751028636;5048.545630893237;5065.645404821627;5066.48005598319;5074.441811400743;5080.491950804964;4456.509783923766;4628.5602867728185;4637.513061128533;4683.414573178353;4693.6949098308505;4859.028194361213;4914.967856750122;4920.507949205051;4927;4950.183219768698;4827.662063655511;4829.73436460998;4839.782209800497;4840.273958906192;4843.297721830244;4476.955230447784;4629.971924425637;4662.976685116552;4664.930026049544;4685.156671799109;3418.2479854431986;3424.8630054798527;3443.603985541695;3457.8789742358895;3460.948085778665;4960.727160006234;4963.081829861487;4967.572375061196;4972.453030166606;5012.649114561946;4632.907341853212;4796.904061918673;4813.614910807197;4819.1566475867285;4842.539958703917;4729.864832440258;4757.524247575215;4786.928196076992;4787.952120478751;4816.036792641416;4615.884602884955;4656.115338085753;4682.083811997321;4682.1103990241745;4701;4651.325034633307;4798.760061996956;4805.630395337452;4841.709497430165;4860.829870954641;4719.433667959866;4733.195356789423;4743.620510359232;4745.6678032538775;4748.928766068442 08:03:19 INFO - PROCESS | 24250 | |5;yui.html;649.5972497051827;658.259458109627;670.8624731929955;680.7821497120921;733.5158795195172;11519.136064795131;12483.875161248396;12495.062870284719;12495.43770530326;12510.4995800168;11585.884141158585;11640.650780476599;11653.766924661502;11666.533338666442;11671.591494297702;612.3294991983771;626.8934281172212;736.2416710787898;743.0192146366811;756.9621518924059;745.6756311004731;759.5670467833337;759.7644730133649;759.8328367759084;759.8480303939207;803.6905791270344;806.4677312973439;806.4757907360233;807.3178164451059;807.6204184033525;640.4492136762381;660.7753363856264;774.1213722425032;801.967921283148;803.7146812881431;581.5609215042658;587.0138167877964;587.4272584230384;587.7325816753367;587.9059350503942;12557.937210313981;12565.308908010056;12602.495900163982;12605.873941260561;12615.558455454107;12150.817737733942;12353.505859765599;12709.491620335175;12750.936245318713;12829.807552886621;11157.27477713946;11183.720406989809;11194.216404851664;11223.719407014809;11423.828642570368;3933.8229779659982;3948.5853985331414;3993.5407428145845;4005.679545636342;4007.5190977082643;50363;52873;53081.46918530804;53216.73391633056;53230.733846330906;9218.677346292847;9312.068793120769;9398.90601093994;9539.14147726708;9539.284553658365;15713.764293535605;16196.595085122966;16254.837451625332;16264;16942.491725248263;6463.256725476536;6524.543281970311;6541.443977261986;6851.45188384928;6919.688614012382;3650.5619325681087;3730.1047748540154;3747.138158223624;3789.3558095123894;3807.0862992881507;2483.2426110036613;2541.466292078684;2559.8976040958523;2565.538203123456;2569.0494517028446;465.89051572880345;468.52912822613735;471.4907899468566;475.6171282117928;477.38417441500076;555.3252797850631;569.0780934885512;591.2077815726947;594.9762009519658;603.2308806272039;6966.582005079711;7018.719251229996;7235.782926512213;7286.526375785557;7525.58609276495;438.04069088695655;463.2287241742528;491.3170692737098;569.3225062175998;572.5836967995054;3682.5212722345923;3689.760165589228;3786.6970642348547;3860.2472517858746;3915.197384536163;40491.595084049375;51023.48976510262;63281;68311.65844170748;68666.313336867;38025.61974380276;38584.42123368096;40519.59480405217;57709.422905771244;59142.70428647829;35097.64902350995;55882;56253.43746562482;56457.15314270289;57252;7037.964810175917;7289.380402665833;7429.33136017761;7507.774766757006;7545.132309784445;36554;38135.42796858105;38460.23079538337;38826.41760373653;39073.60926390813;46034;46034.61896143121;47118;48830;48969.51030489792;9209.125133112344;9236.861447078434;9508.11018092913;9650.71047868565;9653.565589548627;10560.313579617301;10794.73013174677;10840.186985975926;10878.456077196266;10967;9708.126268635857;10098.293119481566;10476.742790865144;10486.89887561795;10503.47482625881;10099.798004040025;10271.7432064196;10312.587496500057;10482.056614904695;10631.096356809758;9880.802383952425;10217;10261;10409.219308551737;10437.895621043692;8117.472364296302;8337.791555210926;8506.574671266288;8620.310375170096;8854.645814167361;8098.473599216032;8169.79575510617;8400.579971001303;8409.327253819802;8625.39622226438 08:03:19 INFO - PROCESS | 24250 | __end_tp_report 08:03:19 INFO - PROCESS | 24250 | __start_cc_report 08:03:19 INFO - PROCESS | 24250 | _x_x_mozilla_cycle_collect,1243 08:03:19 INFO - PROCESS | 24250 | __end_cc_report 08:03:19 INFO - PROCESS | 24250 | __startTimestamp1480089799403__endTimestamp 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | ------- Summary: start ------- 08:03:19 INFO - PROCESS | 24250 | Number of tests: 6 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | [#0] dojo.html Cycles:165 Average:4590.78 Median:4710.88 stddev:487.16 (10.3%) stddev-sans-first:461.53 08:03:19 INFO - PROCESS | 24250 | Values: 2547.5 2592.3 2608.4 2622.5 2637.6 4583.4 4647.6 4648.7 4686.5 4686.7 4667.4 4668.0 4679.1 4679.3 4690.6 4252.7 4281.7 4288.7 4316.0 4350.6 4238.5 4239.4 4255.3 4256.8 4262.0 4207.5 4233.9 4264.7 4290.8 4298.2 4347.1 4347.2 4352.8 4355.1 4362.8 4170.6 4208.3 4222.4 4263.1 4265.3 4639.0 4659.1 4661.0 4667.6 4729.1 4942.0 4979.8 4990.7 4992.8 5022.0 4839.9 4872.5 4873.2 5003.6 5057.8 4647.1 4666.1 4682.6 4710.9 4755.7 5140.0 5149.8 5154.9 5156.6 5201.0 4743.0 4914.1 4930.9 4932.4 4975.0 4857.1 4914.1 4940.0 4967.9 4969.7 4933.5 4934.9 4935.9 4972.4 4978.5 4915.0 4928.5 4930.0 4930.0 4965.7 4036.2 4038.1 4081.9 4119.8 4132.5 3597.9 3608.9 3633.7 3644.8 3663.0 4303.4 4304.0 4313.0 4321.2 4339.5 4959.8 4965.9 4966.9 4967.9 5036.3 4220.2 4267.8 4287.5 4294.9 4328.2 4391.1 4415.5 4423.2 4432.1 4437.2 4704.0 4709.7 4709.8 4712.1 4714.7 4925.7 4959.4 4968.1 4971.9 4977.1 4706.6 4707.2 4708.9 4710.3 4710.9 4862.7 4873.1 4876.3 4876.8 4878.1 4927.8 4932.1 4934.2 4953.5 4954.6 4808.2 4882.4 4885.5 4885.9 4930.3 4862.5 4870.1 4876.3 4878.4 4922.6 4600.7 4645.5 4718.6 4758.5 4758.7 4866.1 4868.4 4876.4 4921.6 4940.1 4752.8 4766.5 4769.1 4774.0 4821.5 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | [#1] ext.html Cycles:180 Average:37023.42 Median:18706.02 stddev:55247.16 (295.3%) stddev-sans-first:55334.22 08:03:19 INFO - PROCESS | 24250 | Values: 537.1 549.0 549.1 560.3 574.2 27511.0 37643.4 39004.6 39020.0 42428.0 38392.8 38845.2 38883.8 38892.0 38896.6 7376.6 7470.8 7495.6 7531.6 7531.7 7434.2 7631.8 9459.4 9680.0 9684.8 9595.6 9645.1 9649.6 9660.1 9662.9 9673.7 9721.9 9727.4 9733.2 9741.8 9619.8 9633.8 9697.6 9700.4 9713.7 34857.3 35108.5 35151.1 35152.8 35190.8 3132.6 3270.8 3395.2 3577.0 3636.1 28605.4 28799.9 29281.4 30717.8 31943.8 3009.5 3047.4 3077.2 3092.3 3134.6 220506.0 221020.0 221478.0 222055.0 222985.0 50583.0 50885.2 50906.0 51048.2 51049.7 52672.5 52718.0 52750.7 52795.5 52798.7 13410.7 13872.9 13890.7 13897.5 13901.1 9765.8 10073.9 10825.4 10963.1 10968.7 16451.0 16996.5 16996.7 17724.7 17755.5 6584.3 6714.8 6717.9 6732.8 6822.9 767.3 844.8 872.0 914.8 932.9 25278.9 27070.9 27177.7 27394.5 27533.9 907.7 943.1 986.5 1005.9 1021.0 14177.4 14463.3 14525.9 14691.6 14871.2 109491.5 109583.5 109594.5 109867.5 314733.0 47026.5 47575.3 47648.3 47652.0 47661.5 1039.8 1089.5 1123.3 1153.9 1193.4 25979.4 27317.5 28023.4 28218.5 28506.4 39071.4 39538.8 39558.6 39598.6 39653.4 235293.0 236356.0 237080.0 237157.0 237162.0 23772.6 24607.3 24629.1 25737.2 25951.6 38830.4 39254.0 39306.8 40132.8 40521.4 33510.0 33522.5 33697.0 33890.8 34450.3 32689.0 33042.7 33389.8 34295.3 34605.3 32811.5 33282.2 33390.8 33862.5 34016.8 29778.7 30634.7 30680.7 30688.2 30898.0 23329.2 23966.9 23982.5 24163.4 24305.1 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | [#2] jquery.html Cycles:180 Average:21385.95 Median:4635.77 stddev:53280.92 (1149.3%) stddev-sans-first:53406.92 08:03:19 INFO - PROCESS | 24250 | Values: 322.8 325.1 332.5 334.1 335.5 12223.2 15172.5 15321.7 16677.9 16957.3 14423.6 14939.9 15020.6 16237.3 16607.9 4473.8 4533.9 4595.4 4675.0 4683.4 3476.2 4552.2 4630.9 4635.3 4636.2 3637.2 5133.7 5373.1 5414.2 5493.6 5196.1 5423.4 5428.8 5440.0 5461.3 5257.9 5369.4 5374.2 5374.5 5375.0 12233.8 12359.8 12375.9 12435.3 12466.3 1780.2 1823.8 1828.4 1911.2 1949.6 8734.6 8796.1 9009.0 9080.3 9605.2 1664.5 1707.6 1737.2 1748.8 1765.0 55701.0 61631.8 63303.0 64413.4 65321.3 9654.5 9660.6 9832.9 9864.4 9999.7 13349.7 13401.4 13408.3 13413.7 13457.8 7085.9 7309.9 7316.7 7395.6 7404.2 6482.6 6671.2 6789.7 7157.8 7160.7 4212.9 4265.0 4315.2 4414.9 4435.4 1765.1 1877.4 1882.8 1895.3 1925.0 756.5 765.5 795.6 807.7 811.4 15744.5 15963.0 15967.2 16334.3 16904.8 892.5 896.8 901.6 908.4 909.5 8847.8 8941.7 9192.0 9222.5 9254.5 313925.0 319377.0 319797.0 325876.0 326860.0 69571.7 70841.9 71700.0 73534.3 74090.0 841.7 864.9 872.0 873.0 873.8 14152.6 14419.8 14855.9 14862.6 14886.3 32428.0 33186.0 33470.0 33813.2 34324.7 45011.0 46879.8 46940.5 48675.0 52947.0 7467.7 7567.2 7703.5 7713.5 7750.5 8960.7 11240.3 11250.7 11702.7 11932.7 9824.9 9990.4 10137.3 10215.2 10522.3 9978.6 10002.9 10106.2 10273.2 10364.5 9774.4 10038.2 10055.3 10452.7 10915.0 7522.2 7545.7 7548.0 7628.4 7965.6 7961.6 9249.0 9913.1 10140.5 10423.2 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | [#3] mootools.html Cycles:180 Average:4428.52 Median:5309.77 stddev:2318.44 (43.7%) stddev-sans-first:2312.22 08:03:19 INFO - PROCESS | 24250 | Values: 1197.4 1303.9 1330.8 1352.2 1591.9 5713.5 6183.3 6415.1 6433.8 6573.6 6359.7 6403.3 6405.3 6415.8 6418.8 1731.3 1785.9 1969.0 2003.6 2004.4 1958.0 2006.6 2006.9 2019.8 2030.1 1974.4 1978.5 1980.3 1983.8 1986.3 1988.3 2004.4 2009.9 2011.9 2013.1 1954.4 1969.4 1994.3 1996.6 2004.3 6718.4 6777.1 6793.9 6795.0 6800.7 4011.1 4112.7 4132.1 4134.9 4138.1 2527.5 2652.9 2658.6 2681.7 2763.0 836.6 889.8 897.2 908.5 916.4 8577.5 8623.3 8633.0 8643.7 8660.2 3567.9 3583.9 3661.2 3738.9 3745.3 7466.9 7481.9 7487.0 7491.6 7506.7 4062.1 4062.9 4065.8 4067.4 4069.7 3255.6 3353.2 3607.6 3632.6 3688.0 3171.7 3173.8 3249.8 3284.6 3305.2 1055.7 1062.5 1075.9 1078.2 1079.7 782.2 792.6 801.4 809.9 819.2 4507.8 4540.4 4686.3 4793.1 4922.7 851.0 853.7 930.2 932.1 938.2 3524.2 3669.6 3684.2 3726.1 3742.6 7913.8 7975.8 8092.8 8100.1 8103.4 8025.4 8027.3 8030.4 8040.5 8040.7 6247.3 6428.2 6431.7 6434.6 6436.3 4651.8 4771.0 4772.8 4858.1 5119.3 7182.1 7307.3 7312.7 7333.2 7370.3 7008.3 7349.2 7351.3 7357.9 7366.8 5139.0 5480.5 5722.0 5756.3 5767.7 5846.9 6141.3 6380.1 6389.1 6502.7 5839.1 5860.6 5878.1 5894.9 5988.5 5652.4 5724.7 5809.4 5826.2 5910.1 5516.8 5524.4 5533.7 5544.3 5581.8 4047.9 4080.6 4096.6 4128.8 4140.1 4256.4 4300.7 4337.4 4409.3 4497.4 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | [#4] prototype.html Cycles:180 Average:4019.55 Median:4631.44 stddev:1178.98 (25.5%) stddev-sans-first:1148.06 08:03:19 INFO - PROCESS | 24250 | Values: 262.3 266.6 270.9 272.1 277.1 4718.3 4751.3 4753.3 4753.8 4774.6 4649.2 4666.9 4667.7 4671.3 4681.1 3481.8 3523.6 3589.6 3592.2 3679.6 3627.6 3631.7 3649.3 3651.8 3653.4 3623.9 3625.1 3642.8 3644.7 3653.9 3461.3 3545.3 3556.1 3594.4 3659.7 3112.0 3142.4 3196.5 3197.2 3220.9 4490.7 4501.2 4504.7 4514.1 4534.3 4026.5 4126.9 4132.9 4146.8 4151.4 4803.6 4812.4 4823.6 4829.4 4852.1 3478.7 3489.7 3493.6 3536.3 3546.4 5137.2 5156.8 5179.1 5184.6 5200.2 3311.3 3442.6 3469.1 3481.2 3650.5 3503.9 3509.7 3513.9 3519.7 3528.4 4079.6 4084.8 4086.9 4100.7 4116.5 4761.9 4978.2 4994.8 4997.4 4998.5 1168.9 1188.7 1193.0 1193.9 1199.9 783.7 806.6 818.4 821.2 825.3 4255.5 4269.5 4276.4 4281.8 4372.7 5003.7 5095.4 5096.7 5109.1 5133.3 4390.1 4413.3 4420.2 4425.3 4441.4 2508.6 2588.0 2607.9 2610.8 2611.6 4628.9 4634.3 4641.2 4648.6 4720.4 5048.5 5065.6 5066.5 5074.4 5080.5 4456.5 4628.6 4637.5 4683.4 4693.7 4859.0 4915.0 4920.5 4927.0 4950.2 4827.7 4829.7 4839.8 4840.3 4843.3 4477.0 4630.0 4663.0 4664.9 4685.2 3418.2 3424.9 3443.6 3457.9 3460.9 4960.7 4963.1 4967.6 4972.5 5012.6 4632.9 4796.9 4813.6 4819.2 4842.5 4729.9 4757.5 4786.9 4788.0 4816.0 4615.9 4656.1 4682.1 4682.1 4701.0 4651.3 4798.8 4805.6 4841.7 4860.8 4719.4 4733.2 4743.6 4745.7 4748.9 08:03:19 INFO - PROCESS | 24250 | 08:03:19 INFO - PROCESS | 24250 | [#5] yui.html Cycles:180 Average:13626.42 Median:25427.16 stddev:16998.80 (66.9%) stddev-sans-first:17018.55 08:03:19 INFO - PROCESS | 24250 | Values: 649.6 658.3 670.9 680.8 733.5 11519.1 12483.9 12495.1 12495.4 12510.5 11585.9 11640.7 11653.8 11666.5 11671.6 612.3 626.9 736.2 743.0 757.0 745.7 759.6 759.8 759.8 759.8 803.7 806.5 806.5 807.3 807.6 640.4 660.8 774.1 802.0 803.7 581.6 587.0 587.4 587.7 587.9 12557.9 12565.3 12602.5 12605.9 12615.6 12150.8 12353.5 12709.5 12750.9 12829.8 11157.3 11183.7 11194.2 11223.7 11423.8 3933.8 3948.6 3993.5 4005.7 4007.5 50363.0 52873.0 53081.5 53216.7 53230.7 9218.7 9312.1 9398.9 9539.1 9539.3 15713.8 16196.6 16254.8 16264.0 16942.5 6463.3 6524.5 6541.4 6851.5 6919.7 3650.6 3730.1 3747.1 3789.4 3807.1 2483.2 2541.5 2559.9 2565.5 2569.0 465.9 468.5 471.5 475.6 477.4 555.3 569.1 591.2 595.0 603.2 6966.6 7018.7 7235.8 7286.5 7525.6 438.0 463.2 491.3 569.3 572.6 3682.5 3689.8 3786.7 3860.2 3915.2 40491.6 51023.5 63281.0 68311.7 68666.3 38025.6 38584.4 40519.6 57709.4 59142.7 35097.6 55882.0 56253.4 56457.2 57252.0 7038.0 7289.4 7429.3 7507.8 7545.1 36554.0 38135.4 38460.2 38826.4 39073.6 46034.0 46034.6 47118.0 48830.0 48969.5 9209.1 9236.9 9508.1 9650.7 9653.6 10560.3 10794.7 10840.2 10878.5 10967.0 9708.1 10098.3 10476.7 10486.9 10503.5 10099.8 10271.7 10312.6 10482.1 10631.1 9880.8 10217.0 10261.0 10409.2 10437.9 8117.5 8337.8 8506.6 8620.3 8854.6 8098.5 8169.8 8400.6 8409.3 8625.4 08:03:19 INFO - PROCESS | 24250 | -------- Summary: end -------- 08:03:19 INFO - PROCESS | 24250 | 08:03:20 INFO - TEST-INFO | 24250: exit 0 08:03:20 INFO - TEST-OK | dromaeo_css | took 1122925ms 08:03:20 INFO - TEST-START | kraken 08:03:20 INFO - operating with platform_type : linux_ 08:03:20 INFO - Initialising browser for kraken test... 08:03:20 INFO - TEST-INFO | started process 24554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJxp6C/profile http://localhost:38625/getInfo.html) 08:03:24 INFO - PROCESS | 24554 | __metrics Screen width/height:1600/1200 08:03:24 INFO - PROCESS | 24554 | colorDepth:24 08:03:24 INFO - PROCESS | 24554 | Browser inner width/height: 1024/697 08:03:24 INFO - PROCESS | 24554 | __metrics 08:03:25 INFO - PROCESS | 24554 | 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" 08:03:25 INFO - PROCESS | 24554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:03:26 INFO - TEST-INFO | 24554: exit 0 08:03:26 INFO - Browser initialized. 08:03:26 INFO - Running cycle 1/1 for kraken test... 08:03:26 INFO - TEST-INFO | started process 24636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJxp6C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:38 INFO - PROCESS | 24636 | RSS: Main: 174301184 08:03:38 INFO - PROCESS | 24636 | 08:03:41 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38625/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:42 INFO - PROCESS | 24636 | RSS: Main: 239665152 08:03:42 INFO - PROCESS | 24636 | 08:03:45 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38625/tests/kraken/driver.html?testName=audio-dft) 08:03:46 INFO - PROCESS | 24636 | RSS: Main: 217858048 08:03:46 INFO - PROCESS | 24636 | 08:03:49 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38625/tests/kraken/driver.html?testName=audio-fft) 08:03:49 INFO - PROCESS | 24636 | RSS: Main: 300224512 08:03:49 INFO - PROCESS | 24636 | 08:03:51 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38625/tests/kraken/driver.html?testName=audio-oscillator) 08:03:52 INFO - PROCESS | 24636 | RSS: Main: 211542016 08:03:52 INFO - PROCESS | 24636 | 08:03:54 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:55 INFO - PROCESS | 24636 | RSS: Main: 213942272 08:03:55 INFO - PROCESS | 24636 | 08:03:58 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38625/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:59 INFO - PROCESS | 24636 | RSS: Main: 253759488 08:03:59 INFO - PROCESS | 24636 | 08:04:02 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38625/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:03 INFO - PROCESS | 24636 | RSS: Main: 247685120 08:04:03 INFO - PROCESS | 24636 | 08:04:06 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38625/tests/kraken/driver.html?testName=json-parse-financial) 08:04:06 INFO - PROCESS | 24636 | RSS: Main: 249401344 08:04:06 INFO - PROCESS | 24636 | 08:04:08 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:09 INFO - PROCESS | 24636 | RSS: Main: 212877312 08:04:09 INFO - PROCESS | 24636 | 08:04:11 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:11 INFO - PROCESS | 24636 | RSS: Main: 220463104 08:04:11 INFO - PROCESS | 24636 | 08:04:13 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:14 INFO - PROCESS | 24636 | RSS: Main: 229036032 08:04:14 INFO - PROCESS | 24636 | 08:04:17 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:18 INFO - PROCESS | 24636 | RSS: Main: 237260800 08:04:18 INFO - PROCESS | 24636 | 08:04:21 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:21 INFO - PROCESS | 24636 | RSS: Main: 233963520 08:04:21 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | Cycle 1(1): loaded http://localhost:38625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38625/tests/kraken/driver.html?testName=ai-astar) 08:04:23 INFO - PROCESS | 24636 | RSS: Main: 286044160 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | __start_tp_report 08:04:23 INFO - PROCESS | 24636 | _x_x_mozilla_page_load 08:04:23 INFO - PROCESS | 24636 | _x_x_mozilla_page_load_details 08:04:23 INFO - PROCESS | 24636 | |i|pagename|runs| 08:04:23 INFO - PROCESS | 24636 | |0;ai-astar;107;117;116;116;116;115;117;116;116;115 08:04:23 INFO - PROCESS | 24636 | |1;audio-beat-detection;158;131;130;174;130;134;129;128;149;131 08:04:23 INFO - PROCESS | 24636 | |2;audio-dft;161;162;162;161;161;161;161;160;159;161 08:04:23 INFO - PROCESS | 24636 | |3;audio-fft;77;76;76;123;77;77;77;76;91;76 08:04:23 INFO - PROCESS | 24636 | |4;audio-oscillator;85;85;118;83;83;83;109;83;82;112 08:04:23 INFO - PROCESS | 24636 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 08:04:23 INFO - PROCESS | 24636 | |6;imaging-darkroom;146;146;148;148;146;147;149;147;146;147 08:04:23 INFO - PROCESS | 24636 | |7;imaging-desaturate;95;95;95;95;96;96;95;97;95;95 08:04:23 INFO - PROCESS | 24636 | |8;json-parse-financial;67;64;64;64;65;70;66;67;66;67 08:04:23 INFO - PROCESS | 24636 | |9;json-stringify-tinderbox;68;66;66;66;67;66;68;67;67;67 08:04:23 INFO - PROCESS | 24636 | |10;stanford-crypto-aes;95;88;91;84;86;84;84;85;85;92 08:04:23 INFO - PROCESS | 24636 | |11;stanford-crypto-ccm;148;146;155;146;143;147;144;142;179;144 08:04:23 INFO - PROCESS | 24636 | |12;stanford-crypto-pbkdf2;185;190;186;183;181;184;180;184;185;180 08:04:23 INFO - PROCESS | 24636 | |13;stanford-crypto-sha256-iterative;75;69;70;71;71;69;69;69;69;75 08:04:23 INFO - PROCESS | 24636 | __end_tp_report 08:04:23 INFO - PROCESS | 24636 | __start_cc_report 08:04:23 INFO - PROCESS | 24636 | _x_x_mozilla_cycle_collect,1989 08:04:23 INFO - PROCESS | 24636 | __end_cc_report 08:04:23 INFO - PROCESS | 24636 | __startTimestamp1480089863960__endTimestamp 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | ------- Summary: start ------- 08:04:23 INFO - PROCESS | 24636 | Number of tests: 14 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:2.92 (2.5%) stddev-sans-first:0.71 08:04:23 INFO - PROCESS | 24636 | Values: 107.0 117.0 116.0 116.0 116.0 115.0 117.0 116.0 116.0 115.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:132.50 stddev:15.71 (11.9%) stddev-sans-first:15.15 08:04:23 INFO - PROCESS | 24636 | Values: 158.0 131.0 130.0 174.0 130.0 134.0 129.0 128.0 149.0 131.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 08:04:23 INFO - PROCESS | 24636 | Values: 161.0 162.0 162.0 161.0 161.0 161.0 161.0 160.0 159.0 161.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:14.92 (19.4%) stddev-sans-first:15.68 08:04:23 INFO - PROCESS | 24636 | Values: 77.0 76.0 76.0 123.0 77.0 77.0 77.0 76.0 91.0 76.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:14.48 (17.4%) stddev-sans-first:15.11 08:04:23 INFO - PROCESS | 24636 | Values: 85.0 85.0 118.0 83.0 83.0 83.0 109.0 83.0 82.0 112.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:04:23 INFO - PROCESS | 24636 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 08:04:23 INFO - PROCESS | 24636 | Values: 146.0 146.0 148.0 148.0 146.0 147.0 149.0 147.0 146.0 147.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:04:23 INFO - PROCESS | 24636 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 97.0 95.0 95.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.50 stddev:1.89 (2.8%) stddev-sans-first:1.96 08:04:23 INFO - PROCESS | 24636 | Values: 67.0 64.0 64.0 64.0 65.0 70.0 66.0 67.0 66.0 67.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 08:04:23 INFO - PROCESS | 24636 | Values: 68.0 66.0 66.0 66.0 67.0 66.0 68.0 67.0 67.0 67.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:3.95 (4.5%) stddev-sans-first:3.09 08:04:23 INFO - PROCESS | 24636 | Values: 95.0 88.0 91.0 84.0 86.0 84.0 84.0 85.0 85.0 92.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:146.50 stddev:11.02 (7.5%) stddev-sans-first:11.67 08:04:23 INFO - PROCESS | 24636 | Values: 148.0 146.0 155.0 146.0 143.0 147.0 144.0 142.0 179.0 144.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:184.50 stddev:3.05 (1.7%) stddev-sans-first:3.20 08:04:23 INFO - PROCESS | 24636 | Values: 185.0 190.0 186.0 183.0 181.0 184.0 180.0 184.0 185.0 180.0 08:04:23 INFO - PROCESS | 24636 | 08:04:23 INFO - PROCESS | 24636 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:2.41 (3.4%) stddev-sans-first:1.99 08:04:23 INFO - PROCESS | 24636 | Values: 75.0 69.0 70.0 71.0 71.0 69.0 69.0 69.0 69.0 75.0 08:04:23 INFO - PROCESS | 24636 | -------- Summary: end -------- 08:04:23 INFO - PROCESS | 24636 | 08:04:25 INFO - TEST-INFO | 24636: exit 0 08:04:25 INFO - TEST-OK | kraken | took 64964ms 08:04:25 INFO - SUITE-END | took 1187s 08:04:25 INFO - Completed test suite (00:19:48) 08:04:25 INFO - javascript benchmark 08:04:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2547.477767057753, 2592.325995241237, 2608.4391855751014, 2622.4755048990196, 2637.617545455909, 4583.427071616048, 4647.558481944214, 4648.65135114866, 4686.531346865316, 4686.695364801286, 4667.416572928384, 4667.996380778132, 4679.087577922306, 4679.344891715163, 4690.624750019999, 4252.702310838243, 4281.67887408444, 4288.69979101463, 4315.978420107895, 4350.608445239928, 4238.533761286256, 4239.3852891330735, 4255.255330317182, 4256.787160641956, 4262.019735460846, 4207.516135644394, 4233.851815186469, 4264.701470897038, 4290.785460726966, 4298.161858437606, 4347.087111706545, 4347.174036933005, 4352.7605981670995, 4355.128974205171, 4362.8036738346855, 4170.645495132917, 4208.347706105558, 4222.408862759216, 4263.104748002923, 4265.253580623378, 4639.025804581042, 4659.114768194032, 4661.044485880387, 4667.649926255544, 4729.0541891621815, 4941.975290123526, 4979.825706100305, 4990.725510096943, 4992.82525111623, 5022.0, 4839.927401088987, 4872.488388719169, 4873.220284754458, 5003.574696150831, 5057.772400241961, 4647.070585882837, 4666.136764698542, 4682.648801339913, 4710.882227944328, 4755.738434386142, 5139.974300128475, 5149.819756308511, 5154.9484505155215, 5156.613254005964, 5201.011807756589, 4742.976285118552, 4914.140025495524, 4930.901381972412, 4932.408111026628, 4975.004999000214, 4857.101436234238, 4914.140025495524, 4939.950600493949, 4967.850964471072, 4969.652124351261, 4933.531314525115, 4934.876628084255, 4935.851924442272, 4972.403311602631, 4978.502149785065, 4914.950850491521, 4928.507149285043, 4929.950700493021, 4930.0, 4965.702057876539, 4036.1524079942956, 4038.0510580013674, 4081.91836163281, 4119.7940102994735, 4132.462779838602, 3597.9460308094876, 3608.9278214435562, 3633.691136253448, 3644.8177591120866, 3662.9816850915577, 4303.419038429772, 4304.0, 4312.978435107804, 4321.222180007566, 4339.500957389878, 4959.82640607577, 4965.875853103701, 4966.925496117561, 4967.925481117786, 5036.32009678696, 4220.198162349144, 4267.8292868284925, 4287.485501739811, 4294.892627684333, 4328.220920234388, 4391.077873646506, 4415.51429342772, 4423.225935461282, 4432.069265454291, 4437.2234858899565, 4704.0356726870905, 4709.670323077352, 4709.81160753566, 4712.057588482248, 4714.7406892619865, 4925.704457732548, 4959.380077490314, 4968.080905032436, 4971.900561988812, 4977.129002424634, 4706.599939005086, 4707.246840505502, 4708.92936605958, 4710.340552322609, 4710.858674239778, 4862.6839255449695, 4873.074115917964, 4876.341693871424, 4876.829310974099, 4878.121938051043, 4927.778249978688, 4932.062908047459, 4934.18585933317, 4953.455119936732, 4954.603631709527, 4808.158572249912, 4882.389701287339, 4885.487023862585, 4885.853424397274, 4930.285108659296, 4862.4651288357545, 4870.147724148331, 4876.341693871282, 4878.390201224847, 4922.630802689741, 4600.677952543289, 4645.465771436328, 4718.575328220477, 4758.547937945889, 4758.666893317434, 4866.124097662455, 4868.440129385166, 4876.4392094909535, 4921.557059864629, 4940.110780059624, 4752.833650822205, 4766.451858036232, 4769.14155452022, 4773.9761301193275, 4821.54195351441], "value": 4559.299686946275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.0842713174038, 548.9917651235231, 549.1488193300384, 560.2548610348236, 574.2420005592619, 27511.0, 37643.435348469764, 39004.60995390045, 39020.0, 42428.0, 38392.80803595985, 38845.22309553807, 38883.805580972126, 38892.02769930753, 38896.611033889654, 7376.594287314196, 7470.813229669247, 7495.625218739068, 7531.585762783045, 7531.661075251627, 7434.219406962272, 7631.847363052736, 9459.432434053944, 9679.95160024199, 9684.806303873918, 9595.616175352978, 9645.131938125567, 9649.614015439409, 9660.082292182267, 9662.855057174113, 9673.661421850236, 9721.902780972241, 9727.367721098106, 9733.22134229267, 9741.756456088619, 9619.759506012335, 9633.807323853554, 9697.612095516242, 9700.417974921527, 9713.66002189927, 34857.30285394303, 35108.473372899425, 35151.1212219694, 35152.82423587866, 35190.82404587986, 3132.592762940826, 3270.7546933979806, 3395.2021275000357, 3576.9821150894077, 3636.054625797285, 28605.42789144226, 28799.856000720072, 29281.41437171266, 30717.846410768027, 31943.840280798446, 3009.458297506448, 3047.3905218956074, 3077.2306923269184, 3092.335147943203, 3134.5925029746213, 220506.0, 221020.0, 221478.0, 222055.0, 222985.0, 50583.0, 50885.23672144921, 50906.0, 51048.234276485884, 51049.744751276005, 52672.473275267526, 52718.0, 52750.73624631852, 52795.47204527982, 52798.73600631972, 13410.664733381744, 13872.930635346758, 13890.652733681738, 13897.513587024405, 13901.096428732302, 9765.755856103513, 10073.899261007442, 10825.350478971286, 10963.122950164126, 10968.725781855517, 16451.0, 16996.490105296612, 16996.745048824276, 17724.734128988075, 17755.46733597994, 6584.341565843473, 6714.764983225564, 6717.865642687118, 6732.7643532477105, 6822.897656535156, 767.3247542162861, 844.8310337932438, 872.0059132588854, 914.8216097860986, 932.9300302477342, 25278.873605632223, 27070.86464567704, 27177.72822271752, 27394.45211095767, 27533.86233068862, 907.6687009241712, 943.0757857299884, 986.4722373530127, 1005.8541511480794, 1021.0300214795825, 14177.362018709182, 14463.27683615815, 14525.854741452662, 14691.632709182357, 14871.18208498543, 109491.45254273836, 109583.45208273908, 109594.45202773935, 109867.45066274618, 314733.0, 47026.5297347029, 47575.28637070447, 47648.28527572089, 47652.0, 47661.52338476571, 1039.7816458543791, 1089.493385575711, 1123.2754873106965, 1153.9307641541534, 1193.3734789235373, 25979.350516237246, 27317.45365092727, 28023.439531209668, 28218.46033856963, 28506.42987140287, 39071.41392879166, 39538.80230598828, 39558.604413955494, 39598.60401396064, 39653.405198921464, 235293.0, 236356.0, 237080.0, 237157.0, 237162.0, 23772.64341034851, 24607.261782146565, 24629.13798017061, 25737.227883162785, 25951.61072583875, 38830.4175437363, 39254.0, 39306.803465982484, 40132.79933600313, 40521.392179117924, 33510.0, 33522.49716254307, 33697.0, 33890.830545847115, 34450.310993780484, 32689.0, 33042.66957330396, 33389.83305083459, 34295.31409371849, 34605.30789384249, 32811.50782738309, 33282.16794580155, 33390.83304583462, 33862.492062619574, 34016.82991585125, 29778.702212977594, 30634.693653063183, 30680.693193067782, 30688.232794180323, 30898.0, 23329.18347857817, 23966.88016559976, 23982.52034959256, 24163.395915102265, 24305.14931977372], "value": 16669.448821889433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.7901863788539, 325.1302765103348, 332.4746899898161, 334.0657592539198, 335.46325878594246, 12223.205491643037, 15172.468963586263, 15321.70174473828, 16677.91661041696, 16957.3217071317, 14423.63940901478, 14939.850601493981, 15020.573045560654, 16237.26932288047, 16607.91696041518, 4473.776311184444, 4533.863984080483, 4595.379623750801, 4675.018246168309, 4683.437987441512, 3476.2004738910064, 4552.203364411214, 4630.907381852361, 4635.304704294366, 4636.235021221494, 3637.199816040467, 5133.666311689747, 5373.113436283028, 5414.160805075219, 5493.587980901429, 5196.142636464979, 5423.403425623178, 5428.75570599322, 5439.972800135974, 5461.317335333083, 5257.922125964168, 5369.436209198017, 5374.167004114369, 5374.48942350476, 5374.973125134388, 12233.755324893542, 12359.75280494394, 12375.876241237562, 12435.316057616827, 12466.314352710597, 1780.1811166863258, 1823.7629108215979, 1828.4423250908467, 1911.1877452082808, 1949.6198241342943, 8734.563271836383, 8796.076411976714, 9009.0, 9080.31897607682, 9605.18355939746, 1664.4840099569171, 1707.5560354307845, 1737.1589942973042, 1748.8163742806948, 1764.9558761030949, 55701.0, 61631.76130028908, 63303.0, 64413.355866441205, 65321.346786532, 9654.469004204837, 9660.613575456902, 9832.901670983341, 9864.408135511892, 9999.650012249536, 13349.66625834362, 13401.396937137852, 13408.262545559894, 13413.731725365438, 13457.798133028013, 7085.92914070863, 7309.9429816452375, 7316.670749816271, 7395.556266624019, 7404.222556631584, 6482.643454609947, 6671.232808227019, 6789.6605169741315, 7157.821054473576, 7160.677769500281, 4212.873613791591, 4264.974137284827, 4315.201687687788, 4414.911701765946, 4435.401220835211, 1765.1262625000707, 1877.3616970230187, 1882.7740671119554, 1895.336632178754, 1924.9615007699767, 756.528551966431, 765.5330248548381, 795.6021989005498, 807.6930766308765, 811.4157806379397, 15744.527664170093, 15963.0, 15967.201639917957, 16334.264958076916, 16904.830951690572, 892.4511425473287, 896.8027034052498, 901.6348378906554, 908.3550679017972, 909.508865212791, 8847.778805529913, 8941.687040953535, 9192.0, 9222.53887305632, 9254.4910029949, 313925.0, 319377.0, 319797.0, 325876.0, 326860.0, 69571.65214173897, 70841.93737093947, 71700.0, 73534.26465735381, 74090.0, 841.6507149532998, 864.8745931839974, 872.0233338660614, 873.0178549132099, 873.8033942363045, 14152.646183845074, 14419.78370324467, 14855.851441485447, 14862.580230105299, 14886.255687215813, 32428.0, 33186.0, 33470.0, 33813.15467113243, 34324.656753432144, 45011.0, 46879.76560117178, 46940.53059469361, 48675.0, 52947.0, 7467.663955121924, 7567.167611562833, 7703.53778773253, 7713.498622589514, 7750.496217745828, 8960.731178064669, 11240.269382490113, 11250.718732031764, 11702.719898202491, 11932.70168245766, 9824.901750982684, 9990.400575965465, 10137.341072830242, 10215.233857460571, 10522.31604945676, 9978.550965206437, 10002.899971000488, 10106.242031847494, 10273.229507786797, 10364.481775911023, 9774.413535187912, 10038.247131465316, 10055.29612927088, 10452.68641940743, 10914.96307850753, 7522.247775222434, 7545.7358992435, 7547.99978005818, 7628.351590114902, 7965.601719914097, 7961.6019199040975, 9249.0, 9913.107820296207, 10140.492975351055, 10423.166146708094], "value": 7709.94040613959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.4491733802452, 1303.8826505614495, 1330.773768459362, 1352.1954437109923, 1591.8986937242844, 5713.542916566675, 6183.258009038916, 6415.069814876846, 6433.774817881364, 6573.605583664984, 6359.68201589921, 6403.263624683163, 6405.26339470961, 6415.839604009902, 6418.775342863, 1731.3420900058022, 1785.8571314294825, 1969.0450131686157, 2003.5592169722638, 2004.368623883472, 1957.9510512237166, 2006.6388050150968, 2006.9096890639883, 2019.8081182287658, 2030.0661695620033, 1974.3682021753045, 1978.5251539630458, 1980.3167907072036, 1983.7917018713044, 1986.275009621485, 1988.2941555747645, 2004.4287378097317, 2009.859309848311, 2011.8692285001428, 2013.1444136242185, 1954.355062829263, 1969.359958013637, 1994.311962372979, 1996.5607566335384, 2004.3185316992292, 6718.3953444189765, 6777.085093512412, 6793.898091528631, 6795.014722865157, 6800.727970881158, 4011.13760541485, 4112.712110152291, 4132.070284186064, 4134.937975930364, 4138.110306284133, 2527.4692314613953, 2652.8938842446278, 2658.6410834537282, 2681.6647919010124, 2762.986185069082, 836.6318819719365, 889.817587394589, 897.228383590112, 908.4821651658557, 916.4363916191561, 8577.52823594702, 8623.31013518917, 8632.956835215846, 8643.65425382984, 8660.177283158153, 3567.8761190224996, 3583.928321433557, 3661.2494438640015, 3738.925221495555, 3745.2883952049024, 7466.85066298671, 7481.9251807482315, 7486.962565187139, 7491.550506969599, 7506.662200201004, 4062.1266427718183, 4062.878113656595, 4065.8170382332864, 4067.3695577185586, 4069.715119941635, 3255.6256030556788, 3353.178471274505, 3607.585127710347, 3632.582253040934, 3687.981560092236, 3171.698688624577, 3173.809571425722, 3249.8050116993054, 3284.6186514776596, 3305.2067503798917, 1055.6832950114936, 1062.4793851012948, 1075.8924107589178, 1078.1751959750798, 1079.6599071292517, 782.2021538031177, 792.6076592086839, 801.3909428834128, 809.874469457235, 819.1603606303587, 4507.842225522157, 4540.387047748578, 4686.250199967989, 4793.1372352976105, 4922.704637721748, 850.9829803404022, 853.6926706385697, 930.2093220762298, 932.1424289653535, 938.2306508662967, 3524.22467057247, 3669.5779985301497, 3684.1710615111388, 3726.142987112925, 3742.550893892696, 7913.802154946057, 7975.84048319042, 8092.757217283491, 8100.068492123363, 8103.432759706764, 8025.357971362277, 8027.317677997436, 8030.397720170894, 8040.477368970998, 8040.678372865137, 6247.281562620356, 6428.19647544057, 6431.710573024225, 6434.581752186093, 6436.324185960407, 4651.837185698484, 4770.976145119253, 4772.771533149274, 4858.125537403302, 5119.28330033803, 7182.138143422822, 7307.3058059484265, 7312.670929808065, 7333.230010848784, 7370.336669699753, 7008.264132266038, 7349.191588925107, 7351.26487351282, 7357.889631655637, 7366.789963010968, 5138.997895410359, 5480.534154596904, 5722.0272553665145, 5756.3380211276235, 5767.653940763567, 5846.912296315644, 6141.293751218488, 6380.138681277968, 6389.073584330153, 6502.739890404331, 5839.0949402842625, 5860.648361098348, 5878.088896221093, 5894.882102357843, 5988.520918326611, 5652.434756524314, 5724.74238659253, 5809.390014048633, 5826.242588463642, 5910.054391297372, 5516.806911758069, 5524.4199359066715, 5533.667979921218, 5544.251526044094, 5581.804636837691, 4047.9392809108476, 4080.6123418275215, 4096.5903409658795, 4128.793560322032, 4140.068484590943, 4256.404103425461, 4300.698951073395, 4337.436133302651, 4409.272470042407, 4497.392851964943], "value": 3660.9679234598984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.26957922186716, 266.62672258837637, 270.8970591175354, 272.1020631914681, 277.1187623357722, 4718.292256161578, 4751.2873069039615, 4753.33453316536, 4753.786079626417, 4774.618030557555, 4649.209634362158, 4666.929996050054, 4667.6732628716, 4671.322658214557, 4681.133990211813, 3481.7736847104984, 3523.5947865995354, 3589.5513060867393, 3592.1738000259957, 3679.632036796326, 3627.6372362763777, 3631.7276204284653, 3649.3066317399744, 3651.7991510466913, 3653.433717773736, 3623.8912832615065, 3625.111847597342, 3642.8178591070473, 3644.7084233261407, 3653.908652283701, 3461.2904354607244, 3545.3263879862743, 3556.146524834047, 3594.388953877847, 3659.652333028358, 3111.9533207001914, 3142.3872344892757, 3196.488561830096, 3197.216681912923, 3220.855061522237, 4490.685652004361, 4501.189785838547, 4504.747626186907, 4514.097180563867, 4534.274516077412, 4026.4564283821896, 4126.855560055384, 4132.855350062763, 4146.751194928283, 4151.4395556599775, 4803.591694705954, 4812.350332705075, 4823.564100129447, 4829.3721816164025, 4852.078105160008, 3478.739094567892, 3489.70337521311, 3493.598236202844, 3536.257385948954, 3546.3616549021167, 5137.229415587654, 5156.845294641129, 5179.119549676564, 5184.5593124584075, 5200.245964335188, 3311.2880730642546, 3442.569678790151, 3469.098034511045, 3481.1993241554583, 3650.5397840863866, 3503.8948831534585, 3509.701675357623, 3513.894583162509, 3519.665631764978, 3528.400171970771, 4079.632833044981, 4084.7949854792905, 4086.8773936781945, 4100.733452325649, 4116.521539299288, 4761.928571071437, 4978.2034874419915, 4994.750262486861, 4997.350344455198, 4998.500149985045, 1168.9357085360216, 1188.7028242939266, 1192.9880701192876, 1193.8925496705165, 1199.9380548214717, 783.7452827830978, 806.5967016491754, 818.4475479051616, 821.1542111624916, 825.3067423364403, 4255.510616279105, 4269.466316710411, 4276.444062271885, 4281.7582900959, 4372.726182385142, 5003.722561722077, 5095.401345313842, 5096.694198348111, 5109.080365534165, 5133.25567792668, 4390.143921935192, 4413.293872980308, 4420.226460369422, 4425.336199570026, 4441.400410944481, 2508.5735424977797, 2587.974120258811, 2607.9478410432066, 2610.838177011212, 2611.595202743578, 4628.884277893012, 4634.328022436795, 4641.234196357631, 4648.605967926521, 4720.362751028636, 5048.545630893237, 5065.645404821627, 5066.48005598319, 5074.441811400743, 5080.491950804964, 4456.509783923766, 4628.5602867728185, 4637.513061128533, 4683.414573178353, 4693.6949098308505, 4859.028194361213, 4914.967856750122, 4920.507949205051, 4927.0, 4950.183219768698, 4827.662063655511, 4829.73436460998, 4839.782209800497, 4840.273958906192, 4843.297721830244, 4476.955230447784, 4629.971924425637, 4662.976685116552, 4664.930026049544, 4685.156671799109, 3418.2479854431986, 3424.8630054798527, 3443.603985541695, 3457.8789742358895, 3460.948085778665, 4960.727160006234, 4963.081829861487, 4967.572375061196, 4972.453030166606, 5012.649114561946, 4632.907341853212, 4796.904061918673, 4813.614910807197, 4819.1566475867285, 4842.539958703917, 4729.864832440258, 4757.524247575215, 4786.928196076992, 4787.952120478751, 4816.036792641416, 4615.884602884955, 4656.115338085753, 4682.083811997321, 4682.1103990241745, 4701.0, 4651.325034633307, 4798.760061996956, 4805.630395337452, 4841.709497430165, 4860.829870954641, 4719.433667959866, 4733.195356789423, 4743.620510359232, 4745.6678032538775, 4748.928766068442], "value": 3637.1644446227956, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.5972497051827, 658.259458109627, 670.8624731929955, 680.7821497120921, 733.5158795195172, 11519.136064795131, 12483.875161248396, 12495.062870284719, 12495.43770530326, 12510.4995800168, 11585.884141158585, 11640.650780476599, 11653.766924661502, 11666.533338666442, 11671.591494297702, 612.3294991983771, 626.8934281172212, 736.2416710787898, 743.0192146366811, 756.9621518924059, 745.6756311004731, 759.5670467833337, 759.7644730133649, 759.8328367759084, 759.8480303939207, 803.6905791270344, 806.4677312973439, 806.4757907360233, 807.3178164451059, 807.6204184033525, 640.4492136762381, 660.7753363856264, 774.1213722425032, 801.967921283148, 803.7146812881431, 581.5609215042658, 587.0138167877964, 587.4272584230384, 587.7325816753367, 587.9059350503942, 12557.937210313981, 12565.308908010056, 12602.495900163982, 12605.873941260561, 12615.558455454107, 12150.817737733942, 12353.505859765599, 12709.491620335175, 12750.936245318713, 12829.807552886621, 11157.27477713946, 11183.720406989809, 11194.216404851664, 11223.719407014809, 11423.828642570368, 3933.8229779659982, 3948.5853985331414, 3993.5407428145845, 4005.679545636342, 4007.5190977082643, 50363.0, 52873.0, 53081.46918530804, 53216.73391633056, 53230.733846330906, 9218.677346292847, 9312.068793120769, 9398.90601093994, 9539.14147726708, 9539.284553658365, 15713.764293535605, 16196.595085122966, 16254.837451625332, 16264.0, 16942.491725248263, 6463.256725476536, 6524.543281970311, 6541.443977261986, 6851.45188384928, 6919.688614012382, 3650.5619325681087, 3730.1047748540154, 3747.138158223624, 3789.3558095123894, 3807.0862992881507, 2483.2426110036613, 2541.466292078684, 2559.8976040958523, 2565.538203123456, 2569.0494517028446, 465.89051572880345, 468.52912822613735, 471.4907899468566, 475.6171282117928, 477.38417441500076, 555.3252797850631, 569.0780934885512, 591.2077815726947, 594.9762009519658, 603.2308806272039, 6966.582005079711, 7018.719251229996, 7235.782926512213, 7286.526375785557, 7525.58609276495, 438.04069088695655, 463.2287241742528, 491.3170692737098, 569.3225062175998, 572.5836967995054, 3682.5212722345923, 3689.760165589228, 3786.6970642348547, 3860.2472517858746, 3915.197384536163, 40491.595084049375, 51023.48976510262, 63281.0, 68311.65844170748, 68666.313336867, 38025.61974380276, 38584.42123368096, 40519.59480405217, 57709.422905771244, 59142.70428647829, 35097.64902350995, 55882.0, 56253.43746562482, 56457.15314270289, 57252.0, 7037.964810175917, 7289.380402665833, 7429.33136017761, 7507.774766757006, 7545.132309784445, 36554.0, 38135.42796858105, 38460.23079538337, 38826.41760373653, 39073.60926390813, 46034.0, 46034.61896143121, 47118.0, 48830.0, 48969.51030489792, 9209.125133112344, 9236.861447078434, 9508.11018092913, 9650.71047868565, 9653.565589548627, 10560.313579617301, 10794.73013174677, 10840.186985975926, 10878.456077196266, 10967.0, 9708.126268635857, 10098.293119481566, 10476.742790865144, 10486.89887561795, 10503.47482625881, 10099.798004040025, 10271.7432064196, 10312.587496500057, 10482.056614904695, 10631.096356809758, 9880.802383952425, 10217.0, 10261.0, 10409.219308551737, 10437.895621043692, 8117.472364296302, 8337.791555210926, 8506.574671266288, 8620.310375170096, 8854.645814167361, 8098.473599216032, 8169.79575510617, 8400.579971001303, 8409.327253819802, 8625.39622226438], "value": 5831.0897147995265, "unit": "score"}], "name": "dromaeo_css", "value": 5975.012722559554, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 116.0, 116.0, 116.0, 115.0, 117.0, 116.0, 116.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 130.0, 174.0, 130.0, 134.0, 129.0, 128.0, 149.0, 131.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 159.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 123.0, 77.0, 77.0, 77.0, 76.0, 91.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 118.0, 83.0, 83.0, 83.0, 109.0, 83.0, 82.0, 112.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 148.0, 146.0, 147.0, 149.0, 147.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 64.0, 65.0, 70.0, 66.0, 67.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 91.0, 84.0, 86.0, 84.0, 84.0, 85.0, 85.0, 92.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 155.0, 146.0, 143.0, 147.0, 144.0, 142.0, 179.0, 144.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 190.0, 186.0, 183.0, 181.0, 184.0, 180.0, 184.0, 185.0, 180.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 70.0, 71.0, 71.0, 69.0, 69.0, 69.0, 69.0, 75.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1573.7, "alertThreshold": 2.0}]} 08:04:25 INFO - Return code: 0 08:04:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:04:25 INFO - # TBPL SUCCESS # 08:04:25 INFO - Running post-action listener: _resource_record_post_action 08:04:25 INFO - [mozharness: 2016-11-25 16:04:25.766314Z] Finished run-tests step (success) 08:04:25 INFO - Running post-run listener: _resource_record_post_run 08:04:25 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408453120; Read time: 12; Write time: 234468 08:04:25 INFO - TinderboxPrint: CPU usage
13.1% 08:04:25 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 12 08:04:25 INFO - TinderboxPrint: I/O write bytes / time
408,453,120 / 234,468 08:04:25 INFO - TinderboxPrint: CPU idle
8,354.6 (86.9%) 08:04:25 INFO - TinderboxPrint: CPU user
1,211.9 (12.6%) 08:04:25 INFO - TinderboxPrint: Swap in / out
0 / 0 08:04:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115732480; Read time: 0; Write time: 54636 08:04:25 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291815424; Read time: 12; Write time: 179812 08:04:26 INFO - Running post-run listener: _upload_blobber_files 08:04:26 INFO - Blob upload gear active. 08:04:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:04:26 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 08:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:04:26 INFO - (blobuploader) - INFO - Open directory for files ... 08:04:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:04:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:04:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:30 INFO - (blobuploader) - INFO - Done attempting. 08:04:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:04:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:31 INFO - (blobuploader) - INFO - Done attempting. 08:04:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:04:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:31 INFO - (blobuploader) - INFO - Done attempting. 08:04:31 INFO - (blobuploader) - INFO - Iteration through files over. 08:04:31 INFO - Return code: 0 08:04:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:04:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:04:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b69f0dcc332b257c8ea709e959ef4757dc11e5dd633059d8800739358a47a77216f11ff5f4f22a46625a3207c3412d42ba5830826070fe64a499c4ed8150998", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fcf9e1f185d3cd6b595b44ea826a5580a3f059b529dcc495fe7deafde104a472938f558deabd0244fb72a11377eb064e229a0ccfcdded81349fafcb5942094c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02196e0ee9fc7d1cffea45c782b80ae7ea0967cc15eea88d50850a885becd3d94d08006855275cef6aa6d03a67b603417f683d1f1f93e2630de3db5a10ca38dc"} 08:04:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:04:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:04:31 INFO - Contents: 08:04:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b69f0dcc332b257c8ea709e959ef4757dc11e5dd633059d8800739358a47a77216f11ff5f4f22a46625a3207c3412d42ba5830826070fe64a499c4ed8150998", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fcf9e1f185d3cd6b595b44ea826a5580a3f059b529dcc495fe7deafde104a472938f558deabd0244fb72a11377eb064e229a0ccfcdded81349fafcb5942094c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02196e0ee9fc7d1cffea45c782b80ae7ea0967cc15eea88d50850a885becd3d94d08006855275cef6aa6d03a67b603417f683d1f1f93e2630de3db5a10ca38dc"} 08:04:31 INFO - Running post-run listener: copy_logs_to_upload_dir 08:04:31 INFO - Copying logs to upload dir... 08:04:31 INFO - mkdir: /builds/slave/test/build/upload/logs 08:04:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.028517 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-25 08:04:31.542227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 08:04:31.546011) ========= 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=32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b69f0dcc332b257c8ea709e959ef4757dc11e5dd633059d8800739358a47a77216f11ff5f4f22a46625a3207c3412d42ba5830826070fe64a499c4ed8150998", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fcf9e1f185d3cd6b595b44ea826a5580a3f059b529dcc495fe7deafde104a472938f558deabd0244fb72a11377eb064e229a0ccfcdded81349fafcb5942094c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02196e0ee9fc7d1cffea45c782b80ae7ea0967cc15eea88d50850a885becd3d94d08006855275cef6aa6d03a67b603417f683d1f1f93e2630de3db5a10ca38dc"} build_url:https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/SMdBg8tMQUmqh3GsnKlmpg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b69f0dcc332b257c8ea709e959ef4757dc11e5dd633059d8800739358a47a77216f11ff5f4f22a46625a3207c3412d42ba5830826070fe64a499c4ed8150998", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fcf9e1f185d3cd6b595b44ea826a5580a3f059b529dcc495fe7deafde104a472938f558deabd0244fb72a11377eb064e229a0ccfcdded81349fafcb5942094c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02196e0ee9fc7d1cffea45c782b80ae7ea0967cc15eea88d50850a885becd3d94d08006855275cef6aa6d03a67b603417f683d1f1f93e2630de3db5a10ca38dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 08:04:31.571411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:04:31.571820) ========= 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=32c5991c409366f7fec8a718000001d2-1480084132.730175-342691854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:04:31.655585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 08:04:31.655919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 08:04:31.656251) ========= ========= Total master_lag: 0.18 =========