builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1484554073.68 results: success (0) buildid: 20170115223822 builduid: 579b0a5e9a0246ff9db6206e29a9f49a revision: 29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.675643) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.676050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.676339) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.740307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.740572) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-16 00:07:54-- 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% 226M=0s 2017-01-16 00:07:54 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.918182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.918542) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017003 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:53.971797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 00:07:53.972104) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-16 00:07:54,715 truncating revision to first 12 chars 2017-01-16 00:07:54,715 Setting DEBUG logging. 2017-01-16 00:07:54,715 attempt 1/10 2017-01-16 00:07:54,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/29164ffa1889?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 00:07:56,030 unpacking tar archive at: mozilla-aurora-29164ffa1889/testing/mozharness/ program finished with exit code 0 elapsedTime=1.598150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 00:07:55.583793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:55.584098) ========= script_repo_revision: 29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:55.584505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:55.584771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 00:07:55.593853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-01-16 00:07:55.594126) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:07:56 INFO - MultiFileLogger online at 20170116 00:07:56 in /builds/slave/test 00:07:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:07:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:07:56 INFO - {'append_to_log': False, 00:07:56 INFO - 'base_work_dir': '/builds/slave/test', 00:07:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:07:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:07:56 INFO - 'branch': 'Mozilla-Aurora', 00:07:56 INFO - 'buildbot_json_path': 'buildprops.json', 00:07:56 INFO - 'config_files': ('talos/linux_config.py',), 00:07:56 INFO - 'default_actions': ('clobber', 00:07:56 INFO - 'read-buildbot-config', 00:07:56 INFO - 'download-and-extract', 00:07:56 INFO - 'populate-webroot', 00:07:56 INFO - 'create-virtualenv', 00:07:56 INFO - 'install', 00:07:56 INFO - 'run-tests'), 00:07:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:07:56 INFO - 'download_minidump_stackwalk': True, 00:07:56 INFO - 'download_symbols': 'ondemand', 00:07:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:07:56 INFO - 'tooltool.py': '/tools/tooltool.py', 00:07:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:07:56 INFO - '/tools/misc-python/virtualenv.py')}, 00:07:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:07:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:07:56 INFO - 'installer_path': 'installer.exe', 00:07:56 INFO - 'log_level': 'info', 00:07:56 INFO - 'log_name': 'talos', 00:07:56 INFO - 'log_to_console': True, 00:07:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:07:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:07:56 INFO - 'opt_config_files': (), 00:07:56 INFO - 'pip_index': False, 00:07:56 INFO - 'sps_profile': False, 00:07:56 INFO - 'sps_profile_interval': 0, 00:07:56 INFO - 'suite': 'dromaeojs', 00:07:56 INFO - 'system_bits': '32', 00:07:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:07:56 INFO - 'title': 'talos-linux64-ix-038', 00:07:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:07:56 INFO - 'use_talos_json': True, 00:07:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:07:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:07:56 INFO - 'work_dir': 'build'} 00:07:56 INFO - [mozharness: 2017-01-16 08:07:56.440809Z] Running clobber step. 00:07:56 INFO - Running pre-action listener: _resource_record_pre_action 00:07:56 INFO - Running main action method: clobber 00:07:56 INFO - rmtree: /builds/slave/test/build 00:07:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:07:56 INFO - Running post-action listener: _resource_record_post_action 00:07:56 INFO - [mozharness: 2017-01-16 08:07:56.900535Z] Finished clobber step (success) 00:07:56 INFO - [mozharness: 2017-01-16 08:07:56.900636Z] Running read-buildbot-config step. 00:07:56 INFO - Running pre-action listener: _resource_record_pre_action 00:07:56 INFO - Running main action method: read_buildbot_config 00:07:56 INFO - Using buildbot properties: 00:07:56 INFO - { 00:07:56 INFO - "project": "", 00:07:56 INFO - "product": "firefox", 00:07:56 INFO - "script_repo_revision": "production", 00:07:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 00:07:56 INFO - "repository": "", 00:07:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 00:07:56 INFO - "buildid": "20170115223822", 00:07:56 INFO - "pgo_build": "True", 00:07:56 INFO - "basedir": "/builds/slave/test", 00:07:56 INFO - "buildnumber": 710, 00:07:56 INFO - "slavename": "talos-linux64-ix-038", 00:07:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:07:56 INFO - "platform": "ubuntu64_hw", 00:07:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:07:56 INFO - "branch": "mozilla-aurora", 00:07:56 INFO - "repo_path": "releases/mozilla-aurora", 00:07:56 INFO - "revision": "29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7", 00:07:56 INFO - "stage_platform": "linux64-pgo", 00:07:56 INFO - "builduid": "579b0a5e9a0246ff9db6206e29a9f49a", 00:07:56 INFO - "slavebuilddir": "test" 00:07:56 INFO - } 00:07:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 00:07:56 INFO - Running post-action listener: _resource_record_post_action 00:07:56 INFO - [mozharness: 2017-01-16 08:07:56.903685Z] Finished read-buildbot-config step (success) 00:07:56 INFO - [mozharness: 2017-01-16 08:07:56.903773Z] Running download-and-extract step. 00:07:56 INFO - Running pre-action listener: _resource_record_pre_action 00:07:56 INFO - Running main action method: download_and_extract 00:07:56 INFO - mkdir: /builds/slave/test/build/tests 00:07: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')]} 00:07:56 INFO - trying https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:07:56 INFO - Downloading https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:07:57 INFO - Downloaded 1361 bytes. 00:07:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:07:57 INFO - Using the following test package requirements: 00:07:57 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 00:07:57 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:07:57 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:07:57 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'jsshell-linux-x86_64.zip'], 00:07:57 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:07:57 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 00:07:57 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:07:57 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:07:57 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:07:57 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:07:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:07:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:07:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 00:07:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:07:57 INFO - Fetch https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 00:07:58 INFO - Http code: 200 00:07:58 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 00:07:58 INFO - x-amz-cf-id: JuINhzcqdc31fteXwEASJcJ3tgauIkRHaT2c2AGrf44MgKHLk2rfSw== 00:07:58 INFO - x-amz-version-id: uDiSbHlxGt5TEUyISSJdBtj5K4Nr4DoO 00:07:58 INFO - Expected file size: 21949260 00:07:58 INFO - Obtained file size: 21949260 00:08:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 00:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 00:08:03 INFO - Http code: 200 00:08:03 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 00:08:03 INFO - x-amz-cf-id: Rke7KvVdcwGVz5YMGNtB6f29UHOVQpzUyn5V97_AdI4OILuShPJNLQ== 00:08:03 INFO - x-amz-version-id: uDiSbHlxGt5TEUyISSJdBtj5K4Nr4DoO 00:08:03 INFO - Expected file size: 21949260 00:08:03 INFO - Obtained file size: 21949260 00:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 00:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 00:08:08 INFO - Http code: 200 00:08:08 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 00:08:08 INFO - x-amz-cf-id: zrFY-uY0NAiVRzwDk-STToRmALIM0vdopTM6e4Hn96zrg6sWFaz48A== 00:08:08 INFO - x-amz-version-id: Z94eQvXRZmhG0Hn4aOkwTVKm8K0u7goH 00:08:09 INFO - Expected file size: 14409038 00:08:09 INFO - Obtained file size: 14409038 00:08: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')]} 00:08:09 INFO - trying https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:08:09 INFO - Downloading https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:08:11 INFO - Downloaded 64166931 bytes. 00:08:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:08:11 INFO - mkdir: /builds/slave/test/properties 00:08:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:08:11 INFO - Writing to file /builds/slave/test/properties/build_url 00:08:11 INFO - Contents: 00:08:11 INFO - build_url:https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:08:12 INFO - Running post-action listener: _resource_record_post_action 00:08:12 INFO - Running post-action listener: set_extra_try_arguments 00:08:12 INFO - [mozharness: 2017-01-16 08:08:12.424871Z] Finished download-and-extract step (success) 00:08:12 INFO - [mozharness: 2017-01-16 08:08:12.425097Z] Running populate-webroot step. 00:08:12 INFO - Running pre-action listener: _resource_record_pre_action 00:08:12 INFO - Running main action method: populate_webroot 00:08:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:08:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:08:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:08:12 INFO - '--tppagecycles', 00:08:12 INFO - '7'], 00:08:12 INFO - 'tests': ['tsvgm']}}, 00:08:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:08:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:08:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:08:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:08:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:08:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:08:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['damp', 'tps']}, 00:08:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'tests': ['damp', 'tps']}, 00:08:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['dromaeo_dom']}, 00:08:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:08:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['basic_compositor_video']}, 00:08:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:08:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['a11yr', 00:08:12 INFO - 'ts_paint', 00:08:12 INFO - 'tpaint', 00:08:12 INFO - 'sessionrestore', 00:08:12 INFO - 'sessionrestore_no_auto_restore', 00:08:12 INFO - 'tabpaint']}, 00:08:12 INFO - 'other-e10s': {'tests': ['a11yr', 00:08:12 INFO - 'ts_paint', 00:08:12 INFO - 'tpaint', 00:08:12 INFO - 'sessionrestore', 00:08:12 INFO - 'sessionrestore_no_auto_restore', 00:08:12 INFO - 'tabpaint']}, 00:08:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:08:12 INFO - 'ts_paint', 00:08:12 INFO - 'tpaint', 00:08:12 INFO - 'sessionrestore', 00:08:12 INFO - 'sessionrestore_no_auto_restore', 00:08:12 INFO - 'tabpaint']}, 00:08:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:08:12 INFO - 'ts_paint', 00:08:12 INFO - 'tpaint', 00:08:12 INFO - 'sessionrestore', 00:08:12 INFO - 'sessionrestore_no_auto_restore', 00:08:12 INFO - 'tabpaint']}, 00:08:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['a11yr', 00:08:12 INFO - 'ts_paint', 00:08:12 INFO - 'tpaint', 00:08:12 INFO - 'sessionrestore', 00:08:12 INFO - 'sessionrestore_no_auto_restore', 00:08:12 INFO - 'tabpaint']}, 00:08:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['a11yr', 00:08:12 INFO - 'ts_paint', 00:08:12 INFO - 'tpaint', 00:08:12 INFO - 'sessionrestore', 00:08:12 INFO - 'sessionrestore_no_auto_restore', 00:08:12 INFO - 'tabpaint']}, 00:08:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['tsvgx', 00:08:12 INFO - 'tsvgr_opacity', 00:08:12 INFO - 'tart', 00:08:12 INFO - 'tscrollx', 00:08:12 INFO - 'cart']}, 00:08:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:08:12 INFO - 'tsvgr_opacity', 00:08:12 INFO - 'tart', 00:08:12 INFO - 'tscrollx', 00:08:12 INFO - 'cart']}, 00:08:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'talos_options': ['--disable-e10s'], 00:08:12 INFO - 'tests': ['tp5o']}, 00:08:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'tests': ['tp5o']}, 00:08:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'talos_options': ['--disable-e10s', 00:08:12 INFO - '--xperf_path', 00:08:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:08:12 INFO - 'tests': ['tp5n']}, 00:08:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:12 INFO - 'talos_options': ['--xperf_path', 00:08:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:08:12 INFO - 'tests': ['tp5n']}}, 00:08:12 INFO - 'talos.zip': {'path': '', 00:08:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:08:12 INFO - Running post-action listener: _resource_record_post_action 00:08:12 INFO - [mozharness: 2017-01-16 08:08:12.441279Z] Finished populate-webroot step (success) 00:08:12 INFO - [mozharness: 2017-01-16 08:08:12.441367Z] Running create-virtualenv step. 00:08:12 INFO - Running pre-action listener: _resource_record_pre_action 00:08:12 INFO - Running main action method: create_virtualenv 00:08:12 INFO - Creating virtualenv /builds/slave/test/build/venv 00:08:12 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 00:08:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:08:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:08:12 INFO - Using real prefix '/usr' 00:08:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:08:13 INFO - Installing distribute.............................................................................................................................................................................................done. 00:08:15 INFO - Installing pip.................done. 00:08:15 INFO - Return code: 0 00:08:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:08:15 INFO - Reading from file tmpfile_stdout 00:08:15 INFO - Output received: 00:08:15 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) 00:08:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:08:15 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')]} 00:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:15 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')]} 00:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:15 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:15 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 00:08:15 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 00:08:15 INFO - Using env: {'DISPLAY': ':0', 00:08:15 INFO - 'HOME': '/home/cltbld', 00:08:15 INFO - 'LANG': 'en_US.UTF-8', 00:08:15 INFO - 'LANGUAGE': 'en_US:en', 00:08:15 INFO - 'LOGNAME': 'cltbld', 00:08:15 INFO - 'MAIL': '/var/mail/cltbld', 00:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:15 INFO - 'MOZ_NO_REMOTE': '1', 00:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:15 INFO - 'NO_EM_RESTART': '1', 00:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:15 INFO - 'PWD': '/builds/slave/test', 00:08:15 INFO - 'SHELL': '/bin/bash', 00:08:15 INFO - 'SHLVL': '1', 00:08:15 INFO - 'TERM': 'linux', 00:08:15 INFO - 'TMOUT': '86400', 00:08:15 INFO - 'USER': 'cltbld', 00:08:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:15 INFO - '_': '/tools/buildbot/bin/python'} 00:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:15 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 00:08:15 INFO - Cleaning up... 00:08:15 INFO - Return code: 0 00:08:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:08:15 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')]} 00:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:15 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')]} 00:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:15 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:15 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 00:08:15 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 00:08:15 INFO - Using env: {'DISPLAY': ':0', 00:08:15 INFO - 'HOME': '/home/cltbld', 00:08:15 INFO - 'LANG': 'en_US.UTF-8', 00:08:15 INFO - 'LANGUAGE': 'en_US:en', 00:08:15 INFO - 'LOGNAME': 'cltbld', 00:08:15 INFO - 'MAIL': '/var/mail/cltbld', 00:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:15 INFO - 'MOZ_NO_REMOTE': '1', 00:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:15 INFO - 'NO_EM_RESTART': '1', 00:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:15 INFO - 'PWD': '/builds/slave/test', 00:08:15 INFO - 'SHELL': '/bin/bash', 00:08:15 INFO - 'SHLVL': '1', 00:08:15 INFO - 'TERM': 'linux', 00:08:15 INFO - 'TMOUT': '86400', 00:08:15 INFO - 'USER': 'cltbld', 00:08:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:15 INFO - '_': '/tools/buildbot/bin/python'} 00:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:15 INFO - Downloading/unpacking psutil>=3.1.1 00:08:15 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 00:08:15 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 00:08:15 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 00:08:15 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 00:08:15 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 00:08:15 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 00:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:08:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:08:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:08:17 INFO - Installing collected packages: psutil 00:08:17 INFO - Running setup.py install for psutil 00:08:17 INFO - building 'psutil._psutil_linux' extension 00:08:17 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 00:08:18 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 00:08:18 INFO - building 'psutil._psutil_posix' extension 00:08:18 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 00:08:18 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 00:08:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:08:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:08:18 INFO - Successfully installed psutil 00:08:18 INFO - Cleaning up... 00:08:18 INFO - Return code: 0 00:08:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:08:18 INFO - Using env: {'DISPLAY': ':0', 00:08:18 INFO - 'HOME': '/home/cltbld', 00:08:18 INFO - 'LANG': 'en_US.UTF-8', 00:08:18 INFO - 'LANGUAGE': 'en_US:en', 00:08:18 INFO - 'LOGNAME': 'cltbld', 00:08:18 INFO - 'MAIL': '/var/mail/cltbld', 00:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:18 INFO - 'MOZ_NO_REMOTE': '1', 00:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:18 INFO - 'NO_EM_RESTART': '1', 00:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:18 INFO - 'PWD': '/builds/slave/test', 00:08:18 INFO - 'SHELL': '/bin/bash', 00:08:18 INFO - 'SHLVL': '1', 00:08:18 INFO - 'TERM': 'linux', 00:08:18 INFO - 'TMOUT': '86400', 00:08:18 INFO - 'USER': 'cltbld', 00:08:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:18 INFO - '_': '/tools/buildbot/bin/python'} 00:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:08:18 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 00:08:18 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 00:08:18 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 00:08:18 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 00:08:18 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 00:08:18 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 00:08:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:08:20 INFO - Installing collected packages: mozsystemmonitor 00:08:20 INFO - Running setup.py install for mozsystemmonitor 00:08:20 INFO - Successfully installed mozsystemmonitor 00:08:20 INFO - Cleaning up... 00:08:20 INFO - Return code: 0 00:08:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:08: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')]} 00:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08: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')]} 00:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08: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==2.5.1'] in /builds/slave/test/build 00:08: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==2.5.1 00:08:20 INFO - Using env: {'DISPLAY': ':0', 00:08:20 INFO - 'HOME': '/home/cltbld', 00:08:20 INFO - 'LANG': 'en_US.UTF-8', 00:08:20 INFO - 'LANGUAGE': 'en_US:en', 00:08:20 INFO - 'LOGNAME': 'cltbld', 00:08:20 INFO - 'MAIL': '/var/mail/cltbld', 00:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:20 INFO - 'MOZ_NO_REMOTE': '1', 00:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:20 INFO - 'NO_EM_RESTART': '1', 00:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:20 INFO - 'PWD': '/builds/slave/test', 00:08:20 INFO - 'SHELL': '/bin/bash', 00:08:20 INFO - 'SHLVL': '1', 00:08:20 INFO - 'TERM': 'linux', 00:08:20 INFO - 'TMOUT': '86400', 00:08:20 INFO - 'USER': 'cltbld', 00:08:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:20 INFO - '_': '/tools/buildbot/bin/python'} 00:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:20 INFO - Downloading/unpacking jsonschema==2.5.1 00:08:20 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 00:08:20 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 00:08:20 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 00:08:20 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 00:08:20 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 00:08:20 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 00:08:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:08:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:08:22 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 00:08:22 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 00:08:22 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 00:08:22 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 00:08:22 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 00:08:22 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 00:08:23 INFO - Downloading functools32-3.2.3-2.tar.gz 00:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:08:23 INFO - warning: no files found matching '*.txt' 00:08:23 INFO - no previously-included directories found matching 'build' 00:08:23 INFO - no previously-included directories found matching 'dist' 00:08:23 INFO - no previously-included directories found matching '.git*' 00:08:23 INFO - Installing collected packages: jsonschema, functools32 00:08:23 INFO - Running setup.py install for functools32 00:08:23 INFO - warning: no files found matching '*.txt' 00:08:23 INFO - no previously-included directories found matching 'build' 00:08:23 INFO - no previously-included directories found matching 'dist' 00:08:23 INFO - no previously-included directories found matching '.git*' 00:08:23 INFO - Successfully installed jsonschema functools32 00:08:23 INFO - Cleaning up... 00:08:23 INFO - Return code: 0 00:08:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:23 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:23 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 00:08:23 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 00:08:23 INFO - Using env: {'DISPLAY': ':0', 00:08:23 INFO - 'HOME': '/home/cltbld', 00:08:23 INFO - 'LANG': 'en_US.UTF-8', 00:08:23 INFO - 'LANGUAGE': 'en_US:en', 00:08:23 INFO - 'LOGNAME': 'cltbld', 00:08:23 INFO - 'MAIL': '/var/mail/cltbld', 00:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:23 INFO - 'MOZ_NO_REMOTE': '1', 00:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:23 INFO - 'NO_EM_RESTART': '1', 00:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:23 INFO - 'PWD': '/builds/slave/test', 00:08:23 INFO - 'SHELL': '/bin/bash', 00:08:23 INFO - 'SHLVL': '1', 00:08:23 INFO - 'TERM': 'linux', 00:08:23 INFO - 'TMOUT': '86400', 00:08:23 INFO - 'USER': 'cltbld', 00:08:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:23 INFO - '_': '/tools/buildbot/bin/python'} 00:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:08:23 INFO - Cleaning up... 00:08:23 INFO - Return code: 0 00:08:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:23 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:23 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 00:08:23 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 00:08:23 INFO - Using env: {'DISPLAY': ':0', 00:08:23 INFO - 'HOME': '/home/cltbld', 00:08:23 INFO - 'LANG': 'en_US.UTF-8', 00:08:23 INFO - 'LANGUAGE': 'en_US:en', 00:08:23 INFO - 'LOGNAME': 'cltbld', 00:08:23 INFO - 'MAIL': '/var/mail/cltbld', 00:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:23 INFO - 'MOZ_NO_REMOTE': '1', 00:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:23 INFO - 'NO_EM_RESTART': '1', 00:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:23 INFO - 'PWD': '/builds/slave/test', 00:08:23 INFO - 'SHELL': '/bin/bash', 00:08:23 INFO - 'SHLVL': '1', 00:08:23 INFO - 'TERM': 'linux', 00:08:23 INFO - 'TMOUT': '86400', 00:08:23 INFO - 'USER': 'cltbld', 00:08:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:23 INFO - '_': '/tools/buildbot/bin/python'} 00:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:23 INFO - Downloading/unpacking blobuploader==1.2.4 00:08:23 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 00:08:23 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 00:08:23 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 00:08:23 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 00:08:23 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 00:08:23 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 00:08:25 INFO - Downloading blobuploader-1.2.4.tar.gz 00:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:08:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:08:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 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 00:08:26 INFO - Downloading docopt-0.6.1.tar.gz 00:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:08:26 INFO - Installing collected packages: blobuploader, requests, docopt 00:08:26 INFO - Running setup.py install for blobuploader 00:08:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:08:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:08:26 INFO - Running setup.py install for requests 00:08:27 INFO - Running setup.py install for docopt 00:08:27 INFO - Successfully installed blobuploader requests docopt 00:08:27 INFO - Cleaning up... 00:08:27 INFO - Return code: 0 00:08:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:27 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:27 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 00:08:27 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 00:08:27 INFO - Using env: {'DISPLAY': ':0', 00:08:27 INFO - 'HOME': '/home/cltbld', 00:08:27 INFO - 'LANG': 'en_US.UTF-8', 00:08:27 INFO - 'LANGUAGE': 'en_US:en', 00:08:27 INFO - 'LOGNAME': 'cltbld', 00:08:27 INFO - 'MAIL': '/var/mail/cltbld', 00:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:27 INFO - 'MOZ_NO_REMOTE': '1', 00:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:27 INFO - 'NO_EM_RESTART': '1', 00:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:27 INFO - 'PWD': '/builds/slave/test', 00:08:27 INFO - 'SHELL': '/bin/bash', 00:08:27 INFO - 'SHLVL': '1', 00:08:27 INFO - 'TERM': 'linux', 00:08:27 INFO - 'TMOUT': '86400', 00:08:27 INFO - 'USER': 'cltbld', 00:08:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:27 INFO - '_': '/tools/buildbot/bin/python'} 00:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:08:27 INFO - Running setup.py (path:/tmp/pip-CeczrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:08:27 INFO - Running setup.py (path:/tmp/pip-mNSyVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:08:27 INFO - Running setup.py (path:/tmp/pip-Xoqdx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:08:27 INFO - Running setup.py (path:/tmp/pip-rrS1TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:08:27 INFO - Running setup.py (path:/tmp/pip-zkw43v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:08:27 INFO - Running setup.py (path:/tmp/pip-nmbLqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:08:27 INFO - Running setup.py (path:/tmp/pip-rdEUsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:08:28 INFO - Running setup.py (path:/tmp/pip-FHgMWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:08:28 INFO - Running setup.py (path:/tmp/pip-GGZmNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:08:28 INFO - Running setup.py (path:/tmp/pip-NNsbvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:08:28 INFO - Running setup.py (path:/tmp/pip-fEagnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:08:28 INFO - Running setup.py (path:/tmp/pip-gGqBbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:08:28 INFO - Running setup.py (path:/tmp/pip-baXCjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:08:28 INFO - Running setup.py (path:/tmp/pip-KNKNQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:28 INFO - Running setup.py (path:/tmp/pip-0qOpGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:08:28 INFO - Running setup.py (path:/tmp/pip-D4P80s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:08:28 INFO - Running setup.py (path:/tmp/pip-Gj9DSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:08:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:08:28 INFO - Running setup.py install for manifestparser 00:08:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:08:28 INFO - Running setup.py install for mozcrash 00:08:28 INFO - Running setup.py install for mozdebug 00:08:29 INFO - Running setup.py install for mozdevice 00:08:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Running setup.py install for mozfile 00:08:29 INFO - Running setup.py install for mozhttpd 00:08:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Running setup.py install for mozinfo 00:08:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Running setup.py install for mozInstall 00:08:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Running setup.py install for mozleak 00:08:29 INFO - Running setup.py install for mozlog 00:08:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Running setup.py install for moznetwork 00:08:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:08:29 INFO - Running setup.py install for mozprocess 00:08:30 INFO - Running setup.py install for mozprofile 00:08:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:08:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:08:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:08:30 INFO - Running setup.py install for mozrunner 00:08:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:08:30 INFO - Running setup.py install for mozscreenshot 00:08:30 INFO - Running setup.py install for moztest 00:08:30 INFO - Running setup.py install for mozversion 00:08:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:08:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:08:30 INFO - Cleaning up... 00:08:30 INFO - Return code: 0 00:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:30 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:30 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 00:08:30 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 00:08:30 INFO - Using env: {'DISPLAY': ':0', 00:08:30 INFO - 'HOME': '/home/cltbld', 00:08:30 INFO - 'LANG': 'en_US.UTF-8', 00:08:30 INFO - 'LANGUAGE': 'en_US:en', 00:08:30 INFO - 'LOGNAME': 'cltbld', 00:08:30 INFO - 'MAIL': '/var/mail/cltbld', 00:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:30 INFO - 'MOZ_NO_REMOTE': '1', 00:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:30 INFO - 'NO_EM_RESTART': '1', 00:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:30 INFO - 'PWD': '/builds/slave/test', 00:08:30 INFO - 'SHELL': '/bin/bash', 00:08:30 INFO - 'SHLVL': '1', 00:08:30 INFO - 'TERM': 'linux', 00:08:30 INFO - 'TMOUT': '86400', 00:08:30 INFO - 'USER': 'cltbld', 00:08:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:30 INFO - '_': '/tools/buildbot/bin/python'} 00:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:08:30 INFO - Running setup.py (path:/tmp/pip-XOPB4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:08:30 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)) 00:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:08:30 INFO - Running setup.py (path:/tmp/pip-6cAnRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:08:30 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)) 00:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:08:30 INFO - Running setup.py (path:/tmp/pip-OO1wV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:08:31 INFO - Running setup.py (path:/tmp/pip-HPm2zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:08:31 INFO - Running setup.py (path:/tmp/pip-gYsKvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:08:31 INFO - Running setup.py (path:/tmp/pip-khfdbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:08:31 INFO - Running setup.py (path:/tmp/pip-LOdNbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:08:31 INFO - Running setup.py (path:/tmp/pip-gz3P3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:08:31 INFO - Running setup.py (path:/tmp/pip-GjQiTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:08:31 INFO - Running setup.py (path:/tmp/pip-lo55Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:08:31 INFO - Running setup.py (path:/tmp/pip-f9nh54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:08:31 INFO - Running setup.py (path:/tmp/pip-WYHaXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:08:31 INFO - Running setup.py (path:/tmp/pip-6zcfvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:08:31 INFO - Running setup.py (path:/tmp/pip-W8aErW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:31 INFO - Running setup.py (path:/tmp/pip-O3Bvs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:31 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)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:08:31 INFO - Running setup.py (path:/tmp/pip-LC4VN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:08:31 INFO - Running setup.py (path:/tmp/pip-P41tPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:08:32 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)) 00:08:32 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)) 00:08:32 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)) 00:08:32 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)) 00:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:08:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:08:32 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 00:08:32 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 00:08:32 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 00:08:32 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 00:08:32 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 00:08:32 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 00:08:34 INFO - Downloading blessings-1.6.tar.gz 00:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:08:34 INFO - Installing collected packages: blessings 00:08:34 INFO - Running setup.py install for blessings 00:08:34 INFO - Successfully installed blessings 00:08:34 INFO - Cleaning up... 00:08:34 INFO - Return code: 0 00:08:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:08:34 INFO - Reading from file tmpfile_stdout 00:08:34 INFO - Current package versions: 00:08:34 INFO - argparse == 1.2.1 00:08:34 INFO - blessings == 1.6 00:08:34 INFO - blobuploader == 1.2.4 00:08:34 INFO - docopt == 0.6.1 00:08:34 INFO - functools32 == 3.2.3-2 00:08:34 INFO - jsonschema == 2.5.1 00:08:34 INFO - manifestparser == 1.1 00:08:34 INFO - mozInstall == 1.12 00:08:34 INFO - mozcrash == 1.0 00:08:34 INFO - mozdebug == 0.1 00:08:34 INFO - mozdevice == 0.48 00:08:34 INFO - mozfile == 1.2 00:08:34 INFO - mozhttpd == 0.7 00:08:34 INFO - mozinfo == 0.9 00:08:34 INFO - mozleak == 0.1 00:08:34 INFO - mozlog == 3.4 00:08:34 INFO - moznetwork == 0.27 00:08:34 INFO - mozprocess == 0.23 00:08:34 INFO - mozprofile == 0.28 00:08:34 INFO - mozrunner == 6.13 00:08:34 INFO - mozscreenshot == 0.1 00:08:34 INFO - mozsystemmonitor == 0.3 00:08:34 INFO - moztest == 0.8 00:08:34 INFO - mozversion == 1.4 00:08:34 INFO - psutil == 3.1.1 00:08:34 INFO - requests == 1.2.3 00:08:34 INFO - wsgiref == 0.1.2 00:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:34 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')]} 00:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:34 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')]} 00:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:34 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:34 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 00:08:34 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 00:08:34 INFO - Using env: {'DISPLAY': ':0', 00:08:34 INFO - 'HOME': '/home/cltbld', 00:08:34 INFO - 'LANG': 'en_US.UTF-8', 00:08:34 INFO - 'LANGUAGE': 'en_US:en', 00:08:34 INFO - 'LOGNAME': 'cltbld', 00:08:34 INFO - 'MAIL': '/var/mail/cltbld', 00:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:34 INFO - 'MOZ_NO_REMOTE': '1', 00:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:34 INFO - 'NO_EM_RESTART': '1', 00:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:34 INFO - 'PWD': '/builds/slave/test', 00:08:34 INFO - 'SHELL': '/bin/bash', 00:08:34 INFO - 'SHLVL': '1', 00:08:34 INFO - 'TERM': 'linux', 00:08:34 INFO - 'TMOUT': '86400', 00:08:34 INFO - 'USER': 'cltbld', 00:08:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:34 INFO - '_': '/tools/buildbot/bin/python'} 00:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 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)) 00:08:34 INFO - Cleaning up... 00:08:34 INFO - Return code: 0 00:08:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:08:34 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')]} 00:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:34 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')]} 00:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:35 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 0x7fac0eae3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', '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 00:08:35 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 00:08:35 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 00:08:35 INFO - Using env: {'DISPLAY': ':0', 00:08:35 INFO - 'HOME': '/home/cltbld', 00:08:35 INFO - 'LANG': 'en_US.UTF-8', 00:08:35 INFO - 'LANGUAGE': 'en_US:en', 00:08:35 INFO - 'LOGNAME': 'cltbld', 00:08:35 INFO - 'MAIL': '/var/mail/cltbld', 00:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:35 INFO - 'MOZ_NO_REMOTE': '1', 00:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:35 INFO - 'NO_EM_RESTART': '1', 00:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:35 INFO - 'PWD': '/builds/slave/test', 00:08:35 INFO - 'SHELL': '/bin/bash', 00:08:35 INFO - 'SHLVL': '1', 00:08:35 INFO - 'TERM': 'linux', 00:08:35 INFO - 'TMOUT': '86400', 00:08:35 INFO - 'USER': 'cltbld', 00:08:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:35 INFO - '_': '/tools/buildbot/bin/python'} 00:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:08:35 INFO - Cleaning up... 00:08:35 INFO - Return code: 0 00:08:35 INFO - Running post-action listener: _resource_record_post_action 00:08:35 INFO - Running post-action listener: _start_resource_monitoring 00:08:35 INFO - Starting resource monitoring. 00:08:35 INFO - [mozharness: 2017-01-16 08:08:35.268909Z] Finished create-virtualenv step (success) 00:08:35 INFO - [mozharness: 2017-01-16 08:08:35.269370Z] Running install step. 00:08:35 INFO - Running pre-action listener: _resource_record_pre_action 00:08:35 INFO - Running main action method: install 00:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:08:35 INFO - Reading from file tmpfile_stdout 00:08:35 INFO - Detecting whether we're running mozinstall >=1.0... 00:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:08:35 INFO - Reading from file tmpfile_stdout 00:08:35 INFO - Output received: 00:08:35 INFO - Usage: mozinstall [options] installer 00:08:35 INFO - Options: 00:08:35 INFO - -h, --help show this help message and exit 00:08:35 INFO - -d DEST, --destination=DEST 00:08:35 INFO - Directory to install application into. [default: 00:08:35 INFO - "/builds/slave/test"] 00:08:35 INFO - --app=APP Application being installed. [default: firefox] 00:08:35 INFO - mkdir: /builds/slave/test/build/application 00:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:08:51 INFO - Reading from file tmpfile_stdout 00:08:51 INFO - Output received: 00:08:51 INFO - /builds/slave/test/build/application/firefox/firefox 00:08:51 INFO - Running post-action listener: _resource_record_post_action 00:08:51 INFO - [mozharness: 2017-01-16 08:08:51.587265Z] Finished install step (success) 00:08:51 INFO - [mozharness: 2017-01-16 08:08:51.587510Z] Running run-tests step. 00:08:51 INFO - Running pre-action listener: _resource_record_pre_action 00:08:51 INFO - Running main action method: run_tests 00:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:08:51 INFO - Python 2.7.3 00:08:51 INFO - Return code: 0 00:08:51 INFO - grabbing minidump binary from tooltool 00:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:08:51 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 0x26c3f60>, '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 0x26c4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:08:51 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 00:08:51 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 00:08:51 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 00:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:08:51 INFO - Return code: 0 00:08:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:08:51 INFO - Using env: {'DISPLAY': ':0', 00:08:51 INFO - 'HOME': '/home/cltbld', 00:08:51 INFO - 'LANG': 'en_US.UTF-8', 00:08:51 INFO - 'LANGUAGE': 'en_US:en', 00:08:51 INFO - 'LOGNAME': 'cltbld', 00:08:51 INFO - 'MAIL': '/var/mail/cltbld', 00:08:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:08:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:51 INFO - 'MOZ_NO_REMOTE': '1', 00:08:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:51 INFO - 'NO_EM_RESTART': '1', 00:08:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:51 INFO - 'PWD': '/builds/slave/test', 00:08:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:08:51 INFO - 'SHELL': '/bin/bash', 00:08:51 INFO - 'SHLVL': '1', 00:08:51 INFO - 'TERM': 'linux', 00:08:51 INFO - 'TMOUT': '86400', 00:08:51 INFO - 'USER': 'cltbld', 00:08:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121', 00:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:51 INFO - '_': '/tools/buildbot/bin/python'} 00:08:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:08:51 INFO - mozversion application_buildid: 20170115223822 00:08:51 INFO - mozversion application_changeset: 29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7 00:08:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:08:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:08:51 INFO - mozversion application_name: Firefox 00:08:51 INFO - mozversion application_remotingname: firefox-dev 00:08:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:08:51 INFO - mozversion application_vendor: Mozilla 00:08:51 INFO - mozversion application_version: 52.0a2 00:08:51 INFO - mozversion platform_buildid: 20170115223822 00:08:51 INFO - mozversion platform_changeset: 29164ffa1889e8a8e94c6e61f4c80f8f3c1427f7 00:08:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:08:51 INFO - mozversion platform_version: 52.0a2 00:08:51 INFO - using testdate: 1484554131 00:08:51 INFO - actual date: 1484554131 00:08:51 INFO - starting webserver on 'localhost:37494' 00:08:51 INFO - SUITE-START | Running 2 tests 00:08:51 INFO - TEST-START | dromaeo_css 00:08:51 INFO - operating with platform_type : linux_ 00:08:51 INFO - Initialising browser for dromaeo_css test... 00:08:51 INFO - TEST-INFO | started process 19108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT_4Hcm/profile http://localhost:37494/getInfo.html) 00:08:56 INFO - PROCESS | 19108 | __metrics Screen width/height:1600/1200 00:08:56 INFO - PROCESS | 19108 | colorDepth:24 00:08:56 INFO - PROCESS | 19108 | Browser inner width/height: 1024/697 00:08:56 INFO - PROCESS | 19108 | __metrics 00:08:57 INFO - PROCESS | 19108 | 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" 00:08:57 INFO - PROCESS | 19108 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:08:57 INFO - PROCESS | 19108 | console.error: PushService: 00:08:57 INFO - PROCESS | 19108 | stateChangeProcessEnqueue: Error transitioning state 00:08:57 INFO - PROCESS | 19108 | UnknownError 00:08:58 INFO - TEST-INFO | 19108: exit 0 00:08:58 INFO - Browser initialized. 00:08:58 INFO - Running cycle 1/1 for dromaeo_css test... 00:08:58 INFO - TEST-INFO | started process 19198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT_4Hcm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:09:10 INFO - PROCESS | 19198 | RSS: Main: 147456000 00:09:10 INFO - PROCESS | 19198 | 00:12:11 INFO - PROCESS | 19198 | Cycle 1(1): loaded http://localhost:37494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37494/tests/dromaeo/cssquery-ext.html) 00:12:12 INFO - PROCESS | 19198 | RSS: Main: 239165440 00:12:12 INFO - PROCESS | 19198 | 00:15:15 INFO - PROCESS | 19198 | Cycle 1(1): loaded http://localhost:37494/tests/dromaeo/cssquery-ext.html (next: http://localhost:37494/tests/dromaeo/cssquery-jquery.html) 00:15:15 INFO - PROCESS | 19198 | RSS: Main: 237559808 00:15:15 INFO - PROCESS | 19198 | 00:18:17 INFO - PROCESS | 19198 | Cycle 1(1): loaded http://localhost:37494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37494/tests/dromaeo/cssquery-mootools.html) 00:18:18 INFO - PROCESS | 19198 | RSS: Main: 173109248 00:18:18 INFO - PROCESS | 19198 | 00:21:20 INFO - PROCESS | 19198 | Cycle 1(1): loaded http://localhost:37494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37494/tests/dromaeo/cssquery-prototype.html) 00:21:20 INFO - PROCESS | 19198 | RSS: Main: 199917568 00:21:20 INFO - PROCESS | 19198 | 00:24:23 INFO - PROCESS | 19198 | Cycle 1(1): loaded http://localhost:37494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37494/tests/dromaeo/cssquery-yui.html) 00:24:23 INFO - PROCESS | 19198 | RSS: Main: 176001024 00:24:23 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | Cycle 1(1): loaded http://localhost:37494/tests/dromaeo/cssquery-yui.html (next: http://localhost:37494/tests/dromaeo/cssquery-dojo.html) 00:27:26 INFO - PROCESS | 19198 | RSS: Main: 261419008 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | __start_tp_report 00:27:26 INFO - PROCESS | 19198 | _x_x_mozilla_page_load 00:27:26 INFO - PROCESS | 19198 | _x_x_mozilla_page_load_details 00:27:26 INFO - PROCESS | 19198 | |i|pagename|runs| 00:27:26 INFO - PROCESS | 19198 | |0;dojo.html;3208.165876872013;3247.8213698246586;3249.9512507312393;3265.510173473977;3291.2594666200107;5544.16837474379;5583.944160558393;5591.580631452642;5601.747921343539;5602.4117467665865;5532.640378375403;5599.692016939067;5622.353429355625;5630.071038278689;5635.887282254353;5058.4435712071645;5088.720120393377;5100.0054989277105;5130.07658621448;5167.664101833388;5034.09386310464;5145.022445735298;5193.221016847466;5197.168453047513;5199.792008319662;5015.348004759376;5030.270610761438;5049.596032317424;5105.5149760772665;5106.974465127669;5056.747162641872;5082.2376643503585;5104.3109180260935;5149.536541711226;5170.37955445349;4972.651914365996;5044.848654540369;5091.312672789163;5113.51421614946;5115.795368185268;5386.946130538684;5417.024935511607;5446.291982042309;5481.095619222823;5487.314085739283;5820.592558520905;5832;5840.065589505702;5949.732262048218;5953.3748956359395;5966.164736936832;5974.014287642533;5982.252218472691;5983.371745966698;5994.790182343597;5447.291852059247;5481.040817856859;5515.090010148361;5541.944580554224;5544.500994910478;6014.939850601526;6037.305709843336;6048.425399587032;6050.606710563799;6073.18012068374;5831.271091113611;5848.0350742127075;5849.473547380671;5852.092925596539;5854.2974843018255;5787.189793428924;5846.7076646167525;5851;5893.292804863444;5900.055991041413;5907.940920590825;5913.379095195029;5915.852103697442;5941.584089113807;5950.315713692894;5871.060630299217;5915.792947246911;5928.288605367384;5929.792457263975;5932.733027013708;4544.681872268976;4585.28928016158;4618.676692631483;4633.559811817872;4658;4143.3370660694145;4176.2900306947895;4180.91638167241;4213.431186789744;4219.219444402734;5840.386759390203;5845.269341332333;5851.502622277069;5852.502537284294;5855.3266374367495;5831.94168058314;5898.3216930053595;5916.674582897982;6022.277326720821;6033.12519684652;5733.283339582552;5802.738876750556;5811.27359080115;5831.475167234969;5835.67903765297;5176.145935920531;5185.714785686748;5188.11801993662;5190.091733946544;5211.557017653466;6145.262568491809;6204.224471941007;6234.906476402857;6291.5281353898645;6302.65335406557;5816.796412125725;5836.766529338779;5877.382874798255;5910.113482977587;5928.081147422156;6217.96891015542;6219.160413344141;6223.315435302204;6225.533085018551;6236.688165591611;5713.200151978644;5793.044147715748;5800.1589769484035;5800.4489573490455;5805.013147764975;5786.623869448473;5933.317668468181;5967;5971.671558064174;6052.939470605237;5818.7090645466715;5860.560457965755;5870.970645146747;5872.119182122716;5873.148393482836;5863.325717542367;5879.529637628894;5880.353161152356;5883;5885.293764748258;5604.887902242014;5614.5789065821045;5750.022496175744;5788.044972579477;5789;5894.852628684317;5901.822945311647;5917;5917.082852157922;5918.378570250062;5579.860503487445;5624.100143976944;5763.510101641407;5770.711464426678;5775.133729940542 00:27:26 INFO - PROCESS | 19198 | |1;ext.html;562.3083607163189;598.4733434577571;615.7260019291414;644.3363335764161;649.3668673043786;35489;37654.24691506168;37668.62331376685;45339.31991020129;45732.31401528972;46653.76673116638;47086.293705594355;47115.764421177846;47191.764041179835;47210;8879.644814207424;9019.503927283997;9026.277897768163;9027.999999999967;9039.276857851357;8377.95811020947;8595.570221488932;10536.578536858517;10829.187810914213;10838.187135964794;10865.782684346308;10877.347359158475;10880.401577913251;10885.18361122915;10898.727531811728;8391.202835730595;10843.132549396068;10887.727806804814;10901.618443354524;10903.618373356974;8353.164683531599;10265.846012309821;10623.25637205396;10665.306755060896;10903.127749779998;43716.562834371885;44026.11947761059;44055.77972110151;44094;44138;3671.210689701727;3831;4022.8189731462153;4063.6545893599077;4325.6106950374615;32980.50529242063;33084.834575827204;33159.668403315896;33178.50232246518;33330.83334583336;4441.311596702516;4502.842400515966;4503.049250237327;4506.954930450719;4543.727376357429;314238.99999999773;314322;314494;314707;314745;39195.608043919194;62762.372376276566;63145.368546314865;63146;63235;38183.23633527314;40756;40938.38592421116;40977;40986.590134098275;14521.34653940554;14554.636134096521;14558.41766329335;14573.344199511048;14592.270386480846;12016.879831201752;12261.325627090417;12672.80990785139;12781.744365112645;12800.551980680817;9127.497987610745;9130.360874738837;9299.442033478013;9410.717678469657;9665.323427360157;3534.4344904815107;3541.256336169382;3558.9110272242883;3583.390823559949;3611.1874828163454;986.4673076538588;1055.171690223171;1068.4978060311641;1077.8706555213425;1088.6026600290836;34529.82735086309;34729.65270347315;34880.47679284813;34959.475607865905;35138.64861351405;1108.8724796648328;1124.173732306754;1127.199688221372;1141.9657410277705;1167.6788883057056;18288.542786430447;18328.81671183271;18479.168437420347;18596.163172657263;18601;540332;540875;548344;549259;549447;65329.67335163294;65546;65753;65845;65983.67008165024;1200.0939290835363;1332.0875200487696;1361.3261435589448;1409.5912185466304;1429.306786208688;33234.16914577155;35668;35731.285374292886;37474.625253747115;37880.62119378771;59730.70134649299;60437.39562604317;60755.69622151861;60828.391716082275;60883.69558152181;432961;435610;435612.93161205214;437834;438080;27925.44149117047;28032.29919252035;31827.840860795546;31945.881894133592;32165.35669286648;47074.52925470839;49096.75451622719;53849;53957.19064213961;54335;42712.14575708531;44468.33297500605;44808;44960.550394496946;45490.545094549954;42998.785006074766;44030.339544907496;44768.55231447774;45122.77438612786;45867.54132458766;43986.56013439825;45398.77300613476;45984.31023534583;46193.76903115463;46200.7689961548;36993.445098323005;38936.610633893295;39413.605863941;39978.60021399749;40165.397519036655;29740.256493587833;30086.796528138628;30211.848940756034;30423;30467.542986855657 00:27:26 INFO - PROCESS | 19198 | |2;jquery.html;390.09692561719635;390.69916164553297;409.6067774936061;414.89420197849546;421.36163711976343;14133.646658833535;18540.351087711933;19584.41246762596;20201.696974545375;20223;17427.825721742778;17521.474355769315;18990;19430.417087487363;19492.707609385834;5348.438413966526;5364.1149210380245;5492.5605951523985;5524.972375138119;5537.556995440375;5461.098918678414;5548.9722551387185;5549.112142057272;5549.694766787825;5552.833414997536;4189.811458484375;5630.690312032836;6172.043333283325;6233.688315584202;6285.842853928642;5923.881522369572;6139.1712118863825;6278.968605156968;6279.309275979662;6279.968600157015;5406.756695948652;5414.3232095988005;5417.349918009824;5420.376656684492;5422.240886275925;23286.41783955398;23301.41746456335;23334.18330358446;23523.76476235233;23923.40191495209;2292.4154340643195;2449.6570480132796;2565.8717064146904;2591.9870400647874;3003.294225856922;13481.528146514924;14589.92705036468;15059.397624095023;15112.622184445367;15211.315490802941;1929.7684277886744;1935.632229876333;2004.8195662390456;2055.4142069510117;2086.5618220173783;75133.24866751372;79180.60409697972;83021;85571;87555;11356.318620882774;11467.77064458706;11527.365994870195;11656.242344247597;11729.237599556001;14078.436862525385;14595.051321664057;16549.669006620043;16636.168191590372;16641.167941603115;8235.258826705625;8510.638297872434;8687.609057592423;8752.956235218782;8915.866262006075;8456.238938495564;8477.491350518989;8507.744767656981;8662.393632445668;8680.609372578248;4996.200607902718;5045.344105266292;5064.265681476165;5073.898522029539;5106.208537676666;1980.0200697949494;1983.5041239690077;2101.3905967269625;2101.506146055676;2137.7541582718186;867.2758246863813;991.4101109839634;1006.6325791086201;1031.3657100883054;1073.5061871539024;19370.32203872886;19482.318118865773;19580.412587622108;19626.50933726668;19824.107915143853;1014.771676372825;1018.3737001743874;1032.4166845732138;1037.061459379263;1089.6077412131626;10358.482075896174;10711.410872401937;10741.946290268656;10844.566217351376;10894.891051089387;475761;482710;510568;515667;517434;92674.53662731643;92807.53596231976;92822;93084;95234.52382738041;1009.2329829329763;1025.610268098118;1053.7365658585354;1054.6361505280665;1055.261317078033;16680.416185433452;16972.915135424242;17130.914345428693;17212.88116272438;17214.13929303505;35982;43377.3493397593;43711;43777.34333984929;44234.77882610695;56074;56881.431185687616;57503.137452939074;57543.424565753805;58211.4178858206;7900.486468379537;8187.549684767395;8226.341892648694;8247;8749.868751968854;9413.640617804329;11956.76086478283;12605.495780169058;12754.744905102032;12960.935195323964;11679.416029198675;11807.291562506278;11855.822162667739;11980.760384792082;12413.565525206574;11381.146414018816;11526.481308341312;11540.884591153981;11597.304161750322;11806.173567850168;6198.659073750987;9261.564457509097;11647.475863585989;12331.383430828602;12397.690057748629;8946.821063578822;8984.32617553673;8995.100489950952;9015.14356136166;9054.185123338932;10883.564657413932;11336.6032188873;11575.421228938689;11703.414829258674;11798.52805887755 00:27:26 INFO - PROCESS | 19198 | |3;mootools.html;1477.0842077911693;1518.4913054126869;1645.3089702325021;1787.9195436205368;1792.399546152039;8595.183457571537;9058.682946096887;9095.1359620836;9099.45403275804;9103.226225770817;8034.517928924269;8280.089190189074;8638.438501497414;8864.778380540474;8959.104089591037;2454.680891484109;2456.5701002324613;2476.1333533263305;2482.1684735613503;2483.4412257242157;2435.7320694723567;2524.432002799374;2525.2424272718204;2528;2528.5954247320433;2428.490017096412;2431.294924471901;2483.900643974239;2484.5155194737035;2487.962680559793;2366.7751563601432;2374.050379848057;2396.760323967607;2400.4838959623767;2404.038384646138;2397.095272864539;2400.4958958618713;2419.830611857171;2421.2857207123766;2449.6203088521306;9100.408473449272;9140.268778497772;9181.67864124759;9205.217556507705;9208.355415120945;5486.149646804752;5637;5641.182028605829;5641.379448260688;5643.915341269884;3516.4373700207843;3547.219611685425;3612.837422315976;3775.1497619297256;3806;1139.1968662093204;1149.0979581028935;1169.561414469574;1170.3738499902597;1200.0339726520149;12787.872121278855;12882.420291086924;12893.904018158468;12895.935520322431;12920.54778082772;4729.881752956204;4997.650164488524;5000.974995125001;5019.196928491424;5090.08378491875;10765.13878889687;10767.89232107669;10776.892231077745;10776.892231077745;10780.838287425695;5552.666839989613;5571.331440227199;5575.219469274305;5575.888482230333;5577.44225577439;4462.531434199363;4760.690555113906;5022.547970682656;5077.009983053269;5125.15434953236;4133.739811117156;4155.916881662411;4249.80875860587;4290.2706539888295;4290.549492303326;1282.4549566434227;1331.593863871509;1334.5129027904745;1343.9193648381129;1348.5886804524714;878.5826732302105;978.9363691360039;1008.4050410257983;1050.7478205230689;1063.3194755356578;5996.970015149896;6085.5435842312;6166.784162554379;6272.968635156795;6365.14070600463;939.6852054561662;940.5579377692474;957.5260246178048;968.3173362779223;1050.5955207245265;4244.342126970325;4414.271645178574;4426.557344265612;4439.911201775946;4450.777461126995;11079.612213572647;11359.829602555968;11426.600068997544;11437.771244575062;11466.827997580043;10568.894311056945;11364.374959377148;11385.601503947322;11390.829137562943;11398.772024559628;8272.255497005179;8710.564471776386;8712.346574006848;8712.695055673148;8713.782155446037;6021.909671355021;6154.969225153845;6281.842953926189;6385.13800636908;6421.646809425526;10168.186545076524;10242.743931401477;10252.487375631337;10416.1667066636;10416.375017498975;10246.590136394461;10397.844032339672;10644.41455719912;10793.67618971432;10794.784104317712;7534.284242996907;7731.342835859015;7736.651850666846;8153.388495862952;8319;8409.579521024047;8471.57642117904;8678.956605216934;8686.522241276538;8771.517566533646;7316.634168291458;7659;7694.846103077795;8012.599370031592;8021.478603890729;7913.327367173854;7953.5227886327;7976.6410511525955;8008.199180081945;8108.594570271581;7527.623618818928;7530.209328020479;7539.9246007541415;7601.695932162652;7633.809154770953;5416.783328666809;5460.071787796005;5487.9298536784945;5530.834074977757;5530.972345138249;5423.078076727044;5460.863478413072;5525.889482210414;5576.86057848557;5621.747021383966 00:27:26 INFO - PROCESS | 19198 | |4;prototype.html;318.5778843032981;325.64016761478564;338.8932486266824;341.98771635957564;346.1968233697819;5211.635185537014;5321.92017119743;5372.57019438445;5383.192521121834;5403.999999999995;5179;5254.479498735846;5266.3153790007345;5279.234510995903;5296.761645725942;4170.249355116078;4170.52039015514;4174.31123864562;4195.66434685226;4220.704550681454;4130.917381652365;4201.348790937394;4209.85265515707;4215.810288537024;4226.830926762926;4181.477315335583;4184.476940382452;4185.79071046448;4189.916201675965;4192.5597812229735;4172.603602657758;4178.415021896937;4179.205950869356;4182.498100227962;4183.368486290349;3524.488949102366;3618.475321078455;3624.4563315502623;3625.1843335249623;3729.5151630287887;5118.539331460149;5152.252923326134;5190.974045129788;5196.53231209193;5233.581313494911;4727.692699974525;4739.928901066487;4740.502247264057;4748.240281554969;4757.310190022427;5406.297016439808;5585.74864131111;5597.916031259534;5611.382747897728;5619.129034999582;3987.461692671481;4005.73962692427;4029.4560234368278;4032.9395059074136;4046.271671099201;5778.855528611776;5809.651420914759;5825.718341964761;5838;5840.678762668052;4001.2197621464115;4160.209560183555;4225.471816022997;4241;4242.151569686075;4263.744175349489;4308.353746937984;4311.116221174714;4318.287482565342;4341.848035318749;4841.104395686809;4842.22524396102;4842.903141937141;4855.781489832966;4891.951080489221;5436.320459942507;5643.746031428595;5643.887122257532;5667.858303542362;5703.458171473703;1391.4364682303683;1397.3013493253372;1409.7251036047871;1451.4557041109583;1455.657920388708;990.9950450247702;1021.274894824668;1022.3967858963248;1034.2915103154212;1035.4874337203132;5361.678299302054;5361.954418888357;5373.704446255493;5376.569874410038;5377.704226267515;5442.265294185314;5469.019384435493;5479.479449452296;5519;5528.917066244009;5137.794488220504;5300.44345343741;5352.19717042439;5361.571074314045;5362.383325917569;2926;2932.222960915359;2933.8386388748395;2945.175350901751;2945.8495298432263;5738;5756.625819321731;5796.420357964254;5805.506531944748;5805.912911306334;5379.65032272901;5570.526505247019;5576.9845711087955;5596.888062238814;5605.971970140124;5743.741531631086;5753.087900227802;5753.921651916205;5754.7985820496915;5769.74036168365;5160.612954028538;5421.945780542144;5480.972595136999;5517.15175416224;5536.446355364431;5385.946140538545;5392.51467367923;5393.460653934575;5416.350037995466;5434.83695489136;5758.1362795581;5783.7397317119985;5787.305523337226;5828.912566311424;5834.358220595816;3908.5895980921596;4050.4936882889638;4058.330375488011;4153.7300075494995;4172.895677608084;5516.475934786189;5664.433556644302;5726.885462290647;5754.625949313281;5765.336986246468;5532.336119665666;5672.546196304368;5683.460071293221;5693.5160511357;5699.458551437607;5657.60396772222;5666.603337766317;5669.092945128759;5675.489205971482;5680.488756011979;5361.410244872983;5585.385607583082;5602.803901863415;5635.8591035224445;5650.943490565041;5666.603337766317;5686.800961966477;5690.658560486384;5701.714914254354;5718.599698021098;5368.2484452177505;5555.166724991283;5565.860853478695;5595.468430499096;5622.269105016322 00:27:26 INFO - PROCESS | 19198 | |5;yui.html;808.1877712898532;810.9351251899849;839.1901814748768;841.9747407577775;876.6843936182975;13497.662558436044;14151.504697335595;14160.858391416083;14173.149611023333;14177.858221417782;12403;13409.46362145513;13461.461541538327;14562.854371456282;14724;815.0708192660343;815.9836803263931;816.0859836982588;820.1347578304886;823.2508417340237;847.4872702015284;848.749618862434;850.2347886901777;850.9829803403928;851.1573542193246;893.7988952485704;894.4767311123001;895.8611415230617;897.2776914583758;897.3225214962727;892.9330300227476;893.2139717048956;893.714011516315;894.0344428017726;894.8791913091746;649.525846132326;652.5725649699407;654.4862283107785;654.5712558274338;654.7642848574557;14939.327730252056;14992.850071499255;15002.774958375632;15006.174660393674;15091.698166036618;13769.655758606115;14713;14738.705225895423;15079.54761357161;15124.395024199019;12303.93848030754;12387.380630968415;12468.875311246862;12540.435680394405;13065.869341306561;3793.108619474449;3829.1941331983976;3860.208657225262;3889.669378102865;3927.9214415711526;44796.776016120035;45794.77102614499;61357.386426135614;62866.37133628697;67548.6622566889;11541.826872596917;11646.767064658829;11664.88335116638;11857.525698972117;11861.288322700666;20938;21096.894515527325;21118;21272.36182914515;21467.141314347562;8554.786130346667;8654.350923680624;8680.479171249744;8683.175098365646;8931.776705582412;4473.4408198975125;4514.819407223675;4533.84131555394;4581.839635612738;4658.277966915133;3552.6447355264268;3682.558093028854;3683.797391143459;3686.170611612419;3690.538682664667;624.7282432141942;628.0547775597696;628.613402757301;631.8862604731193;641.4900154377282;705.4215543254483;706.156143408632;769.4882902869641;791.3431851563189;798.8477586232484;9856.556454959544;9968.950155249177;10043.548040338203;10055.648052318134;10077.093061624342;760.5550752809557;766.4749646492171;770.7572114783825;804.3364224514798;805.3838813307824;4780.354652121989;5038.193888977746;5044.596432285482;5056.393232812086;5083.110455670243;73812.2618773816;74561.62719186369;74809.25190748132;76220.23779762242;93017;48127.518724812304;61506.384936150964;69342.30657693358;76559.85160222602;76603;65929.35176620622;67660.32339676541;69298.3070169302;69448.30551694418;70319;9836.45899475507;9929.304948653526;9993.250506212209;10050.64822731201;10232.693019209435;30998.845005774827;32042.19894502656;41883.58116418797;42837;45108;39686.603133969445;54174.45825541852;55187.724061379435;62409.68795155995;62985;12751.71123845915;12819.743605127658;13355.399007044512;13391.799123012968;13524.729505410034;14581.708365832836;14945.476908308157;15006.324715388053;15013.924930375279;15115.622109447351;13869;14189.148651080555;14264.144151350953;14325.426982920566;14433.20617366055;13177.802332965204;13414.664633384244;13535.458581656623;14349.64125896861;14821.777673335124;12608.369581520703;13200.14199077057;13449.798253026016;13486.190828550318;14116.858831411555;10564.894351056391;10930.617428389969;10934.45327733626;11353.37556434404;11595.478203480694;11517.769644606893;11813.822792657946;12022.699432513908;12029.819552706891;12090.939545302217 00:27:26 INFO - PROCESS | 19198 | __end_tp_report 00:27:26 INFO - PROCESS | 19198 | __start_cc_report 00:27:26 INFO - PROCESS | 19198 | _x_x_mozilla_cycle_collect,968 00:27:26 INFO - PROCESS | 19198 | __end_cc_report 00:27:26 INFO - PROCESS | 19198 | __startTimestamp1484555246532__endTimestamp 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | ------- Summary: start ------- 00:27:26 INFO - PROCESS | 19198 | Number of tests: 6 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | [#0] dojo.html Cycles:165 Average:5546.65 Median:5802.74 stddev:609.03 (10.5%) stddev-sans-first:582.62 00:27:26 INFO - PROCESS | 19198 | Values: 3208.2 3247.8 3250.0 3265.5 3291.3 5544.2 5583.9 5591.6 5601.7 5602.4 5532.6 5599.7 5622.4 5630.1 5635.9 5058.4 5088.7 5100.0 5130.1 5167.7 5034.1 5145.0 5193.2 5197.2 5199.8 5015.3 5030.3 5049.6 5105.5 5107.0 5056.7 5082.2 5104.3 5149.5 5170.4 4972.7 5044.8 5091.3 5113.5 5115.8 5386.9 5417.0 5446.3 5481.1 5487.3 5820.6 5832.0 5840.1 5949.7 5953.4 5966.2 5974.0 5982.3 5983.4 5994.8 5447.3 5481.0 5515.1 5541.9 5544.5 6014.9 6037.3 6048.4 6050.6 6073.2 5831.3 5848.0 5849.5 5852.1 5854.3 5787.2 5846.7 5851.0 5893.3 5900.1 5907.9 5913.4 5915.9 5941.6 5950.3 5871.1 5915.8 5928.3 5929.8 5932.7 4544.7 4585.3 4618.7 4633.6 4658.0 4143.3 4176.3 4180.9 4213.4 4219.2 5840.4 5845.3 5851.5 5852.5 5855.3 5831.9 5898.3 5916.7 6022.3 6033.1 5733.3 5802.7 5811.3 5831.5 5835.7 5176.1 5185.7 5188.1 5190.1 5211.6 6145.3 6204.2 6234.9 6291.5 6302.7 5816.8 5836.8 5877.4 5910.1 5928.1 6218.0 6219.2 6223.3 6225.5 6236.7 5713.2 5793.0 5800.2 5800.4 5805.0 5786.6 5933.3 5967.0 5971.7 6052.9 5818.7 5860.6 5871.0 5872.1 5873.1 5863.3 5879.5 5880.4 5883.0 5885.3 5604.9 5614.6 5750.0 5788.0 5789.0 5894.9 5901.8 5917.0 5917.1 5918.4 5579.9 5624.1 5763.5 5770.7 5775.1 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | [#1] ext.html Cycles:180 Average:60103.32 Median:40072.00 stddev:117313.05 (292.8%) stddev-sans-first:117556.97 00:27:26 INFO - PROCESS | 19198 | Values: 562.3 598.5 615.7 644.3 649.4 35489.0 37654.2 37668.6 45339.3 45732.3 46653.8 47086.3 47115.8 47191.8 47210.0 8879.6 9019.5 9026.3 9028.0 9039.3 8378.0 8595.6 10536.6 10829.2 10838.2 10865.8 10877.3 10880.4 10885.2 10898.7 8391.2 10843.1 10887.7 10901.6 10903.6 8353.2 10265.8 10623.3 10665.3 10903.1 43716.6 44026.1 44055.8 44094.0 44138.0 3671.2 3831.0 4022.8 4063.7 4325.6 32980.5 33084.8 33159.7 33178.5 33330.8 4441.3 4502.8 4503.0 4507.0 4543.7 314239.0 314322.0 314494.0 314707.0 314745.0 39195.6 62762.4 63145.4 63146.0 63235.0 38183.2 40756.0 40938.4 40977.0 40986.6 14521.3 14554.6 14558.4 14573.3 14592.3 12016.9 12261.3 12672.8 12781.7 12800.6 9127.5 9130.4 9299.4 9410.7 9665.3 3534.4 3541.3 3558.9 3583.4 3611.2 986.5 1055.2 1068.5 1077.9 1088.6 34529.8 34729.7 34880.5 34959.5 35138.6 1108.9 1124.2 1127.2 1142.0 1167.7 18288.5 18328.8 18479.2 18596.2 18601.0 540332.0 540875.0 548344.0 549259.0 549447.0 65329.7 65546.0 65753.0 65845.0 65983.7 1200.1 1332.1 1361.3 1409.6 1429.3 33234.2 35668.0 35731.3 37474.6 37880.6 59730.7 60437.4 60755.7 60828.4 60883.7 432961.0 435610.0 435612.9 437834.0 438080.0 27925.4 28032.3 31827.8 31945.9 32165.4 47074.5 49096.8 53849.0 53957.2 54335.0 42712.1 44468.3 44808.0 44960.6 45490.5 42998.8 44030.3 44768.6 45122.8 45867.5 43986.6 45398.8 45984.3 46193.8 46200.8 36993.4 38936.6 39413.6 39978.6 40165.4 29740.3 30086.8 30211.8 30423.0 30467.5 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | [#2] jquery.html Cycles:180 Average:29453.88 Median:13186.53 stddev:82530.51 (625.9%) stddev-sans-first:82733.17 00:27:26 INFO - PROCESS | 19198 | Values: 390.1 390.7 409.6 414.9 421.4 14133.6 18540.4 19584.4 20201.7 20223.0 17427.8 17521.5 18990.0 19430.4 19492.7 5348.4 5364.1 5492.6 5525.0 5537.6 5461.1 5549.0 5549.1 5549.7 5552.8 4189.8 5630.7 6172.0 6233.7 6285.8 5923.9 6139.2 6279.0 6279.3 6280.0 5406.8 5414.3 5417.3 5420.4 5422.2 23286.4 23301.4 23334.2 23523.8 23923.4 2292.4 2449.7 2565.9 2592.0 3003.3 13481.5 14589.9 15059.4 15112.6 15211.3 1929.8 1935.6 2004.8 2055.4 2086.6 75133.2 79180.6 83021.0 85571.0 87555.0 11356.3 11467.8 11527.4 11656.2 11729.2 14078.4 14595.1 16549.7 16636.2 16641.2 8235.3 8510.6 8687.6 8753.0 8915.9 8456.2 8477.5 8507.7 8662.4 8680.6 4996.2 5045.3 5064.3 5073.9 5106.2 1980.0 1983.5 2101.4 2101.5 2137.8 867.3 991.4 1006.6 1031.4 1073.5 19370.3 19482.3 19580.4 19626.5 19824.1 1014.8 1018.4 1032.4 1037.1 1089.6 10358.5 10711.4 10741.9 10844.6 10894.9 475761.0 482710.0 510568.0 515667.0 517434.0 92674.5 92807.5 92822.0 93084.0 95234.5 1009.2 1025.6 1053.7 1054.6 1055.3 16680.4 16972.9 17130.9 17212.9 17214.1 35982.0 43377.3 43711.0 43777.3 44234.8 56074.0 56881.4 57503.1 57543.4 58211.4 7900.5 8187.5 8226.3 8247.0 8749.9 9413.6 11956.8 12605.5 12754.7 12960.9 11679.4 11807.3 11855.8 11980.8 12413.6 11381.1 11526.5 11540.9 11597.3 11806.2 6198.7 9261.6 11647.5 12331.4 12397.7 8946.8 8984.3 8995.1 9015.1 9054.2 10883.6 11336.6 11575.4 11703.4 11798.5 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | [#3] mootools.html Cycles:180 Average:6037.09 Median:4745.29 stddev:3385.48 (71.3%) stddev-sans-first:3377.63 00:27:26 INFO - PROCESS | 19198 | Values: 1477.1 1518.5 1645.3 1787.9 1792.4 8595.2 9058.7 9095.1 9099.5 9103.2 8034.5 8280.1 8638.4 8864.8 8959.1 2454.7 2456.6 2476.1 2482.2 2483.4 2435.7 2524.4 2525.2 2528.0 2528.6 2428.5 2431.3 2483.9 2484.5 2488.0 2366.8 2374.1 2396.8 2400.5 2404.0 2397.1 2400.5 2419.8 2421.3 2449.6 9100.4 9140.3 9181.7 9205.2 9208.4 5486.1 5637.0 5641.2 5641.4 5643.9 3516.4 3547.2 3612.8 3775.1 3806.0 1139.2 1149.1 1169.6 1170.4 1200.0 12787.9 12882.4 12893.9 12895.9 12920.5 4729.9 4997.7 5001.0 5019.2 5090.1 10765.1 10767.9 10776.9 10776.9 10780.8 5552.7 5571.3 5575.2 5575.9 5577.4 4462.5 4760.7 5022.5 5077.0 5125.2 4133.7 4155.9 4249.8 4290.3 4290.5 1282.5 1331.6 1334.5 1343.9 1348.6 878.6 978.9 1008.4 1050.7 1063.3 5997.0 6085.5 6166.8 6273.0 6365.1 939.7 940.6 957.5 968.3 1050.6 4244.3 4414.3 4426.6 4439.9 4450.8 11079.6 11359.8 11426.6 11437.8 11466.8 10568.9 11364.4 11385.6 11390.8 11398.8 8272.3 8710.6 8712.3 8712.7 8713.8 6021.9 6155.0 6281.8 6385.1 6421.6 10168.2 10242.7 10252.5 10416.2 10416.4 10246.6 10397.8 10644.4 10793.7 10794.8 7534.3 7731.3 7736.7 8153.4 8319.0 8409.6 8471.6 8679.0 8686.5 8771.5 7316.6 7659.0 7694.8 8012.6 8021.5 7913.3 7953.5 7976.6 8008.2 8108.6 7527.6 7530.2 7539.9 7601.7 7633.8 5416.8 5460.1 5487.9 5530.8 5531.0 5423.1 5460.9 5525.9 5576.9 5621.7 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | [#4] prototype.html Cycles:180 Average:4686.45 Median:5361.49 stddev:1355.80 (25.3%) stddev-sans-first:1319.37 00:27:26 INFO - PROCESS | 19198 | Values: 318.6 325.6 338.9 342.0 346.2 5211.6 5321.9 5372.6 5383.2 5404.0 5179.0 5254.5 5266.3 5279.2 5296.8 4170.2 4170.5 4174.3 4195.7 4220.7 4130.9 4201.3 4209.9 4215.8 4226.8 4181.5 4184.5 4185.8 4189.9 4192.6 4172.6 4178.4 4179.2 4182.5 4183.4 3524.5 3618.5 3624.5 3625.2 3729.5 5118.5 5152.3 5191.0 5196.5 5233.6 4727.7 4739.9 4740.5 4748.2 4757.3 5406.3 5585.7 5597.9 5611.4 5619.1 3987.5 4005.7 4029.5 4032.9 4046.3 5778.9 5809.7 5825.7 5838.0 5840.7 4001.2 4160.2 4225.5 4241.0 4242.2 4263.7 4308.4 4311.1 4318.3 4341.8 4841.1 4842.2 4842.9 4855.8 4892.0 5436.3 5643.7 5643.9 5667.9 5703.5 1391.4 1397.3 1409.7 1451.5 1455.7 991.0 1021.3 1022.4 1034.3 1035.5 5361.7 5362.0 5373.7 5376.6 5377.7 5442.3 5469.0 5479.5 5519.0 5528.9 5137.8 5300.4 5352.2 5361.6 5362.4 2926.0 2932.2 2933.8 2945.2 2945.8 5738.0 5756.6 5796.4 5805.5 5805.9 5379.7 5570.5 5577.0 5596.9 5606.0 5743.7 5753.1 5753.9 5754.8 5769.7 5160.6 5421.9 5481.0 5517.2 5536.4 5385.9 5392.5 5393.5 5416.4 5434.8 5758.1 5783.7 5787.3 5828.9 5834.4 3908.6 4050.5 4058.3 4153.7 4172.9 5516.5 5664.4 5726.9 5754.6 5765.3 5532.3 5672.5 5683.5 5693.5 5699.5 5657.6 5666.6 5669.1 5675.5 5680.5 5361.4 5585.4 5602.8 5635.9 5650.9 5666.6 5686.8 5690.7 5701.7 5718.6 5368.2 5555.2 5565.9 5595.5 5622.3 00:27:26 INFO - PROCESS | 19198 | 00:27:26 INFO - PROCESS | 19198 | [#5] yui.html Cycles:180 Average:16990.99 Median:24635.11 stddev:21199.77 (86.1%) stddev-sans-first:21224.41 00:27:26 INFO - PROCESS | 19198 | Values: 808.2 810.9 839.2 842.0 876.7 13497.7 14151.5 14160.9 14173.1 14177.9 12403.0 13409.5 13461.5 14562.9 14724.0 815.1 816.0 816.1 820.1 823.3 847.5 848.7 850.2 851.0 851.2 893.8 894.5 895.9 897.3 897.3 892.9 893.2 893.7 894.0 894.9 649.5 652.6 654.5 654.6 654.8 14939.3 14992.9 15002.8 15006.2 15091.7 13769.7 14713.0 14738.7 15079.5 15124.4 12303.9 12387.4 12468.9 12540.4 13065.9 3793.1 3829.2 3860.2 3889.7 3927.9 44796.8 45794.8 61357.4 62866.4 67548.7 11541.8 11646.8 11664.9 11857.5 11861.3 20938.0 21096.9 21118.0 21272.4 21467.1 8554.8 8654.4 8680.5 8683.2 8931.8 4473.4 4514.8 4533.8 4581.8 4658.3 3552.6 3682.6 3683.8 3686.2 3690.5 624.7 628.1 628.6 631.9 641.5 705.4 706.2 769.5 791.3 798.8 9856.6 9969.0 10043.5 10055.6 10077.1 760.6 766.5 770.8 804.3 805.4 4780.4 5038.2 5044.6 5056.4 5083.1 73812.3 74561.6 74809.3 76220.2 93017.0 48127.5 61506.4 69342.3 76559.9 76603.0 65929.4 67660.3 69298.3 69448.3 70319.0 9836.5 9929.3 9993.3 10050.6 10232.7 30998.8 32042.2 41883.6 42837.0 45108.0 39686.6 54174.5 55187.7 62409.7 62985.0 12751.7 12819.7 13355.4 13391.8 13524.7 14581.7 14945.5 15006.3 15013.9 15115.6 13869.0 14189.1 14264.1 14325.4 14433.2 13177.8 13414.7 13535.5 14349.6 14821.8 12608.4 13200.1 13449.8 13486.2 14116.9 10564.9 10930.6 10934.5 11353.4 11595.5 11517.8 11813.8 12022.7 12029.8 12090.9 00:27:26 INFO - PROCESS | 19198 | -------- Summary: end -------- 00:27:26 INFO - PROCESS | 19198 | 00:27:27 INFO - TEST-INFO | 19198: exit 0 00:27:27 INFO - TEST-OK | dromaeo_css | took 1115501ms 00:27:27 INFO - TEST-START | kraken 00:27:27 INFO - operating with platform_type : linux_ 00:27:27 INFO - Initialising browser for kraken test... 00:27:27 INFO - TEST-INFO | started process 19506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkTGb5g/profile http://localhost:37494/getInfo.html) 00:27:31 INFO - PROCESS | 19506 | __metrics Screen width/height:1600/1200 00:27:31 INFO - PROCESS | 19506 | colorDepth:24 00:27:31 INFO - PROCESS | 19506 | Browser inner width/height: 1024/697 00:27:31 INFO - PROCESS | 19506 | __metrics 00:27:32 INFO - PROCESS | 19506 | 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" 00:27:32 INFO - PROCESS | 19506 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:27:33 INFO - PROCESS | 19506 | console.error: PushService: 00:27:33 INFO - PROCESS | 19506 | stateChangeProcessEnqueue: Error transitioning state 00:27:33 INFO - PROCESS | 19506 | UnknownError 00:27:33 INFO - TEST-INFO | 19506: exit 0 00:27:33 INFO - Browser initialized. 00:27:33 INFO - Running cycle 1/1 for kraken test... 00:27:33 INFO - TEST-INFO | started process 19597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkTGb5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:27:45 INFO - PROCESS | 19597 | RSS: Main: 143749120 00:27:45 INFO - PROCESS | 19597 | 00:27:47 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37494/tests/kraken/driver.html?testName=audio-beat-detection) 00:27:48 INFO - PROCESS | 19597 | RSS: Main: 183906304 00:27:48 INFO - PROCESS | 19597 | 00:27:51 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37494/tests/kraken/driver.html?testName=audio-dft) 00:27:51 INFO - PROCESS | 19597 | RSS: Main: 175452160 00:27:51 INFO - PROCESS | 19597 | 00:27:54 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37494/tests/kraken/driver.html?testName=audio-fft) 00:27:55 INFO - PROCESS | 19597 | RSS: Main: 266399744 00:27:55 INFO - PROCESS | 19597 | 00:27:57 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37494/tests/kraken/driver.html?testName=audio-oscillator) 00:27:57 INFO - PROCESS | 19597 | RSS: Main: 172613632 00:27:57 INFO - PROCESS | 19597 | 00:28:00 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:28:00 INFO - PROCESS | 19597 | RSS: Main: 174780416 00:28:00 INFO - PROCESS | 19597 | 00:28:03 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37494/tests/kraken/driver.html?testName=imaging-darkroom) 00:28:04 INFO - PROCESS | 19597 | RSS: Main: 212066304 00:28:04 INFO - PROCESS | 19597 | 00:28:07 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37494/tests/kraken/driver.html?testName=imaging-desaturate) 00:28:08 INFO - PROCESS | 19597 | RSS: Main: 212242432 00:28:08 INFO - PROCESS | 19597 | 00:28:10 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37494/tests/kraken/driver.html?testName=json-parse-financial) 00:28:11 INFO - PROCESS | 19597 | RSS: Main: 211619840 00:28:11 INFO - PROCESS | 19597 | 00:28:12 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:28:13 INFO - PROCESS | 19597 | RSS: Main: 173404160 00:28:13 INFO - PROCESS | 19597 | 00:28:15 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:28:15 INFO - PROCESS | 19597 | RSS: Main: 180789248 00:28:15 INFO - PROCESS | 19597 | 00:28:17 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:28:18 INFO - PROCESS | 19597 | RSS: Main: 188862464 00:28:18 INFO - PROCESS | 19597 | 00:28:20 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:28:21 INFO - PROCESS | 19597 | RSS: Main: 197828608 00:28:21 INFO - PROCESS | 19597 | 00:28:24 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:28:24 INFO - PROCESS | 19597 | RSS: Main: 194699264 00:28:24 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | Cycle 1(1): loaded http://localhost:37494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37494/tests/kraken/driver.html?testName=ai-astar) 00:28:26 INFO - PROCESS | 19597 | RSS: Main: 245063680 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | __start_tp_report 00:28:26 INFO - PROCESS | 19597 | _x_x_mozilla_page_load 00:28:26 INFO - PROCESS | 19597 | _x_x_mozilla_page_load_details 00:28:26 INFO - PROCESS | 19597 | |i|pagename|runs| 00:28:26 INFO - PROCESS | 19597 | |0;ai-astar;100;110;111;110;110;110;111;111;110;110 00:28:26 INFO - PROCESS | 19597 | |1;audio-beat-detection;147;119;118;158;124;119;118;117;147;124 00:28:26 INFO - PROCESS | 19597 | |2;audio-dft;161;159;160;161;160;159;161;161;160;161 00:28:26 INFO - PROCESS | 19597 | |3;audio-fft;74;75;75;117;75;75;75;74;95;75 00:28:26 INFO - PROCESS | 19597 | |4;audio-oscillator;81;81;117;82;82;81;110;82;81;107 00:28:26 INFO - PROCESS | 19597 | |5;imaging-gaussian-blur;117;117;117;116;121;117;117;116;117;116 00:28:26 INFO - PROCESS | 19597 | |6;imaging-darkroom;146;146;145;145;146;145;145;145;145;145 00:28:26 INFO - PROCESS | 19597 | |7;imaging-desaturate;85;84;84;85;84;84;84;84;84;84 00:28:26 INFO - PROCESS | 19597 | |8;json-parse-financial;51;50;49;49;50;57;50;49;49;49 00:28:26 INFO - PROCESS | 19597 | |9;json-stringify-tinderbox;57;60;58;59;60;59;60;58;59;59 00:28:26 INFO - PROCESS | 19597 | |10;stanford-crypto-aes;74;74;74;74;75;82;75;75;75;74 00:28:26 INFO - PROCESS | 19597 | |11;stanford-crypto-ccm;121;139;123;130;119;118;121;121;158;118 00:28:26 INFO - PROCESS | 19597 | |12;stanford-crypto-pbkdf2;156;159;153;153;155;152;152;152;151;156 00:28:26 INFO - PROCESS | 19597 | |13;stanford-crypto-sha256-iterative;66;66;64;63;61;67;60;61;61;60 00:28:26 INFO - PROCESS | 19597 | __end_tp_report 00:28:26 INFO - PROCESS | 19597 | __start_cc_report 00:28:26 INFO - PROCESS | 19597 | _x_x_mozilla_cycle_collect,1565 00:28:26 INFO - PROCESS | 19597 | __end_cc_report 00:28:26 INFO - PROCESS | 19597 | __startTimestamp1484555306564__endTimestamp 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | ------- Summary: start ------- 00:28:26 INFO - PROCESS | 19597 | Number of tests: 14 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.30 (3.0%) stddev-sans-first:0.50 00:28:26 INFO - PROCESS | 19597 | Values: 100.0 110.0 111.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:124.00 stddev:15.37 (12.4%) stddev-sans-first:14.87 00:28:26 INFO - PROCESS | 19597 | Values: 147.0 119.0 118.0 158.0 124.0 119.0 118.0 117.0 147.0 124.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 00:28:26 INFO - PROCESS | 19597 | Values: 161.0 159.0 160.0 161.0 160.0 159.0 161.0 161.0 160.0 161.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:14.17 (18.9%) stddev-sans-first:14.80 00:28:26 INFO - PROCESS | 19597 | Values: 74.0 75.0 75.0 117.0 75.0 75.0 75.0 74.0 95.0 75.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:14.65 (18.1%) stddev-sans-first:15.14 00:28:26 INFO - PROCESS | 19597 | Values: 81.0 81.0 117.0 82.0 82.0 81.0 110.0 82.0 81.0 107.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:1.45 (1.2%) stddev-sans-first:1.54 00:28:26 INFO - PROCESS | 19597 | Values: 117.0 117.0 117.0 116.0 121.0 117.0 117.0 116.0 117.0 116.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 00:28:26 INFO - PROCESS | 19597 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 00:28:26 INFO - PROCESS | 19597 | Values: 85.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:2.45 (4.9%) stddev-sans-first:2.59 00:28:26 INFO - PROCESS | 19597 | Values: 51.0 50.0 49.0 49.0 50.0 57.0 50.0 49.0 49.0 49.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.99 (1.7%) stddev-sans-first:0.78 00:28:26 INFO - PROCESS | 19597 | Values: 57.0 60.0 58.0 59.0 60.0 59.0 60.0 58.0 59.0 59.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.44 (3.3%) stddev-sans-first:2.55 00:28:26 INFO - PROCESS | 19597 | Values: 74.0 74.0 74.0 74.0 75.0 82.0 75.0 75.0 75.0 74.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:122.00 stddev:12.75 (10.5%) stddev-sans-first:13.35 00:28:26 INFO - PROCESS | 19597 | Values: 121.0 139.0 123.0 130.0 119.0 118.0 121.0 121.0 158.0 118.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:2.51 (1.6%) stddev-sans-first:2.55 00:28:26 INFO - PROCESS | 19597 | Values: 156.0 159.0 153.0 153.0 155.0 152.0 152.0 152.0 151.0 156.0 00:28:26 INFO - PROCESS | 19597 | 00:28:26 INFO - PROCESS | 19597 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:2.69 (4.2%) stddev-sans-first:2.60 00:28:26 INFO - PROCESS | 19597 | Values: 66.0 66.0 64.0 63.0 61.0 67.0 60.0 61.0 61.0 60.0 00:28:26 INFO - PROCESS | 19597 | -------- Summary: end -------- 00:28:26 INFO - PROCESS | 19597 | 00:28:27 INFO - TEST-INFO | 19597: exit 0 00:28:27 INFO - TEST-OK | kraken | took 60298ms 00:28:27 INFO - SUITE-END | took 1175s 00:28:27 INFO - Completed test suite (00:19:35) 00:28:27 INFO - javascript benchmark 00:28:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.165876872013, 3247.8213698246586, 3249.9512507312393, 3265.510173473977, 3291.2594666200107, 5544.16837474379, 5583.944160558393, 5591.580631452642, 5601.747921343539, 5602.4117467665865, 5532.640378375403, 5599.692016939067, 5622.353429355625, 5630.071038278689, 5635.887282254353, 5058.4435712071645, 5088.720120393377, 5100.0054989277105, 5130.07658621448, 5167.664101833388, 5034.09386310464, 5145.022445735298, 5193.221016847466, 5197.168453047513, 5199.792008319662, 5015.348004759376, 5030.270610761438, 5049.596032317424, 5105.5149760772665, 5106.974465127669, 5056.747162641872, 5082.2376643503585, 5104.3109180260935, 5149.536541711226, 5170.37955445349, 4972.651914365996, 5044.848654540369, 5091.312672789163, 5113.51421614946, 5115.795368185268, 5386.946130538684, 5417.024935511607, 5446.291982042309, 5481.095619222823, 5487.314085739283, 5820.592558520905, 5832.0, 5840.065589505702, 5949.732262048218, 5953.3748956359395, 5966.164736936832, 5974.014287642533, 5982.252218472691, 5983.371745966698, 5994.790182343597, 5447.291852059247, 5481.040817856859, 5515.090010148361, 5541.944580554224, 5544.500994910478, 6014.939850601526, 6037.305709843336, 6048.425399587032, 6050.606710563799, 6073.18012068374, 5831.271091113611, 5848.0350742127075, 5849.473547380671, 5852.092925596539, 5854.2974843018255, 5787.189793428924, 5846.7076646167525, 5851.0, 5893.292804863444, 5900.055991041413, 5907.940920590825, 5913.379095195029, 5915.852103697442, 5941.584089113807, 5950.315713692894, 5871.060630299217, 5915.792947246911, 5928.288605367384, 5929.792457263975, 5932.733027013708, 4544.681872268976, 4585.28928016158, 4618.676692631483, 4633.559811817872, 4658.0, 4143.3370660694145, 4176.2900306947895, 4180.91638167241, 4213.431186789744, 4219.219444402734, 5840.386759390203, 5845.269341332333, 5851.502622277069, 5852.502537284294, 5855.3266374367495, 5831.94168058314, 5898.3216930053595, 5916.674582897982, 6022.277326720821, 6033.12519684652, 5733.283339582552, 5802.738876750556, 5811.27359080115, 5831.475167234969, 5835.67903765297, 5176.145935920531, 5185.714785686748, 5188.11801993662, 5190.091733946544, 5211.557017653466, 6145.262568491809, 6204.224471941007, 6234.906476402857, 6291.5281353898645, 6302.65335406557, 5816.796412125725, 5836.766529338779, 5877.382874798255, 5910.113482977587, 5928.081147422156, 6217.96891015542, 6219.160413344141, 6223.315435302204, 6225.533085018551, 6236.688165591611, 5713.200151978644, 5793.044147715748, 5800.1589769484035, 5800.4489573490455, 5805.013147764975, 5786.623869448473, 5933.317668468181, 5967.0, 5971.671558064174, 6052.939470605237, 5818.7090645466715, 5860.560457965755, 5870.970645146747, 5872.119182122716, 5873.148393482836, 5863.325717542367, 5879.529637628894, 5880.353161152356, 5883.0, 5885.293764748258, 5604.887902242014, 5614.5789065821045, 5750.022496175744, 5788.044972579477, 5789.0, 5894.852628684317, 5901.822945311647, 5917.0, 5917.082852157922, 5918.378570250062, 5579.860503487445, 5624.100143976944, 5763.510101641407, 5770.711464426678, 5775.133729940542], "value": 5506.836963518403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.3083607163189, 598.4733434577571, 615.7260019291414, 644.3363335764161, 649.3668673043786, 35489.0, 37654.24691506168, 37668.62331376685, 45339.31991020129, 45732.31401528972, 46653.76673116638, 47086.293705594355, 47115.764421177846, 47191.764041179835, 47210.0, 8879.644814207424, 9019.503927283997, 9026.277897768163, 9027.999999999967, 9039.276857851357, 8377.95811020947, 8595.570221488932, 10536.578536858517, 10829.187810914213, 10838.187135964794, 10865.782684346308, 10877.347359158475, 10880.401577913251, 10885.18361122915, 10898.727531811728, 8391.202835730595, 10843.132549396068, 10887.727806804814, 10901.618443354524, 10903.618373356974, 8353.164683531599, 10265.846012309821, 10623.25637205396, 10665.306755060896, 10903.127749779998, 43716.562834371885, 44026.11947761059, 44055.77972110151, 44094.0, 44138.0, 3671.210689701727, 3831.0, 4022.8189731462153, 4063.6545893599077, 4325.6106950374615, 32980.50529242063, 33084.834575827204, 33159.668403315896, 33178.50232246518, 33330.83334583336, 4441.311596702516, 4502.842400515966, 4503.049250237327, 4506.954930450719, 4543.727376357429, 314238.99999999773, 314322.0, 314494.0, 314707.0, 314745.0, 39195.608043919194, 62762.372376276566, 63145.368546314865, 63146.0, 63235.0, 38183.23633527314, 40756.0, 40938.38592421116, 40977.0, 40986.590134098275, 14521.34653940554, 14554.636134096521, 14558.41766329335, 14573.344199511048, 14592.270386480846, 12016.879831201752, 12261.325627090417, 12672.80990785139, 12781.744365112645, 12800.551980680817, 9127.497987610745, 9130.360874738837, 9299.442033478013, 9410.717678469657, 9665.323427360157, 3534.4344904815107, 3541.256336169382, 3558.9110272242883, 3583.390823559949, 3611.1874828163454, 986.4673076538588, 1055.171690223171, 1068.4978060311641, 1077.8706555213425, 1088.6026600290836, 34529.82735086309, 34729.65270347315, 34880.47679284813, 34959.475607865905, 35138.64861351405, 1108.8724796648328, 1124.173732306754, 1127.199688221372, 1141.9657410277705, 1167.6788883057056, 18288.542786430447, 18328.81671183271, 18479.168437420347, 18596.163172657263, 18601.0, 540332.0, 540875.0, 548344.0, 549259.0, 549447.0, 65329.67335163294, 65546.0, 65753.0, 65845.0, 65983.67008165024, 1200.0939290835363, 1332.0875200487696, 1361.3261435589448, 1409.5912185466304, 1429.306786208688, 33234.16914577155, 35668.0, 35731.285374292886, 37474.625253747115, 37880.62119378771, 59730.70134649299, 60437.39562604317, 60755.69622151861, 60828.391716082275, 60883.69558152181, 432961.0, 435610.0, 435612.93161205214, 437834.0, 438080.0, 27925.44149117047, 28032.29919252035, 31827.840860795546, 31945.881894133592, 32165.35669286648, 47074.52925470839, 49096.75451622719, 53849.0, 53957.19064213961, 54335.0, 42712.14575708531, 44468.33297500605, 44808.0, 44960.550394496946, 45490.545094549954, 42998.785006074766, 44030.339544907496, 44768.55231447774, 45122.77438612786, 45867.54132458766, 43986.56013439825, 45398.77300613476, 45984.31023534583, 46193.76903115463, 46200.7689961548, 36993.445098323005, 38936.610633893295, 39413.605863941, 39978.60021399749, 40165.397519036655, 29740.256493587833, 30086.796528138628, 30211.848940756034, 30423.0, 30467.542986855657], "value": 20100.95695051718, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.09692561719635, 390.69916164553297, 409.6067774936061, 414.89420197849546, 421.36163711976343, 14133.646658833535, 18540.351087711933, 19584.41246762596, 20201.696974545375, 20223.0, 17427.825721742778, 17521.474355769315, 18990.0, 19430.417087487363, 19492.707609385834, 5348.438413966526, 5364.1149210380245, 5492.5605951523985, 5524.972375138119, 5537.556995440375, 5461.098918678414, 5548.9722551387185, 5549.112142057272, 5549.694766787825, 5552.833414997536, 4189.811458484375, 5630.690312032836, 6172.043333283325, 6233.688315584202, 6285.842853928642, 5923.881522369572, 6139.1712118863825, 6278.968605156968, 6279.309275979662, 6279.968600157015, 5406.756695948652, 5414.3232095988005, 5417.349918009824, 5420.376656684492, 5422.240886275925, 23286.41783955398, 23301.41746456335, 23334.18330358446, 23523.76476235233, 23923.40191495209, 2292.4154340643195, 2449.6570480132796, 2565.8717064146904, 2591.9870400647874, 3003.294225856922, 13481.528146514924, 14589.92705036468, 15059.397624095023, 15112.622184445367, 15211.315490802941, 1929.7684277886744, 1935.632229876333, 2004.8195662390456, 2055.4142069510117, 2086.5618220173783, 75133.24866751372, 79180.60409697972, 83021.0, 85571.0, 87555.0, 11356.318620882774, 11467.77064458706, 11527.365994870195, 11656.242344247597, 11729.237599556001, 14078.436862525385, 14595.051321664057, 16549.669006620043, 16636.168191590372, 16641.167941603115, 8235.258826705625, 8510.638297872434, 8687.609057592423, 8752.956235218782, 8915.866262006075, 8456.238938495564, 8477.491350518989, 8507.744767656981, 8662.393632445668, 8680.609372578248, 4996.200607902718, 5045.344105266292, 5064.265681476165, 5073.898522029539, 5106.208537676666, 1980.0200697949494, 1983.5041239690077, 2101.3905967269625, 2101.506146055676, 2137.7541582718186, 867.2758246863813, 991.4101109839634, 1006.6325791086201, 1031.3657100883054, 1073.5061871539024, 19370.32203872886, 19482.318118865773, 19580.412587622108, 19626.50933726668, 19824.107915143853, 1014.771676372825, 1018.3737001743874, 1032.4166845732138, 1037.061459379263, 1089.6077412131626, 10358.482075896174, 10711.410872401937, 10741.946290268656, 10844.566217351376, 10894.891051089387, 475761.0, 482710.0, 510568.0, 515667.0, 517434.0, 92674.53662731643, 92807.53596231976, 92822.0, 93084.0, 95234.52382738041, 1009.2329829329763, 1025.610268098118, 1053.7365658585354, 1054.6361505280665, 1055.261317078033, 16680.416185433452, 16972.915135424242, 17130.914345428693, 17212.88116272438, 17214.13929303505, 35982.0, 43377.3493397593, 43711.0, 43777.34333984929, 44234.77882610695, 56074.0, 56881.431185687616, 57503.137452939074, 57543.424565753805, 58211.4178858206, 7900.486468379537, 8187.549684767395, 8226.341892648694, 8247.0, 8749.868751968854, 9413.640617804329, 11956.76086478283, 12605.495780169058, 12754.744905102032, 12960.935195323964, 11679.416029198675, 11807.291562506278, 11855.822162667739, 11980.760384792082, 12413.565525206574, 11381.146414018816, 11526.481308341312, 11540.884591153981, 11597.304161750322, 11806.173567850168, 6198.659073750987, 9261.564457509097, 11647.475863585989, 12331.383430828602, 12397.690057748629, 8946.821063578822, 8984.32617553673, 8995.100489950952, 9015.14356136166, 9054.185123338932, 10883.564657413932, 11336.6032188873, 11575.421228938689, 11703.414829258674, 11798.52805887755], "value": 9390.549343701523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.0842077911693, 1518.4913054126869, 1645.3089702325021, 1787.9195436205368, 1792.399546152039, 8595.183457571537, 9058.682946096887, 9095.1359620836, 9099.45403275804, 9103.226225770817, 8034.517928924269, 8280.089190189074, 8638.438501497414, 8864.778380540474, 8959.104089591037, 2454.680891484109, 2456.5701002324613, 2476.1333533263305, 2482.1684735613503, 2483.4412257242157, 2435.7320694723567, 2524.432002799374, 2525.2424272718204, 2528.0, 2528.5954247320433, 2428.490017096412, 2431.294924471901, 2483.900643974239, 2484.5155194737035, 2487.962680559793, 2366.7751563601432, 2374.050379848057, 2396.760323967607, 2400.4838959623767, 2404.038384646138, 2397.095272864539, 2400.4958958618713, 2419.830611857171, 2421.2857207123766, 2449.6203088521306, 9100.408473449272, 9140.268778497772, 9181.67864124759, 9205.217556507705, 9208.355415120945, 5486.149646804752, 5637.0, 5641.182028605829, 5641.379448260688, 5643.915341269884, 3516.4373700207843, 3547.219611685425, 3612.837422315976, 3775.1497619297256, 3806.0, 1139.1968662093204, 1149.0979581028935, 1169.561414469574, 1170.3738499902597, 1200.0339726520149, 12787.872121278855, 12882.420291086924, 12893.904018158468, 12895.935520322431, 12920.54778082772, 4729.881752956204, 4997.650164488524, 5000.974995125001, 5019.196928491424, 5090.08378491875, 10765.13878889687, 10767.89232107669, 10776.892231077745, 10776.892231077745, 10780.838287425695, 5552.666839989613, 5571.331440227199, 5575.219469274305, 5575.888482230333, 5577.44225577439, 4462.531434199363, 4760.690555113906, 5022.547970682656, 5077.009983053269, 5125.15434953236, 4133.739811117156, 4155.916881662411, 4249.80875860587, 4290.2706539888295, 4290.549492303326, 1282.4549566434227, 1331.593863871509, 1334.5129027904745, 1343.9193648381129, 1348.5886804524714, 878.5826732302105, 978.9363691360039, 1008.4050410257983, 1050.7478205230689, 1063.3194755356578, 5996.970015149896, 6085.5435842312, 6166.784162554379, 6272.968635156795, 6365.14070600463, 939.6852054561662, 940.5579377692474, 957.5260246178048, 968.3173362779223, 1050.5955207245265, 4244.342126970325, 4414.271645178574, 4426.557344265612, 4439.911201775946, 4450.777461126995, 11079.612213572647, 11359.829602555968, 11426.600068997544, 11437.771244575062, 11466.827997580043, 10568.894311056945, 11364.374959377148, 11385.601503947322, 11390.829137562943, 11398.772024559628, 8272.255497005179, 8710.564471776386, 8712.346574006848, 8712.695055673148, 8713.782155446037, 6021.909671355021, 6154.969225153845, 6281.842953926189, 6385.13800636908, 6421.646809425526, 10168.186545076524, 10242.743931401477, 10252.487375631337, 10416.1667066636, 10416.375017498975, 10246.590136394461, 10397.844032339672, 10644.41455719912, 10793.67618971432, 10794.784104317712, 7534.284242996907, 7731.342835859015, 7736.651850666846, 8153.388495862952, 8319.0, 8409.579521024047, 8471.57642117904, 8678.956605216934, 8686.522241276538, 8771.517566533646, 7316.634168291458, 7659.0, 7694.846103077795, 8012.599370031592, 8021.478603890729, 7913.327367173854, 7953.5227886327, 7976.6410511525955, 8008.199180081945, 8108.594570271581, 7527.623618818928, 7530.209328020479, 7539.9246007541415, 7601.695932162652, 7633.809154770953, 5416.783328666809, 5460.071787796005, 5487.9298536784945, 5530.834074977757, 5530.972345138249, 5423.078076727044, 5460.863478413072, 5525.889482210414, 5576.86057848557, 5621.747021383966], "value": 4850.4813399152745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.5778843032981, 325.64016761478564, 338.8932486266824, 341.98771635957564, 346.1968233697819, 5211.635185537014, 5321.92017119743, 5372.57019438445, 5383.192521121834, 5403.999999999995, 5179.0, 5254.479498735846, 5266.3153790007345, 5279.234510995903, 5296.761645725942, 4170.249355116078, 4170.52039015514, 4174.31123864562, 4195.66434685226, 4220.704550681454, 4130.917381652365, 4201.348790937394, 4209.85265515707, 4215.810288537024, 4226.830926762926, 4181.477315335583, 4184.476940382452, 4185.79071046448, 4189.916201675965, 4192.5597812229735, 4172.603602657758, 4178.415021896937, 4179.205950869356, 4182.498100227962, 4183.368486290349, 3524.488949102366, 3618.475321078455, 3624.4563315502623, 3625.1843335249623, 3729.5151630287887, 5118.539331460149, 5152.252923326134, 5190.974045129788, 5196.53231209193, 5233.581313494911, 4727.692699974525, 4739.928901066487, 4740.502247264057, 4748.240281554969, 4757.310190022427, 5406.297016439808, 5585.74864131111, 5597.916031259534, 5611.382747897728, 5619.129034999582, 3987.461692671481, 4005.73962692427, 4029.4560234368278, 4032.9395059074136, 4046.271671099201, 5778.855528611776, 5809.651420914759, 5825.718341964761, 5838.0, 5840.678762668052, 4001.2197621464115, 4160.209560183555, 4225.471816022997, 4241.0, 4242.151569686075, 4263.744175349489, 4308.353746937984, 4311.116221174714, 4318.287482565342, 4341.848035318749, 4841.104395686809, 4842.22524396102, 4842.903141937141, 4855.781489832966, 4891.951080489221, 5436.320459942507, 5643.746031428595, 5643.887122257532, 5667.858303542362, 5703.458171473703, 1391.4364682303683, 1397.3013493253372, 1409.7251036047871, 1451.4557041109583, 1455.657920388708, 990.9950450247702, 1021.274894824668, 1022.3967858963248, 1034.2915103154212, 1035.4874337203132, 5361.678299302054, 5361.954418888357, 5373.704446255493, 5376.569874410038, 5377.704226267515, 5442.265294185314, 5469.019384435493, 5479.479449452296, 5519.0, 5528.917066244009, 5137.794488220504, 5300.44345343741, 5352.19717042439, 5361.571074314045, 5362.383325917569, 2926.0, 2932.222960915359, 2933.8386388748395, 2945.175350901751, 2945.8495298432263, 5738.0, 5756.625819321731, 5796.420357964254, 5805.506531944748, 5805.912911306334, 5379.65032272901, 5570.526505247019, 5576.9845711087955, 5596.888062238814, 5605.971970140124, 5743.741531631086, 5753.087900227802, 5753.921651916205, 5754.7985820496915, 5769.74036168365, 5160.612954028538, 5421.945780542144, 5480.972595136999, 5517.15175416224, 5536.446355364431, 5385.946140538545, 5392.51467367923, 5393.460653934575, 5416.350037995466, 5434.83695489136, 5758.1362795581, 5783.7397317119985, 5787.305523337226, 5828.912566311424, 5834.358220595816, 3908.5895980921596, 4050.4936882889638, 4058.330375488011, 4153.7300075494995, 4172.895677608084, 5516.475934786189, 5664.433556644302, 5726.885462290647, 5754.625949313281, 5765.336986246468, 5532.336119665666, 5672.546196304368, 5683.460071293221, 5693.5160511357, 5699.458551437607, 5657.60396772222, 5666.603337766317, 5669.092945128759, 5675.489205971482, 5680.488756011979, 5361.410244872983, 5585.385607583082, 5602.803901863415, 5635.8591035224445, 5650.943490565041, 5666.603337766317, 5686.800961966477, 5690.658560486384, 5701.714914254354, 5718.599698021098, 5368.2484452177505, 5555.166724991283, 5565.860853478695, 5595.468430499096, 5622.269105016322], "value": 4257.739691901911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.1877712898532, 810.9351251899849, 839.1901814748768, 841.9747407577775, 876.6843936182975, 13497.662558436044, 14151.504697335595, 14160.858391416083, 14173.149611023333, 14177.858221417782, 12403.0, 13409.46362145513, 13461.461541538327, 14562.854371456282, 14724.0, 815.0708192660343, 815.9836803263931, 816.0859836982588, 820.1347578304886, 823.2508417340237, 847.4872702015284, 848.749618862434, 850.2347886901777, 850.9829803403928, 851.1573542193246, 893.7988952485704, 894.4767311123001, 895.8611415230617, 897.2776914583758, 897.3225214962727, 892.9330300227476, 893.2139717048956, 893.714011516315, 894.0344428017726, 894.8791913091746, 649.525846132326, 652.5725649699407, 654.4862283107785, 654.5712558274338, 654.7642848574557, 14939.327730252056, 14992.850071499255, 15002.774958375632, 15006.174660393674, 15091.698166036618, 13769.655758606115, 14713.0, 14738.705225895423, 15079.54761357161, 15124.395024199019, 12303.93848030754, 12387.380630968415, 12468.875311246862, 12540.435680394405, 13065.869341306561, 3793.108619474449, 3829.1941331983976, 3860.208657225262, 3889.669378102865, 3927.9214415711526, 44796.776016120035, 45794.77102614499, 61357.386426135614, 62866.37133628697, 67548.6622566889, 11541.826872596917, 11646.767064658829, 11664.88335116638, 11857.525698972117, 11861.288322700666, 20938.0, 21096.894515527325, 21118.0, 21272.36182914515, 21467.141314347562, 8554.786130346667, 8654.350923680624, 8680.479171249744, 8683.175098365646, 8931.776705582412, 4473.4408198975125, 4514.819407223675, 4533.84131555394, 4581.839635612738, 4658.277966915133, 3552.6447355264268, 3682.558093028854, 3683.797391143459, 3686.170611612419, 3690.538682664667, 624.7282432141942, 628.0547775597696, 628.613402757301, 631.8862604731193, 641.4900154377282, 705.4215543254483, 706.156143408632, 769.4882902869641, 791.3431851563189, 798.8477586232484, 9856.556454959544, 9968.950155249177, 10043.548040338203, 10055.648052318134, 10077.093061624342, 760.5550752809557, 766.4749646492171, 770.7572114783825, 804.3364224514798, 805.3838813307824, 4780.354652121989, 5038.193888977746, 5044.596432285482, 5056.393232812086, 5083.110455670243, 73812.2618773816, 74561.62719186369, 74809.25190748132, 76220.23779762242, 93017.0, 48127.518724812304, 61506.384936150964, 69342.30657693358, 76559.85160222602, 76603.0, 65929.35176620622, 67660.32339676541, 69298.3070169302, 69448.30551694418, 70319.0, 9836.45899475507, 9929.304948653526, 9993.250506212209, 10050.64822731201, 10232.693019209435, 30998.845005774827, 32042.19894502656, 41883.58116418797, 42837.0, 45108.0, 39686.603133969445, 54174.45825541852, 55187.724061379435, 62409.68795155995, 62985.0, 12751.71123845915, 12819.743605127658, 13355.399007044512, 13391.799123012968, 13524.729505410034, 14581.708365832836, 14945.476908308157, 15006.324715388053, 15013.924930375279, 15115.622109447351, 13869.0, 14189.148651080555, 14264.144151350953, 14325.426982920566, 14433.20617366055, 13177.802332965204, 13414.664633384244, 13535.458581656623, 14349.64125896861, 14821.777673335124, 12608.369581520703, 13200.14199077057, 13449.798253026016, 13486.190828550318, 14116.858831411555, 10564.894351056391, 10930.617428389969, 10934.45327733626, 11353.37556434404, 11595.478203480694, 11517.769644606893, 11813.822792657946, 12022.699432513908, 12029.819552706891, 12090.939545302217], "value": 7304.620680922411, "unit": "score"}], "name": "dromaeo_css", "value": 7343.488242298831, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 118.0, 158.0, 124.0, 119.0, 118.0, 117.0, 147.0, 124.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 160.0, 159.0, 161.0, 161.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 117.0, 75.0, 75.0, 75.0, 74.0, 95.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 117.0, 82.0, 82.0, 81.0, 110.0, 82.0, 81.0, 107.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 121.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 49.0, 50.0, 57.0, 50.0, 49.0, 49.0, 49.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 58.0, 59.0, 60.0, 59.0, 60.0, 58.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 75.0, 82.0, 75.0, 75.0, 75.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 139.0, 123.0, 130.0, 119.0, 118.0, 121.0, 121.0, 158.0, 118.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 153.0, 153.0, 155.0, 152.0, 152.0, 152.0, 151.0, 156.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 63.0, 61.0, 67.0, 60.0, 61.0, 61.0, 60.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1444.7000000000003, "alertThreshold": 2.0}]} 00:28:27 INFO - Return code: 0 00:28:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:28:27 INFO - # TBPL SUCCESS # 00:28:27 INFO - Running post-action listener: _resource_record_post_action 00:28:27 INFO - [mozharness: 2017-01-16 08:28:27.878995Z] Finished run-tests step (success) 00:28:27 INFO - Running post-run listener: _resource_record_post_run 00:28:27 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 353296384; Read time: 0; Write time: 684436 00:28:27 INFO - TinderboxPrint: CPU usage
13.0% 00:28:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:28:27 INFO - TinderboxPrint: I/O write bytes / time
353,296,384 / 684,436 00:28:27 INFO - TinderboxPrint: CPU idle
8,273.5 (87.0%) 00:28:27 INFO - TinderboxPrint: CPU user
1,190.1 (12.5%) 00:28:27 INFO - TinderboxPrint: Swap in / out
0 / 0 00:28:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 108371968; Read time: 0; Write time: 328344 00:28:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 244924416; Read time: 0; Write time: 356092 00:28:28 INFO - Running post-run listener: _upload_blobber_files 00:28:28 INFO - Blob upload gear active. 00:28:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:28:28 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 00:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:28:28 INFO - (blobuploader) - INFO - Open directory for files ... 00:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:28:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:29 INFO - (blobuploader) - INFO - Done attempting. 00:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:34 INFO - (blobuploader) - INFO - Done attempting. 00:28:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:28:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:35 INFO - (blobuploader) - INFO - Done attempting. 00:28:35 INFO - (blobuploader) - INFO - Iteration through files over. 00:28:35 INFO - Return code: 0 00:28:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:28:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:28:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e37da066a0a822c76511c26e74c4fcf98e9d2daa767da4eb552233ea21d1869aeb6dbf95a9148d257f56d8538ffc4b4f0bb3cd54c94d55e2a322308ebe791020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/441a085e20bcfb79d707d3c12d689330ed3c426be2fc8cc665162c45d039912146625da089e339c7dc49028582a01fa3777d6572ac8de8c1db1aed598a66139f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac297ff4298b7a8749e9e882d18bb7576a260d79570d7b6a92651f7a66bc3a9d127f99985dc3ff5f6106fcddf24cf5b6d10dfe07ea626fb0f4a1b3ff3d731f7b"} 00:28:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:28:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:28:35 INFO - Contents: 00:28:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e37da066a0a822c76511c26e74c4fcf98e9d2daa767da4eb552233ea21d1869aeb6dbf95a9148d257f56d8538ffc4b4f0bb3cd54c94d55e2a322308ebe791020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/441a085e20bcfb79d707d3c12d689330ed3c426be2fc8cc665162c45d039912146625da089e339c7dc49028582a01fa3777d6572ac8de8c1db1aed598a66139f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac297ff4298b7a8749e9e882d18bb7576a260d79570d7b6a92651f7a66bc3a9d127f99985dc3ff5f6106fcddf24cf5b6d10dfe07ea626fb0f4a1b3ff3d731f7b"} 00:28:35 INFO - Running post-run listener: copy_logs_to_upload_dir 00:28:35 INFO - Copying logs to upload dir... 00:28:35 INFO - mkdir: /builds/slave/test/build/upload/logs 00:28:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.059422 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-01-16 00:28:34.672468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 00:28:34.675581) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e37da066a0a822c76511c26e74c4fcf98e9d2daa767da4eb552233ea21d1869aeb6dbf95a9148d257f56d8538ffc4b4f0bb3cd54c94d55e2a322308ebe791020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/441a085e20bcfb79d707d3c12d689330ed3c426be2fc8cc665162c45d039912146625da089e339c7dc49028582a01fa3777d6572ac8de8c1db1aed598a66139f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac297ff4298b7a8749e9e882d18bb7576a260d79570d7b6a92651f7a66bc3a9d127f99985dc3ff5f6106fcddf24cf5b6d10dfe07ea626fb0f4a1b3ff3d731f7b"} build_url:https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011900 build_url: 'https://queue.taskcluster.net/v1/task/CTW7VuTcT6aKaZLW974mBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e37da066a0a822c76511c26e74c4fcf98e9d2daa767da4eb552233ea21d1869aeb6dbf95a9148d257f56d8538ffc4b4f0bb3cd54c94d55e2a322308ebe791020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/441a085e20bcfb79d707d3c12d689330ed3c426be2fc8cc665162c45d039912146625da089e339c7dc49028582a01fa3777d6572ac8de8c1db1aed598a66139f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac297ff4298b7a8749e9e882d18bb7576a260d79570d7b6a92651f7a66bc3a9d127f99985dc3ff5f6106fcddf24cf5b6d10dfe07ea626fb0f4a1b3ff3d731f7b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 00:28:34.700816) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 00:28:34.701103) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1484552348.165618-363783121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 00:28:34.786567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 00:28:34.786874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 00:28:34.789268) ========= ========= Total master_lag: 0.18 =========