builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1475766250.93 results: success (0) buildid: 20161006063300 builduid: eba5753a1ecc437e99ce5430e2efba02 revision: 8282815e55598b0099a613758d19b232b75b3d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:10.926140) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:10.927328) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:10.928109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:10.968341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:10.968987) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 08:04:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2016-10-06 08:04:11 (18.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:11.072618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:11.073001) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016768 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:11.139703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 08:04:11.140267) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8282815e55598b0099a613758d19b232b75b3d74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8282815e55598b0099a613758d19b232b75b3d74 --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=9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 08:04:11,854 truncating revision to first 12 chars 2016-10-06 08:04:11,854 Setting DEBUG logging. 2016-10-06 08:04:11,854 attempt 1/10 2016-10-06 08:04:11,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8282815e5559?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 08:04:12,936 unpacking tar archive at: autoland-8282815e5559/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 08:04:12.553594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:12.553939) ========= script_repo_revision: 8282815e55598b0099a613758d19b232b75b3d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:12.554380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:12.554693) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 08:04:12.562989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-06 08:04:12.563290) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:13 INFO - MultiFileLogger online at 20161006 08:04:13 in /builds/slave/test 08:04:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:04:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:13 INFO - {'append_to_log': False, 08:04:13 INFO - 'base_work_dir': '/builds/slave/test', 08:04:13 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:04:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:13 INFO - 'branch': 'Autoland-Non-PGO', 08:04:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:13 INFO - 'config_files': ('talos/linux_config.py',), 08:04:13 INFO - 'default_actions': ('clobber', 08:04:13 INFO - 'read-buildbot-config', 08:04:13 INFO - 'download-and-extract', 08:04:13 INFO - 'populate-webroot', 08:04:13 INFO - 'create-virtualenv', 08:04:13 INFO - 'install', 08:04:13 INFO - 'run-tests'), 08:04:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:13 INFO - 'download_minidump_stackwalk': True, 08:04:13 INFO - 'download_symbols': 'ondemand', 08:04:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:13 INFO - 'installer_path': 'installer.exe', 08:04:13 INFO - 'log_level': 'info', 08:04:13 INFO - 'log_name': 'talos', 08:04:13 INFO - 'log_to_console': True, 08:04:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:13 INFO - 'opt_config_files': (), 08:04:13 INFO - 'pip_index': False, 08:04:13 INFO - 'sps_profile': False, 08:04:13 INFO - 'sps_profile_interval': 0, 08:04:13 INFO - 'suite': 'dromaeojs', 08:04:13 INFO - 'system_bits': '32', 08:04:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:13 INFO - 'title': 'talos-linux64-ix-022', 08:04:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:13 INFO - 'use_talos_json': True, 08:04:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:13 INFO - 'work_dir': 'build'} 08:04:13 INFO - [mozharness: 2016-10-06 15:04:13.377424Z] Running clobber step. 08:04:13 INFO - Running pre-action listener: _resource_record_pre_action 08:04:13 INFO - Running main action method: clobber 08:04:13 INFO - rmtree: /builds/slave/test/build 08:04:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:14 INFO - Running post-action listener: _resource_record_post_action 08:04:14 INFO - [mozharness: 2016-10-06 15:04:14.363682Z] Finished clobber step (success) 08:04:14 INFO - [mozharness: 2016-10-06 15:04:14.363781Z] Running read-buildbot-config step. 08:04:14 INFO - Running pre-action listener: _resource_record_pre_action 08:04:14 INFO - Running main action method: read_buildbot_config 08:04:14 INFO - Using buildbot properties: 08:04:14 INFO - { 08:04:14 INFO - "project": "", 08:04:14 INFO - "product": "firefox", 08:04:14 INFO - "script_repo_revision": "production", 08:04:14 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:04:14 INFO - "repository": "", 08:04:14 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:04:14 INFO - "buildid": "20161006063300", 08:04:14 INFO - "pgo_build": "False", 08:04:14 INFO - "basedir": "/builds/slave/test", 08:04:14 INFO - "buildnumber": 804, 08:04:14 INFO - "slavename": "talos-linux64-ix-022", 08:04:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:04:14 INFO - "platform": "ubuntu64_hw", 08:04:14 INFO - "scheduler": "tests-autoland-linux64-talos", 08:04:14 INFO - "branch": "autoland", 08:04:14 INFO - "repo_path": "integration/autoland", 08:04:14 INFO - "revision": "8282815e55598b0099a613758d19b232b75b3d74", 08:04:14 INFO - "stage_platform": "linux64", 08:04:14 INFO - "builduid": "eba5753a1ecc437e99ce5430e2efba02", 08:04:14 INFO - "slavebuilddir": "test" 08:04:14 INFO - } 08:04:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:04:14 INFO - Running post-action listener: _resource_record_post_action 08:04:14 INFO - [mozharness: 2016-10-06 15:04:14.366197Z] Finished read-buildbot-config step (success) 08:04:14 INFO - [mozharness: 2016-10-06 15:04:14.366286Z] Running download-and-extract step. 08:04:14 INFO - Running pre-action listener: _resource_record_pre_action 08:04:14 INFO - Running main action method: download_and_extract 08:04:14 INFO - mkdir: /builds/slave/test/build/tests 08:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:14 INFO - trying https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:04:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:04:14 INFO - Downloaded 1361 bytes. 08:04:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:04:14 INFO - Using the following test package requirements: 08:04:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:04:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'jsshell-linux-x86_64.zip'], 08:04:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:04:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:04:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:04:15 INFO - Http code: 200 08:04:15 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 08:04:15 INFO - x-amz-cf-id: nZ_N1GqAP5kJpG0HxEUeUxIu5g_q_5yPOmMUm2C-D-oJuhSU2AyEgA== 08:04:15 INFO - x-amz-version-id: gSkxu5lhy37f1A20Hi60uVwjACzaXekd 08:04:15 INFO - Expected file size: 20445928 08:04:15 INFO - Obtained file size: 20445928 08:04:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:04:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:04:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:04:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:04:20 INFO - Http code: 200 08:04:20 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 08:04:20 INFO - x-amz-cf-id: sIMeyLkiRU95D8Yka0JuWAjJgBmLs7q9MZXXFgNhpwhVB8evv7JdpQ== 08:04:20 INFO - x-amz-version-id: gSkxu5lhy37f1A20Hi60uVwjACzaXekd 08:04:21 INFO - Expected file size: 20445928 08:04:21 INFO - Obtained file size: 20445928 08:04:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:04:25 INFO - Fetch https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:04:25 INFO - Http code: 200 08:04:25 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:04:25 INFO - x-amz-cf-id: UCniOXGQAnsmNXTm6W45riGFmZOJFhUVTrm7jXCMnweHPkm4-j8Xbg== 08:04:25 INFO - x-amz-version-id: nnxXuVac3E3LyZp2DMog.oly.xy.dpiN 08:04:26 INFO - Expected file size: 14409006 08:04:26 INFO - Obtained file size: 14409006 08:04:26 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')]} 08:04:26 INFO - trying https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:04:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:04:29 INFO - Downloaded 55811271 bytes. 08:04:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:04:29 INFO - mkdir: /builds/slave/test/properties 08:04:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:29 INFO - Contents: 08:04:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:04:29 INFO - Running post-action listener: _resource_record_post_action 08:04:29 INFO - Running post-action listener: set_extra_try_arguments 08:04:29 INFO - [mozharness: 2016-10-06 15:04:29.815260Z] Finished download-and-extract step (success) 08:04:29 INFO - [mozharness: 2016-10-06 15:04:29.815486Z] Running populate-webroot step. 08:04:29 INFO - Running pre-action listener: _resource_record_pre_action 08:04:29 INFO - Running main action method: populate_webroot 08:04:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:29 INFO - '--tppagecycles', 08:04:29 INFO - '7'], 08:04:29 INFO - 'tests': ['tsvgm']}}, 08:04:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:04:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:04:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:04:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['damp', 'tps']}, 08:04:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'tests': ['damp', 'tps']}, 08:04:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['dromaeo_dom']}, 08:04:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['basic_compositor_video']}, 08:04:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:04:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['a11yr', 08:04:29 INFO - 'ts_paint', 08:04:29 INFO - 'tpaint', 08:04:29 INFO - 'sessionrestore', 08:04:29 INFO - 'sessionrestore_no_auto_restore', 08:04:29 INFO - 'tabpaint']}, 08:04:29 INFO - 'other-e10s': {'tests': ['a11yr', 08:04:29 INFO - 'ts_paint', 08:04:29 INFO - 'tpaint', 08:04:29 INFO - 'sessionrestore', 08:04:29 INFO - 'sessionrestore_no_auto_restore', 08:04:29 INFO - 'tabpaint']}, 08:04:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:04:29 INFO - 'ts_paint', 08:04:29 INFO - 'tpaint', 08:04:29 INFO - 'sessionrestore', 08:04:29 INFO - 'sessionrestore_no_auto_restore', 08:04:29 INFO - 'tabpaint']}, 08:04:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:04:29 INFO - 'ts_paint', 08:04:29 INFO - 'tpaint', 08:04:29 INFO - 'sessionrestore', 08:04:29 INFO - 'sessionrestore_no_auto_restore', 08:04:29 INFO - 'tabpaint']}, 08:04:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['a11yr', 08:04:29 INFO - 'ts_paint', 08:04:29 INFO - 'tpaint', 08:04:29 INFO - 'sessionrestore', 08:04:29 INFO - 'sessionrestore_no_auto_restore', 08:04:29 INFO - 'tabpaint']}, 08:04:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['a11yr', 08:04:29 INFO - 'ts_paint', 08:04:29 INFO - 'tpaint', 08:04:29 INFO - 'sessionrestore', 08:04:29 INFO - 'sessionrestore_no_auto_restore', 08:04:29 INFO - 'tabpaint']}, 08:04:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['tsvgx', 08:04:29 INFO - 'tsvgr_opacity', 08:04:29 INFO - 'tart', 08:04:29 INFO - 'tscrollx', 08:04:29 INFO - 'cart']}, 08:04:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:04:29 INFO - 'tsvgr_opacity', 08:04:29 INFO - 'tart', 08:04:29 INFO - 'tscrollx', 08:04:29 INFO - 'cart']}, 08:04:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'talos_options': ['--disable-e10s'], 08:04:29 INFO - 'tests': ['tp5o']}, 08:04:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'tests': ['tp5o']}, 08:04:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'talos_options': ['--disable-e10s', 08:04:29 INFO - '--xperf_path', 08:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:29 INFO - 'tests': ['tp5n']}, 08:04:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:29 INFO - 'talos_options': ['--xperf_path', 08:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:29 INFO - 'tests': ['tp5n']}}, 08:04:29 INFO - 'talos.zip': {'path': '', 08:04:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:29 INFO - Running post-action listener: _resource_record_post_action 08:04:29 INFO - [mozharness: 2016-10-06 15:04:29.830881Z] Finished populate-webroot step (success) 08:04:29 INFO - [mozharness: 2016-10-06 15:04:29.830970Z] Running create-virtualenv step. 08:04:29 INFO - Running pre-action listener: _resource_record_pre_action 08:04:29 INFO - Running main action method: create_virtualenv 08:04:29 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:29 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 08:04:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:04:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:29 INFO - Using real prefix '/usr' 08:04:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:32 INFO - Installing pip.................done. 08:04:32 INFO - Return code: 0 08:04:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:04:32 INFO - Reading from file tmpfile_stdout 08:04:32 INFO - Output received: 08:04:32 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) 08:04:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04:32 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')]} 08:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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')]} 08:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:32 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 08:04:32 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 08:04:32 INFO - Using env: {'DISPLAY': ':0', 08:04:32 INFO - 'HOME': '/home/cltbld', 08:04:32 INFO - 'LANG': 'en_US.UTF-8', 08:04:32 INFO - 'LANGUAGE': 'en_US:en', 08:04:32 INFO - 'LOGNAME': 'cltbld', 08:04:32 INFO - 'MAIL': '/var/mail/cltbld', 08:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:32 INFO - 'MOZ_NO_REMOTE': '1', 08:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:32 INFO - 'NO_EM_RESTART': '1', 08:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:32 INFO - 'PWD': '/builds/slave/test', 08:04:32 INFO - 'SHELL': '/bin/bash', 08:04:32 INFO - 'SHLVL': '1', 08:04:32 INFO - 'TERM': 'linux', 08:04:32 INFO - 'TMOUT': '86400', 08:04:32 INFO - 'USER': 'cltbld', 08:04:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:32 INFO - '_': '/tools/buildbot/bin/python'} 08:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:32 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 08:04:32 INFO - Cleaning up... 08:04:32 INFO - Return code: 0 08:04:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04:32 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')]} 08:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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')]} 08:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:32 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:32 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 08:04:32 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 08:04:32 INFO - Using env: {'DISPLAY': ':0', 08:04:32 INFO - 'HOME': '/home/cltbld', 08:04:32 INFO - 'LANG': 'en_US.UTF-8', 08:04:32 INFO - 'LANGUAGE': 'en_US:en', 08:04:32 INFO - 'LOGNAME': 'cltbld', 08:04:32 INFO - 'MAIL': '/var/mail/cltbld', 08:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:32 INFO - 'MOZ_NO_REMOTE': '1', 08:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:32 INFO - 'NO_EM_RESTART': '1', 08:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:32 INFO - 'PWD': '/builds/slave/test', 08:04:32 INFO - 'SHELL': '/bin/bash', 08:04:32 INFO - 'SHLVL': '1', 08:04:32 INFO - 'TERM': 'linux', 08:04:32 INFO - 'TMOUT': '86400', 08:04:32 INFO - 'USER': 'cltbld', 08:04:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:32 INFO - '_': '/tools/buildbot/bin/python'} 08:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:33 INFO - Downloading/unpacking psutil>=3.1.1 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 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 08:04:33 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 08:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:35 INFO - Installing collected packages: psutil 08:04:35 INFO - Running setup.py install for psutil 08:04:35 INFO - building 'psutil._psutil_linux' extension 08:04:35 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 08:04:35 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 08:04:35 INFO - building 'psutil._psutil_posix' extension 08:04:35 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 08:04:35 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 08:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:35 INFO - Successfully installed psutil 08:04:35 INFO - Cleaning up... 08:04:35 INFO - Return code: 0 08:04:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:04: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 mozsystemmonitor==0.3 08:04:35 INFO - Using env: {'DISPLAY': ':0', 08:04:35 INFO - 'HOME': '/home/cltbld', 08:04:35 INFO - 'LANG': 'en_US.UTF-8', 08:04:35 INFO - 'LANGUAGE': 'en_US:en', 08:04:35 INFO - 'LOGNAME': 'cltbld', 08:04:35 INFO - 'MAIL': '/var/mail/cltbld', 08:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:35 INFO - 'MOZ_NO_REMOTE': '1', 08:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:35 INFO - 'NO_EM_RESTART': '1', 08:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:35 INFO - 'PWD': '/builds/slave/test', 08:04:35 INFO - 'SHELL': '/bin/bash', 08:04:35 INFO - 'SHLVL': '1', 08:04:35 INFO - 'TERM': 'linux', 08:04:35 INFO - 'TMOUT': '86400', 08:04:35 INFO - 'USER': 'cltbld', 08:04:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:35 INFO - '_': '/tools/buildbot/bin/python'} 08:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:35 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 08:04:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:04:37 INFO - Installing collected packages: mozsystemmonitor 08:04:37 INFO - Running setup.py install for mozsystemmonitor 08:04:37 INFO - Successfully installed mozsystemmonitor 08:04:37 INFO - Cleaning up... 08:04:37 INFO - Return code: 0 08:04:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:37 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:37 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 08:04:37 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 08:04:37 INFO - Using env: {'DISPLAY': ':0', 08:04:37 INFO - 'HOME': '/home/cltbld', 08:04:37 INFO - 'LANG': 'en_US.UTF-8', 08:04:37 INFO - 'LANGUAGE': 'en_US:en', 08:04:37 INFO - 'LOGNAME': 'cltbld', 08:04:37 INFO - 'MAIL': '/var/mail/cltbld', 08:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:37 INFO - 'MOZ_NO_REMOTE': '1', 08:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:37 INFO - 'NO_EM_RESTART': '1', 08:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:37 INFO - 'PWD': '/builds/slave/test', 08:04:37 INFO - 'SHELL': '/bin/bash', 08:04:37 INFO - 'SHLVL': '1', 08:04:37 INFO - 'TERM': 'linux', 08:04:37 INFO - 'TMOUT': '86400', 08:04:37 INFO - 'USER': 'cltbld', 08:04:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:37 INFO - '_': '/tools/buildbot/bin/python'} 08:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:40 INFO - warning: no files found matching '*.txt' 08:04:40 INFO - no previously-included directories found matching 'build' 08:04:40 INFO - no previously-included directories found matching 'dist' 08:04:40 INFO - no previously-included directories found matching '.git*' 08:04:40 INFO - Installing collected packages: jsonschema, functools32 08:04:40 INFO - Running setup.py install for functools32 08:04:40 INFO - warning: no files found matching '*.txt' 08:04:40 INFO - no previously-included directories found matching 'build' 08:04:40 INFO - no previously-included directories found matching 'dist' 08:04:40 INFO - no previously-included directories found matching '.git*' 08:04:40 INFO - Successfully installed jsonschema functools32 08:04:40 INFO - Cleaning up... 08:04:40 INFO - Return code: 0 08:04:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:40 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 08:04:40 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 08:04:40 INFO - Using env: {'DISPLAY': ':0', 08:04:40 INFO - 'HOME': '/home/cltbld', 08:04:40 INFO - 'LANG': 'en_US.UTF-8', 08:04:40 INFO - 'LANGUAGE': 'en_US:en', 08:04:40 INFO - 'LOGNAME': 'cltbld', 08:04:40 INFO - 'MAIL': '/var/mail/cltbld', 08:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:40 INFO - 'MOZ_NO_REMOTE': '1', 08:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:40 INFO - 'NO_EM_RESTART': '1', 08:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:40 INFO - 'PWD': '/builds/slave/test', 08:04:40 INFO - 'SHELL': '/bin/bash', 08:04:40 INFO - 'SHLVL': '1', 08:04:40 INFO - 'TERM': 'linux', 08:04:40 INFO - 'TMOUT': '86400', 08:04:40 INFO - 'USER': 'cltbld', 08:04:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:40 INFO - '_': '/tools/buildbot/bin/python'} 08:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:04:40 INFO - Cleaning up... 08:04:40 INFO - Return code: 0 08:04:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:40 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:40 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 08:04:40 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 08:04:40 INFO - Using env: {'DISPLAY': ':0', 08:04:40 INFO - 'HOME': '/home/cltbld', 08:04:40 INFO - 'LANG': 'en_US.UTF-8', 08:04:40 INFO - 'LANGUAGE': 'en_US:en', 08:04:40 INFO - 'LOGNAME': 'cltbld', 08:04:40 INFO - 'MAIL': '/var/mail/cltbld', 08:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:40 INFO - 'MOZ_NO_REMOTE': '1', 08:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:40 INFO - 'NO_EM_RESTART': '1', 08:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:40 INFO - 'PWD': '/builds/slave/test', 08:04:40 INFO - 'SHELL': '/bin/bash', 08:04:40 INFO - 'SHLVL': '1', 08:04:40 INFO - 'TERM': 'linux', 08:04:40 INFO - 'TMOUT': '86400', 08:04:40 INFO - 'USER': 'cltbld', 08:04:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:40 INFO - '_': '/tools/buildbot/bin/python'} 08:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 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 08:04:40 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 08:04:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:42 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 08:04:42 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 08:04:42 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 08:04:42 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 08:04:42 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 08:04:42 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 08:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:43 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 08:04:43 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 08:04:43 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 08:04:43 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 08:04:43 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 08:04:43 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 08:04:43 INFO - Downloading docopt-0.6.1.tar.gz 08:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:43 INFO - Running setup.py install for blobuploader 08:04:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:43 INFO - Running setup.py install for requests 08:04:44 INFO - Running setup.py install for docopt 08:04:44 INFO - Successfully installed blobuploader requests docopt 08:04:44 INFO - Cleaning up... 08:04:44 INFO - Return code: 0 08:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:44 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:44 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 08:04:44 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 08:04:44 INFO - Using env: {'DISPLAY': ':0', 08:04:44 INFO - 'HOME': '/home/cltbld', 08:04:44 INFO - 'LANG': 'en_US.UTF-8', 08:04:44 INFO - 'LANGUAGE': 'en_US:en', 08:04:44 INFO - 'LOGNAME': 'cltbld', 08:04:44 INFO - 'MAIL': '/var/mail/cltbld', 08:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:44 INFO - 'MOZ_NO_REMOTE': '1', 08:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:44 INFO - 'NO_EM_RESTART': '1', 08:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:44 INFO - 'PWD': '/builds/slave/test', 08:04:44 INFO - 'SHELL': '/bin/bash', 08:04:44 INFO - 'SHLVL': '1', 08:04:44 INFO - 'TERM': 'linux', 08:04:44 INFO - 'TMOUT': '86400', 08:04:44 INFO - 'USER': 'cltbld', 08:04:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:44 INFO - '_': '/tools/buildbot/bin/python'} 08:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:44 INFO - Running setup.py (path:/tmp/pip-XzEcop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:44 INFO - Running setup.py (path:/tmp/pip-A9Wwut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:44 INFO - Running setup.py (path:/tmp/pip-91PiPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:44 INFO - Running setup.py (path:/tmp/pip-lQF7ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:44 INFO - Running setup.py (path:/tmp/pip-9rRYLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:44 INFO - Running setup.py (path:/tmp/pip-gcenHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:44 INFO - Running setup.py (path:/tmp/pip-QeeIv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:45 INFO - Running setup.py (path:/tmp/pip-m3MuGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:45 INFO - Running setup.py (path:/tmp/pip-Q548Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:45 INFO - Running setup.py (path:/tmp/pip-QbErKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:45 INFO - Running setup.py (path:/tmp/pip-g4Ylpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:45 INFO - Running setup.py (path:/tmp/pip-n3fvjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:45 INFO - Running setup.py (path:/tmp/pip-1a5i2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:45 INFO - Running setup.py (path:/tmp/pip-XYRzvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:45 INFO - Running setup.py (path:/tmp/pip-rbH9yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:45 INFO - Running setup.py (path:/tmp/pip-xRUn59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:45 INFO - Running setup.py (path:/tmp/pip-y0pVHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:45 INFO - Running setup.py install for manifestparser 08:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:04:45 INFO - Running setup.py install for mozcrash 08:04:45 INFO - Running setup.py install for mozdebug 08:04:46 INFO - Running setup.py install for mozdevice 08:04:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Running setup.py install for mozfile 08:04:46 INFO - Running setup.py install for mozhttpd 08:04:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Running setup.py install for mozinfo 08:04:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Running setup.py install for mozInstall 08:04:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Running setup.py install for mozleak 08:04:46 INFO - Running setup.py install for mozlog 08:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Running setup.py install for moznetwork 08:04:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:04:46 INFO - Running setup.py install for mozprocess 08:04:46 INFO - Running setup.py install for mozprofile 08:04:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:04:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:04:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:04:47 INFO - Running setup.py install for mozrunner 08:04:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:47 INFO - Running setup.py install for mozscreenshot 08:04:47 INFO - Running setup.py install for moztest 08:04:47 INFO - Running setup.py install for mozversion 08:04:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:47 INFO - Cleaning up... 08:04:47 INFO - Return code: 0 08:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:47 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:47 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 08:04:47 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 08:04:47 INFO - Using env: {'DISPLAY': ':0', 08:04:47 INFO - 'HOME': '/home/cltbld', 08:04:47 INFO - 'LANG': 'en_US.UTF-8', 08:04:47 INFO - 'LANGUAGE': 'en_US:en', 08:04:47 INFO - 'LOGNAME': 'cltbld', 08:04:47 INFO - 'MAIL': '/var/mail/cltbld', 08:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:47 INFO - 'MOZ_NO_REMOTE': '1', 08:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:47 INFO - 'NO_EM_RESTART': '1', 08:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:47 INFO - 'PWD': '/builds/slave/test', 08:04:47 INFO - 'SHELL': '/bin/bash', 08:04:47 INFO - 'SHLVL': '1', 08:04:47 INFO - 'TERM': 'linux', 08:04:47 INFO - 'TMOUT': '86400', 08:04:47 INFO - 'USER': 'cltbld', 08:04:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:47 INFO - '_': '/tools/buildbot/bin/python'} 08:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:47 INFO - Running setup.py (path:/tmp/pip-xWxmLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:47 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)) 08:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:47 INFO - Running setup.py (path:/tmp/pip-hSzChl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:47 INFO - Running setup.py (path:/tmp/pip-YpX759-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:47 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)) 08:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:47 INFO - Running setup.py (path:/tmp/pip-FL3u0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:48 INFO - Running setup.py (path:/tmp/pip-oHD6xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:48 INFO - Running setup.py (path:/tmp/pip-t8Q9AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:48 INFO - Running setup.py (path:/tmp/pip-_ZVVgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:48 INFO - Running setup.py (path:/tmp/pip-JbTruE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:48 INFO - Running setup.py (path:/tmp/pip-eYUdq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:48 INFO - Running setup.py (path:/tmp/pip-WhfkvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:48 INFO - Running setup.py (path:/tmp/pip-AsLTbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:48 INFO - Running setup.py (path:/tmp/pip-eZnrXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:48 INFO - Running setup.py (path:/tmp/pip-Apd71G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:48 INFO - Running setup.py (path:/tmp/pip-J4s4tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:48 INFO - Running setup.py (path:/tmp/pip-JV8_P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:48 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)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:48 INFO - Running setup.py (path:/tmp/pip-OWJiPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:48 INFO - Running setup.py (path:/tmp/pip-RcgP8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:49 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)) 08:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:49 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)) 08:04:49 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)) 08:04:49 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)) 08:04:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:49 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 08:04:49 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 08:04:49 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 08:04:49 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 08:04:49 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 08:04:49 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 08:04:50 INFO - Downloading blessings-1.6.tar.gz 08:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:50 INFO - Installing collected packages: blessings 08:04:50 INFO - Running setup.py install for blessings 08:04:51 INFO - Successfully installed blessings 08:04:51 INFO - Cleaning up... 08:04:51 INFO - Return code: 0 08:04:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:51 INFO - Reading from file tmpfile_stdout 08:04:51 INFO - Current package versions: 08:04:51 INFO - argparse == 1.2.1 08:04:51 INFO - blessings == 1.6 08:04:51 INFO - blobuploader == 1.2.4 08:04:51 INFO - docopt == 0.6.1 08:04:51 INFO - functools32 == 3.2.3-2 08:04:51 INFO - jsonschema == 2.5.1 08:04:51 INFO - manifestparser == 1.1 08:04:51 INFO - mozInstall == 1.12 08:04:51 INFO - mozcrash == 0.17 08:04:51 INFO - mozdebug == 0.1 08:04:51 INFO - mozdevice == 0.48 08:04:51 INFO - mozfile == 1.2 08:04:51 INFO - mozhttpd == 0.7 08:04:51 INFO - mozinfo == 0.9 08:04:51 INFO - mozleak == 0.1 08:04:51 INFO - mozlog == 3.4 08:04:51 INFO - moznetwork == 0.27 08:04:51 INFO - mozprocess == 0.23 08:04:51 INFO - mozprofile == 0.28 08:04:51 INFO - mozrunner == 6.12 08:04:51 INFO - mozscreenshot == 0.1 08:04:51 INFO - mozsystemmonitor == 0.3 08:04:51 INFO - moztest == 0.7 08:04:51 INFO - mozversion == 1.4 08:04:51 INFO - psutil == 3.1.1 08:04:51 INFO - requests == 1.2.3 08:04:51 INFO - wsgiref == 0.1.2 08:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:51 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 08:04:51 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 08:04:51 INFO - Using env: {'DISPLAY': ':0', 08:04:51 INFO - 'HOME': '/home/cltbld', 08:04:51 INFO - 'LANG': 'en_US.UTF-8', 08:04:51 INFO - 'LANGUAGE': 'en_US:en', 08:04:51 INFO - 'LOGNAME': 'cltbld', 08:04:51 INFO - 'MAIL': '/var/mail/cltbld', 08:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:51 INFO - 'MOZ_NO_REMOTE': '1', 08:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:51 INFO - 'NO_EM_RESTART': '1', 08:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:51 INFO - 'PWD': '/builds/slave/test', 08:04:51 INFO - 'SHELL': '/bin/bash', 08:04:51 INFO - 'SHLVL': '1', 08:04:51 INFO - 'TERM': 'linux', 08:04:51 INFO - 'TMOUT': '86400', 08:04:51 INFO - 'USER': 'cltbld', 08:04:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:51 INFO - '_': '/tools/buildbot/bin/python'} 08:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 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)) 08:04:51 INFO - Cleaning up... 08:04:51 INFO - Return code: 0 08:04:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 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 0x7f546bb25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', '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 08:04:51 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 08:04:51 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 08:04:51 INFO - Using env: {'DISPLAY': ':0', 08:04:51 INFO - 'HOME': '/home/cltbld', 08:04:51 INFO - 'LANG': 'en_US.UTF-8', 08:04:51 INFO - 'LANGUAGE': 'en_US:en', 08:04:51 INFO - 'LOGNAME': 'cltbld', 08:04:51 INFO - 'MAIL': '/var/mail/cltbld', 08:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:51 INFO - 'MOZ_NO_REMOTE': '1', 08:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:51 INFO - 'NO_EM_RESTART': '1', 08:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:51 INFO - 'PWD': '/builds/slave/test', 08:04:51 INFO - 'SHELL': '/bin/bash', 08:04:51 INFO - 'SHLVL': '1', 08:04:51 INFO - 'TERM': 'linux', 08:04:51 INFO - 'TMOUT': '86400', 08:04:51 INFO - 'USER': 'cltbld', 08:04:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:51 INFO - '_': '/tools/buildbot/bin/python'} 08:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:51 INFO - Cleaning up... 08:04:51 INFO - Return code: 0 08:04:51 INFO - Running post-action listener: _resource_record_post_action 08:04:51 INFO - Running post-action listener: _start_resource_monitoring 08:04:51 INFO - Starting resource monitoring. 08:04:51 INFO - [mozharness: 2016-10-06 15:04:51.877817Z] Finished create-virtualenv step (success) 08:04:51 INFO - [mozharness: 2016-10-06 15:04:51.878277Z] Running install step. 08:04:51 INFO - Running pre-action listener: _resource_record_pre_action 08:04:51 INFO - Running main action method: install 08:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:52 INFO - Reading from file tmpfile_stdout 08:04:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:52 INFO - Reading from file tmpfile_stdout 08:04:52 INFO - Output received: 08:04:52 INFO - Usage: mozinstall [options] installer 08:04:52 INFO - Options: 08:04:52 INFO - -h, --help show this help message and exit 08:04:52 INFO - -d DEST, --destination=DEST 08:04:52 INFO - Directory to install application into. [default: 08:04:52 INFO - "/builds/slave/test"] 08:04:52 INFO - --app=APP Application being installed. [default: firefox] 08:04:52 INFO - mkdir: /builds/slave/test/build/application 08:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:05:08 INFO - Reading from file tmpfile_stdout 08:05:08 INFO - Output received: 08:05:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:08 INFO - Running post-action listener: _resource_record_post_action 08:05:08 INFO - [mozharness: 2016-10-06 15:05:08.311617Z] Finished install step (success) 08:05:08 INFO - [mozharness: 2016-10-06 15:05:08.311861Z] Running run-tests step. 08:05:08 INFO - Running pre-action listener: _resource_record_pre_action 08:05:08 INFO - Running main action method: run_tests 08:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:08 INFO - Python 2.7.3 08:05:08 INFO - Return code: 0 08:05:08 INFO - grabbing minidump binary from tooltool 08:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:08 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 0x11cdf60>, '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 0x11ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:08 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 08:05:08 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 08:05:08 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 08:05:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:08 INFO - Return code: 0 08:05:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 08:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 08:05:08 INFO - Using env: {'DISPLAY': ':0', 08:05:08 INFO - 'HOME': '/home/cltbld', 08:05:08 INFO - 'LANG': 'en_US.UTF-8', 08:05:08 INFO - 'LANGUAGE': 'en_US:en', 08:05:08 INFO - 'LOGNAME': 'cltbld', 08:05:08 INFO - 'MAIL': '/var/mail/cltbld', 08:05:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:08 INFO - 'MOZ_NO_REMOTE': '1', 08:05:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:08 INFO - 'NO_EM_RESTART': '1', 08:05:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:08 INFO - 'PWD': '/builds/slave/test', 08:05:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:08 INFO - 'SHELL': '/bin/bash', 08:05:08 INFO - 'SHLVL': '1', 08:05:08 INFO - 'TERM': 'linux', 08:05:08 INFO - 'TMOUT': '86400', 08:05:08 INFO - 'USER': 'cltbld', 08:05:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128', 08:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:08 INFO - '_': '/tools/buildbot/bin/python'} 08:05:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 08:05:08 INFO - mozversion application_buildid: 20161006063300 08:05:08 INFO - mozversion application_changeset: 8282815e55598b0099a613758d19b232b75b3d74 08:05:08 INFO - mozversion application_display_name: Nightly 08:05:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:08 INFO - mozversion application_name: Firefox 08:05:08 INFO - mozversion application_remotingname: firefox 08:05:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:05:08 INFO - mozversion application_vendor: Mozilla 08:05:08 INFO - mozversion application_version: 52.0a1 08:05:08 INFO - mozversion platform_buildid: 20161006063300 08:05:08 INFO - mozversion platform_changeset: 8282815e55598b0099a613758d19b232b75b3d74 08:05:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:05:08 INFO - mozversion platform_version: 52.0a1 08:05:08 INFO - using testdate: 1475766308 08:05:08 INFO - actual date: 1475766308 08:05:08 INFO - starting webserver on 'localhost:33424' 08:05:08 INFO - SUITE-START | Running 2 tests 08:05:08 INFO - TEST-START | dromaeo_css 08:05:08 INFO - operating with platform_type : linux_ 08:05:08 INFO - Initialising browser for dromaeo_css test... 08:05:08 INFO - TEST-INFO | started process 15507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr6AawI/profile http://localhost:33424/getInfo.html) 08:05:13 INFO - PROCESS | 15507 | __metrics Screen width/height:1600/1200 08:05:13 INFO - PROCESS | 15507 | colorDepth:24 08:05:13 INFO - PROCESS | 15507 | Browser inner width/height: 1024/697 08:05:13 INFO - PROCESS | 15507 | __metrics 08:05:13 INFO - PROCESS | 15507 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:05:13 INFO - PROCESS | 15507 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:05:14 INFO - PROCESS | 15507 | console.error: PushService: 08:05:14 INFO - PROCESS | 15507 | stateChangeProcessEnqueue: Error transitioning state 08:05:14 INFO - PROCESS | 15507 | UnknownError 08:05:15 INFO - TEST-INFO | 15507: exit 0 08:05:15 INFO - Browser initialized. 08:05:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:15 INFO - TEST-INFO | started process 15589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr6AawI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:27 INFO - PROCESS | 15589 | RSS: Main: 174518272 08:05:27 INFO - PROCESS | 15589 | 08:06:18 INFO - PROCESS | 15589 | 1475766378870 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:08:34 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:33424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33424/tests/dromaeo/cssquery-ext.html) 08:08:35 INFO - PROCESS | 15589 | RSS: Main: 280092672 08:08:35 INFO - PROCESS | 15589 | 08:11:38 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:33424/tests/dromaeo/cssquery-ext.html (next: http://localhost:33424/tests/dromaeo/cssquery-jquery.html) 08:11:38 INFO - PROCESS | 15589 | RSS: Main: 277594112 08:11:38 INFO - PROCESS | 15589 | 08:14:41 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:33424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33424/tests/dromaeo/cssquery-mootools.html) 08:14:41 INFO - PROCESS | 15589 | RSS: Main: 222318592 08:14:41 INFO - PROCESS | 15589 | 08:17:44 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:33424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33424/tests/dromaeo/cssquery-prototype.html) 08:17:44 INFO - PROCESS | 15589 | RSS: Main: 239005696 08:17:44 INFO - PROCESS | 15589 | 08:20:47 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:33424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33424/tests/dromaeo/cssquery-yui.html) 08:20:48 INFO - PROCESS | 15589 | RSS: Main: 220315648 08:20:48 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:33424/tests/dromaeo/cssquery-yui.html (next: http://localhost:33424/tests/dromaeo/cssquery-dojo.html) 08:23:51 INFO - PROCESS | 15589 | RSS: Main: 306343936 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | __start_tp_report 08:23:51 INFO - PROCESS | 15589 | _x_x_mozilla_page_load 08:23:51 INFO - PROCESS | 15589 | _x_x_mozilla_page_load_details 08:23:51 INFO - PROCESS | 15589 | |i|pagename|runs| 08:23:51 INFO - PROCESS | 15589 | |0;dojo.html;2572.80703947204;2588.728183540727;2625.3174174714572;2631.1711810779602;2635.9604605930904;4573.817047318112;4661.533846615337;4714.622830173586;4725.621950243981;4732.881677958048;4680.157571637113;4686.2736275877205;4710.152172608938;4757.762111894409;4785;4302.376155457472;4333.306670932651;4391.5827996340295;4423.424954755893;4423.623991960671;4414.337849322611;4474.597286244238;4475.888102797424;4476.574725401098;4493.68544201906;4236.06806502572;4316.115196384733;4316.158349121923;4365.672574556905;4407.735535867858;4227.640650544708;4255.723377980421;4267.039916018902;4283.957160428387;4343.869683909456;4239.47006624172;4249.32010878258;4250.638695710868;4306.5262821089655;4311.417958575584;4597.126545956257;4602.723836569817;4632.837850675244;4637.814487420499;4678.415198100238;4888.095702295087;4930.950690493085;4956.925646115311;5006.724630145341;5039.168537191359;5110.923336149961;5115.155999260118;5117.667351622133;5141.974290128563;5158.561522270612;4749.2876068589985;4757.167495688241;4758.119747846659;4758.381410416693;4817.108834865561;4995.425526064549;5037.874053148701;5092.6435149539175;5193.221016847503;5269.420363759983;4896;4963.181075122637;4963.429205641325;4976.701397916137;5021.974890125526;5031.421386540522;5037.7733002014265;5038.546530812245;5044.117279476077;5099.36257967754;4865.9026819464125;4931.408231012301;5010.974945125251;5021.974890125599;5086.440491545927;4915.508449155056;4960.553550180429;4960.677555958851;4965.453800081988;4976.054549635558;4220.957790422057;4291.270484017725;4297.462817147856;4299.097189590221;4315.741055536615;3704.6110158433517;3716.6283371662616;3818.3317919364;3829.4064420014943;3830.4637350770913;4305.677074219446;4313.784310784448;4315.28797748368;4357.9782101089295;4361.738295702268;4914.680545764514;5003.149464591028;5051.873703157377;5054.469280725544;5065.366829146356;4251.702380833312;4262.914741705211;4286.592773686495;4302.806373713191;4313.1158112586845;4522.615577675934;4535.274356103007;4541.931871021871;4557.111363284128;4611.308303754464;4618.399608050931;4699.741514216614;4705.858824235278;4708.576228139484;4724.811007559797;4980.377452818398;5031.647784655039;5096.923546146885;5105.744712764421;5172.948270517247;4728.858134255978;4757.666963312673;4763.595094417014;4770.928436073531;4825.227963525819;5033.677772670167;5034.471380504994;5035.16919708244;5036.823711170092;5101.107306221471;4897.2654101885;4965.503449655005;5017.874553136201;5065.493450655053;5091.363579552556;4938.308636790924;4941.629377796751;4941.678790878582;4943.97528012372;4989.476105009067;4934.925976110289;4938.851834444972;4939.135651260943;4939.827106051271;4988.9501104988485;4690.882727931829;4753.857384278477;4793.400824896888;4833.782479788348;4920.261960705922;4935.777889995031;4936.136176169084;4939.753012349296;4987.376577927759;4996.800127994839;4797.856064318076;4835.516448355136;4839.516048395132;4883.706977581356;4889.291052797395 08:23:51 INFO - PROCESS | 15589 | |1;ext.html;572.6564061563063;576.3861487515795;580.465971306398;585.5871610514587;585.7217821534772;27598;36452.635473645256;37445.43831842518;37533;37899;38639.806800965955;39044;39095.60904390955;39119.60880391195;39186.412203816966;7689.692412303515;7840.372770178372;7849.8037549061155;7851.782973639095;7853.371730261594;7624.6187690615525;7703.5377877327255;7706.306432421081;7707.229277072304;7709.768706938801;7732.30409263169;7796.259355361231;7801.531908085504;7804.453688241825;7808.219178082203;7730.574818384986;7748.961255193688;7770.261825126576;7771.028621422322;7778.805529861742;7700.499467534648;7719.421043421766;7778.6888524458955;7779.7666070017995;7788.727394541221;37521;37926;37934.81032594847;37943.620563794284;37973;2470.5800013997664;2508.912188073427;2707.5803250496206;2793.9580906286424;2854.5290027145497;22606.54786904269;22856.885715571316;22882.542349152925;23024.53950920972;23237.419064523354;3287.211069343364;3333.183370074323;3348.614909285415;3348.68187522185;3367.2928684976187;240354;241235;241407.79296103583;241458;241774;51406.48593514092;51600.74199628978;51601.48398516042;51614.74192629013;51686;31823.204419889687;33194.50208246878;33228.66771332304;34258.828705856315;34303;11508;11512.424378781028;11513.251638643462;11519.19365644397;11522.942385288019;7499.550026998289;7648.196939321291;7661.923380766121;7747.992760941154;7775.961120194476;17434.302627894995;17612.119394030247;17621.47135585909;17650.323219294147;17800.617882602262;6739.887918493394;6759.121314229119;6776.7628133015105;6854.897176542356;6872.62200578963;749.9587522686196;889.5196593839383;901.6032945504088;919.8022425178618;960.3469640644429;24347.878260608937;25560.744392556207;26109.216723498324;26154.6076808848;26162.86918565433;887.8135591525852;896.9058248883904;933.3793027636682;982.8574856645746;1027.6896956380674;13481.865181348061;14104.294785260696;14259.575872101768;14377.928110359382;14417.927910360591;369639;371588;371703;371721;373157;47428;47996.760016199696;48062.51937480651;48110.27834582484;48161.75919120452;956.990375154205;1059.4543809937888;1114.9498272577753;1133.994330028361;1174.8766379530027;26785.598216026385;28089.71910280871;28654.283642909093;28664.28339291451;29479.85260073686;39624.80187599044;39882.2023559533;40015.79992100137;40016.79991600024;40041.799791000856;270061;270460;270466;271019;272194;24088.63867041961;25030.499390011733;25271.49457010886;25278.620820687338;26474.338141546614;37400.812995934844;37551.43672844964;38542.42186367151;38604.80697596494;38787.80606096952;32315.35369292648;32452;32503.349933001682;32511;33704.66295337015;32695.673043269264;32994.67005330012;33253;33355.332893342485;33873;32314.676853232108;32972.50541241835;33090.33819323552;33267.33465330728;33313;25425.643668364675;27350.452990940466;28862.567061493675;29108.741620551682;29909.850450748476;22996.4250893729;23340.014094573373;23431.297061087513;23596.17413390523;23800.166994155814 08:23:51 INFO - PROCESS | 15589 | |2;jquery.html;326.53631842783244;342.5666531837228;352.42202787428613;352.50121078673686;370.9610490898456;12341.69145771355;13247.7350452991;15355.078695278276;15522.30149643266;16018.119003454805;15529.922350388233;15619.609509762262;15754.921225393857;15852.3659053638;15853.603659908507;4727.598154156901;4835.178019736653;4953.257011448276;4953.678010929278;4955.628327875405;3701.4262789267573;5004.474530174334;5016.072026675077;5016.3227964224725;5021.221710634839;5005.299258103868;5010.49685094472;5012.498750124995;5014.122528557488;5015.39815222172;4761.47623761386;4949.7772600233075;4972.602191824645;4973.875653108665;4974.1543937530705;4458.197524445631;4462.665300102472;4470;4473.82104715811;4474.172278128524;18955;19688.803111968984;19786.208551657917;19822.10800513966;20827.791722082737;1749.6850566897954;1834.2479583370755;1916.549610841451;2037.724907137547;2126.7873212678765;12310.446029928675;13563.254021028839;13758.65603359914;14141.575752727435;14792.260386980608;1802.5493626593352;1849.3897013985352;1855.239351865742;1885.1422602715732;1927.8264956154014;74817;79713;79791;81233.59383203105;83988;15920.601984950468;16063.839361606468;16153.911517871833;16322.510324690278;16441.58896027585;27484.450310994067;27628.861855690993;27662.170134895987;27669.169924902286;27743.44513109767;7954.5624990626075;7961.36309095271;8000.239977202156;8002.759917202493;8278.71024514139;6384.521160912857;6488.870222595521;6625.701843417058;6627.5029372797235;6674.733010679518;8070.757877263692;8097.433179677366;8106.675732970615;8111.269985701315;8357.498550087013;3000.6099207103375;3003.9233695055286;3110.751139908802;3185.0604071798875;3221.855016524215;822.6956026270318;831.2767891934056;843.8144407108023;860.7159637319669;877.9473231606124;15771.369145234063;16552.66894662124;16583.50249492517;16720.331186752635;16906.323747050224;763.9579823109782;803.1566854802434;803.7227156630953;804.2199066905092;839.3243439031638;7227.349538541556;8912.777180570538;9208.631654733736;9398.812023759487;9401.670941517013;350701;351610;352155;353153;353536;71494.9275760864;72396;72662.27337726555;74298.25701742913;75061.62469187619;864.2999170671776;882.6734108379941;886.1979908183105;888.5557221389305;890.3011136258007;14498.202598856742;14520.273986300432;14522.419103235752;14558;15021.624459388166;35079.12302192466;36022.27955440929;36815.63184368229;37451.625483744814;37606.2478750418;48802.511974881214;48971.265431019274;49168.26247606217;49203.53982300799;49245.261321079495;6534.693061387837;6647.734090636321;6791.72833086671;6803.89794153098;7138.46461515378;9856.457894815567;10000.649977251052;10076.496175191065;10366.637167699095;10502.894971050191;8431.367647426345;8496.617652205789;8566.957165214384;8790.912090879265;8857.424267422597;8222.218889205516;8368.20502052304;8696.869546956674;8702.956485217534;9231.261499079923;8213.83572328562;8569.271611913056;8887.289016878764;8946.284297256334;9141.725748227564;6637.336266373324;6694.966525167343;6740.865182696417;6827.283135270924;6945.513814032969;6788.355106264897;7615.6953721850505;8285.917140828757;8687.348448866487;8910.955445222733 08:23:51 INFO - PROCESS | 15589 | |3;mootools.html;1188.203903384732;1332.273910718658;1352.1211212711737;1407.303384824512;1651.3477176515269;6429.614223146615;6915.654217289134;7031.964840175805;7341.192468828424;7346.449016323771;7419.740309089183;7479.62601869907;7487.138979017414;7489.812754681122;7503.2121627229035;2073.9792602073935;2105.947351316214;2108.051376880402;2109.4199095248778;2109.440998135495;2061.1127837361655;2084;2101.2015434135005;2111.7043613894066;2113.608982338272;2095.140992193201;2101.957960840782;2115.1010820401343;2122.564874200793;2139.9251026214088;2044.3253726270295;2052.2406709517427;2053.158205135902;2055.876647401161;2058.4442200605904;2013.6778115501595;2014.74815648044;2044.795520447958;2050;2055.1779288284656;7281.817954551178;7382.778516644509;7452.627368631601;7492.100947886234;7504.512206706547;4010.6991975601654;4213.768242746648;4214.978925105354;4261.169072030955;4268.445102136733;2593.1831473085917;2685.7179996100517;2711.3221694576355;2722.3058120179226;2724.523208438515;786.1431040166246;791.3431851563189;807.6325272001226;809.7004108479841;811.377245508982;9815.558299876522;9969.80060398788;9985.450800205987;10021.048000439947;10021.44882031488;3686.1153323202775;3783;3916.8433262669746;3944.980275098606;3968.503937007874;7743.9612801936755;7752.186020467882;7755;7755.92244077552;7761.72833950809;4137.77242251679;4147.3986271991;4150.107726838744;4151.584841515884;4155.792210389529;3340.9665903341142;3481.7736847104857;3600.9099772505374;3763.4166704160352;3769.0577355661085;3185.865470135015;3236.7896086754286;3289.588801399825;3299.934001320008;3334.0997930558615;971.965981190669;975.2003357247131;991.1822746234242;996.8454889492141;1001.0540039662449;685.2530741491798;705.6683358821346;717.1716667249335;732.6593134192626;741.7070257248357;4790.568848803555;4856.033306510869;4884.218525036048;4896.3389942358035;4911.926321105187;354.2136457065362;368.778732760347;369.9667029967316;373.21997026214797;375.1427987049633;3328.284418849959;3336.382769187708;3402.40457919868;3411.9829400852836;3494.965050349515;8391.454555453876;8679.262262707614;8744.69393571222;8787.516686582172;8809.383343166044;8636.352273579507;8637.0499245083;8652.178043085896;8652.480851148952;8658.567071646392;6749.380148764261;6822.965885170543;6825.863482730318;6830.453563714891;6831.316868313228;4854.262981408311;4952.4057113146655;5016.874578135576;5063.9744102359355;5136.357955255593;8052.83894322122;8154.9806274215725;8427.199416055464;8474.618642160995;8563.743087707378;7914.24814642608;8091.595420228848;8476.321894248322;8631.784205394915;8671.21959023691;6087.57386982907;6781.966090169518;6855.4172895304455;6940.305969403221;6940.7917762467205;6350.428461438492;6493.740250389931;6613.6693165340575;6870.931290687029;6920.826979325557;6272.40412160844;6334;6379.617222966451;6403.263624683221;6491.967540162269;6148.877022459616;6202.4417802398;6237.033259844731;6266.279377871603;6358.554901156875;5598.21624972496;5757.453041961007;5764;5767.307923049261;5772.6536407815665;4139.2135494256;4172.374143878443;4253.5108462527205;4324.35134729793;4481.708688935209;4272.957270427256;4300.784960752013;4324.56754324565;4376.365427013129;4425.668074894332 08:23:51 INFO - PROCESS | 15589 | |4;prototype.html;272.63875365141183;277.9110684580934;281.3164011452172;286.3171336362774;287.2889598244347;4645.488996210414;4781.808727650894;4800.071956106772;4862.222044472889;4866.586340161086;4617.8686221875605;4761.833335833247;4764.499182757429;4772.164871147544;4778.880527986794;3758.530183727034;3765.4728338032696;3770.622937706228;3771.17034252464;3779.3575092234387;3570.6429357064217;3617.674409303162;3669.7981611011382;3765.4540091686827;3781.149241420686;3723.3111874303204;3744.1762812181278;3747.494088298086;3755.192633583779;3759.191773768639;3719.163188282642;3720.441933709938;3726.6459686329754;3727.5154229949935;3745.9250814983684;3257.800984335564;3260.4131256373844;3274.6889045540634;3282.195862013798;3283.6372905244293;4540.954590454086;4636.5131661175765;4644.140833945731;4649.860504184846;4659.394278743742;4180.16396720654;4210.389493523453;4217.7891105444605;4220.746755194698;4225.556316586745;4961.5286547777905;4972.428170760337;4993.226049962262;4995.825146119904;5000.349954505928;3484.372812893678;3521.894343169709;3524.3479956208184;3530.8764193253114;3587.210813620999;5174.534291913746;5176.922346164811;5179.766910489037;5180.456052114511;5183.170692689189;3627.437747149196;3640.9635903641156;3642.908927276839;3647.7811331319676;3649.908752281161;3700.296943580711;3702.6667599916136;3707.4068149096015;3709.221063576625;3736.4208547675153;3965.702572307031;4167.770772607536;4168.478940132483;4175.937360939588;4180.581941805856;4951.8266860659705;4964.503549645006;4965;4983.327250821165;5004.199328107486;1157.65270418874;1196.7785959597502;1232.9136960412864;1246.8815462531045;1250.2935841249664;805.9435839491297;830.3730683334044;836.6028732017545;843.6583183810567;845.7970087179033;4375.453068366454;4387.912241755211;4392.363107349416;4427.645788336926;4452.8218871245435;5150.922736158961;5161.612879034087;5162.045021671003;5162.509561591718;5165.405978312467;4257.978710106491;4438.667099967515;4466.330050492452;4486.237339652267;4511.729296242171;2751.5047291487726;2771.5981182728797;2775.9861200693867;2778.8054836161273;2782.692134696689;4825.831095911626;4861.611071114302;4880.243562247857;4883.4628190898975;4886.584640305614;5181.3782346118705;5271.762770675329;5283.682979021271;5290.470952904679;5297.7880884764945;4836.564709176191;4865.756712164378;4876.561109500162;4884.316195732529;4884.92531643038;5008.749562521786;5193.558547523503;5194.97402512985;5197.740112994411;5203.635745497931;5058.1148299048255;5063.9616230261545;5081.551757749024;5086.3896332440345;5105.744712764421;4861.878453038702;4868.853934381974;4871.244957031666;4871.585915197106;4906.73012984275;3604.9098772530897;3616.6202548732003;3620.6560376764164;3637.927241455209;3641.8361173746716;4975.328330675457;5126.56424203932;5137.152369858932;5151.793928242828;5168.638195326442;4989.403390915018;4993.675411098267;5003.824866129668;5034.16936205522;5062.417821950376;4896.6572339935865;5030.673006254582;5056.721880296619;5059.3422855030085;5077.669951453144;4708.411448568929;4874.4150701916;4914.140025495595;4952.232403977389;4974.030064137603;4968.3292755479;5125.282460455614;5125.410577783603;5126.589872810241;5131.4868513148385;4990.326305948651;5004.749762511933;5011.248312753116;5013.899722005613;5016.021875734197 08:23:51 INFO - PROCESS | 15589 | |5;yui.html;571.4228629084624;585.1252377695344;597.2743117112707;613.8741557980615;655.1973832055729;10618.150547956164;11503.13726470514;11506.999999999989;11508.769824603503;11520.942395288033;10923.235373523856;12199.695007624814;12223;12264.141510094274;12325.198862073981;599.9700014999232;733.886247631618;750.921153278906;751.515272649141;752.4995877741322;626.8119564130766;730.1384366447589;759.2407592407592;765.334159281426;767.075673813054;797.5693125712138;800.0439474827583;800.2477670989281;801.8396320735847;801.9518828870257;637.7672149665385;657.5200103924115;782.0498094814799;783.3419927261072;783.7374479549358;567.5544697412512;583.5011065538988;587.2805812879232;587.9941200587982;588.6291636269166;10907;10907.509162087725;10915.672529824038;10945.671629851116;10959.342439453578;12021.278723276544;12462;12626.24242545441;12708.364581770875;12898.742025159538;11668.299902005907;11942.820857687142;12001.459934302977;12044.156909016372;12651.74696506074;4213.30480470722;4224.049588842517;4240;4434.334849772527;4436.977815110904;59177.40822591762;60120.39879601192;60297.39702602962;60682.393176068115;61695.383046169416;10190.286679932482;10248.23138264633;10278.434686092336;10457.947710261553;10856.457177141112;18250.269989200548;18273.634527309645;18302.26790928348;18305;18322.450326490227;6240.920967174155;6279.277883043417;6316.210473690789;6478.093066970628;6538.084668146464;3450.913727156791;3502.387082260594;3560.3235385276716;3601.8019008954757;3630.2013557017412;2521.646969424282;2565.191964531167;2568.1011645923777;2573.5238980788613;2605.0751983045748;451.7876597998935;455.47847714366867;457.8283143821067;467.91343601433846;470.53417117054556;361.73593276908;421.090444639577;423.6610711430843;440.35268155810905;455.05802987815565;6983.092198014328;7319.890201646979;7539.547627142389;7608.771736847903;7724.188960159215;381.5612046146953;392.976421414716;481.8120932836197;485.44174199670664;492.58622756884387;2977.2408035950693;3303.174206448388;3394;3485.89542313731;3631.473436351767;52724;54635.45364546383;72839;101798;102233;48163.518364816606;59441;72568.27431725615;84927;85677;75165.52005655035;76614.23385766182;77715.61142194252;78162;80316;6352.936470635234;6355.1420558224045;6479.092926990319;6490.513211509061;6667.833304167435;43149;45189.322160166965;46011.53988460206;46522.76738616285;47337.52662473331;35727.64272357347;36378.636213637525;53661;63597.364026359144;66191.33808661852;8503.702370417006;8953.776155596162;9033.277337813091;9245.72262832116;9256.537173141181;9490.525473726148;9586.856197156909;9616.326857119935;9666.323357364918;9684.983076776836;8741.256993155654;8806.91193088061;8980.326475514494;9085.409448385833;9144.08559144107;7633.351165150802;8486.957565212135;8795.826114662395;9110.772230694285;9159.267258619428;9018.774530636787;9121.087891210826;9200.631974720936;9367.20378767785;9370;7303.765756666467;7383.926160738324;7447.70209191648;7645.426593005658;7704.6918123274445;7051.330123638451;7342.9632851835395;7370;7404.888926665996;7422.777316680508 08:23:51 INFO - PROCESS | 15589 | __end_tp_report 08:23:51 INFO - PROCESS | 15589 | __start_cc_report 08:23:51 INFO - PROCESS | 15589 | _x_x_mozilla_cycle_collect,1129 08:23:51 INFO - PROCESS | 15589 | __end_cc_report 08:23:51 INFO - PROCESS | 15589 | __startTimestamp1475767431535__endTimestamp 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | ------- Summary: start ------- 08:23:51 INFO - PROCESS | 15589 | Number of tests: 6 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | [#0] dojo.html Cycles:165 Average:4655.96 Median:4763.60 stddev:489.10 (10.3%) stddev-sans-first:462.49 08:23:51 INFO - PROCESS | 15589 | Values: 2572.8 2588.7 2625.3 2631.2 2636.0 4573.8 4661.5 4714.6 4725.6 4732.9 4680.2 4686.3 4710.2 4757.8 4785.0 4302.4 4333.3 4391.6 4423.4 4423.6 4414.3 4474.6 4475.9 4476.6 4493.7 4236.1 4316.1 4316.2 4365.7 4407.7 4227.6 4255.7 4267.0 4284.0 4343.9 4239.5 4249.3 4250.6 4306.5 4311.4 4597.1 4602.7 4632.8 4637.8 4678.4 4888.1 4931.0 4956.9 5006.7 5039.2 5110.9 5115.2 5117.7 5142.0 5158.6 4749.3 4757.2 4758.1 4758.4 4817.1 4995.4 5037.9 5092.6 5193.2 5269.4 4896.0 4963.2 4963.4 4976.7 5022.0 5031.4 5037.8 5038.5 5044.1 5099.4 4865.9 4931.4 5011.0 5022.0 5086.4 4915.5 4960.6 4960.7 4965.5 4976.1 4221.0 4291.3 4297.5 4299.1 4315.7 3704.6 3716.6 3818.3 3829.4 3830.5 4305.7 4313.8 4315.3 4358.0 4361.7 4914.7 5003.1 5051.9 5054.5 5065.4 4251.7 4262.9 4286.6 4302.8 4313.1 4522.6 4535.3 4541.9 4557.1 4611.3 4618.4 4699.7 4705.9 4708.6 4724.8 4980.4 5031.6 5096.9 5105.7 5172.9 4728.9 4757.7 4763.6 4770.9 4825.2 5033.7 5034.5 5035.2 5036.8 5101.1 4897.3 4965.5 5017.9 5065.5 5091.4 4938.3 4941.6 4941.7 4944.0 4989.5 4934.9 4938.9 4939.1 4939.8 4989.0 4690.9 4753.9 4793.4 4833.8 4920.3 4935.8 4936.1 4939.8 4987.4 4996.8 4797.9 4835.5 4839.5 4883.7 4889.3 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | [#1] ext.html Cycles:180 Average:43488.46 Median:35377.82 stddev:78956.06 (223.2%) stddev-sans-first:79111.80 08:23:51 INFO - PROCESS | 15589 | Values: 572.7 576.4 580.5 585.6 585.7 27598.0 36452.6 37445.4 37533.0 37899.0 38639.8 39044.0 39095.6 39119.6 39186.4 7689.7 7840.4 7849.8 7851.8 7853.4 7624.6 7703.5 7706.3 7707.2 7709.8 7732.3 7796.3 7801.5 7804.5 7808.2 7730.6 7749.0 7770.3 7771.0 7778.8 7700.5 7719.4 7778.7 7779.8 7788.7 37521.0 37926.0 37934.8 37943.6 37973.0 2470.6 2508.9 2707.6 2794.0 2854.5 22606.5 22856.9 22882.5 23024.5 23237.4 3287.2 3333.2 3348.6 3348.7 3367.3 240354.0 241235.0 241407.8 241458.0 241774.0 51406.5 51600.7 51601.5 51614.7 51686.0 31823.2 33194.5 33228.7 34258.8 34303.0 11508.0 11512.4 11513.3 11519.2 11522.9 7499.6 7648.2 7661.9 7748.0 7776.0 17434.3 17612.1 17621.5 17650.3 17800.6 6739.9 6759.1 6776.8 6854.9 6872.6 750.0 889.5 901.6 919.8 960.3 24347.9 25560.7 26109.2 26154.6 26162.9 887.8 896.9 933.4 982.9 1027.7 13481.9 14104.3 14259.6 14377.9 14417.9 369639.0 371588.0 371703.0 371721.0 373157.0 47428.0 47996.8 48062.5 48110.3 48161.8 957.0 1059.5 1114.9 1134.0 1174.9 26785.6 28089.7 28654.3 28664.3 29479.9 39624.8 39882.2 40015.8 40016.8 40041.8 270061.0 270460.0 270466.0 271019.0 272194.0 24088.6 25030.5 25271.5 25278.6 26474.3 37400.8 37551.4 38542.4 38604.8 38787.8 32315.4 32452.0 32503.3 32511.0 33704.7 32695.7 32994.7 33253.0 33355.3 33873.0 32314.7 32972.5 33090.3 33267.3 33313.0 25425.6 27350.5 28862.6 29108.7 29909.9 22996.4 23340.0 23431.3 23596.2 23800.2 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | [#2] jquery.html Cycles:180 Average:23691.45 Median:4954.65 stddev:58565.25 (1182.0%) stddev-sans-first:58703.26 08:23:51 INFO - PROCESS | 15589 | Values: 326.5 342.6 352.4 352.5 371.0 12341.7 13247.7 15355.1 15522.3 16018.1 15529.9 15619.6 15754.9 15852.4 15853.6 4727.6 4835.2 4953.3 4953.7 4955.6 3701.4 5004.5 5016.1 5016.3 5021.2 5005.3 5010.5 5012.5 5014.1 5015.4 4761.5 4949.8 4972.6 4973.9 4974.2 4458.2 4462.7 4470.0 4473.8 4474.2 18955.0 19688.8 19786.2 19822.1 20827.8 1749.7 1834.2 1916.5 2037.7 2126.8 12310.4 13563.3 13758.7 14141.6 14792.3 1802.5 1849.4 1855.2 1885.1 1927.8 74817.0 79713.0 79791.0 81233.6 83988.0 15920.6 16063.8 16153.9 16322.5 16441.6 27484.5 27628.9 27662.2 27669.2 27743.4 7954.6 7961.4 8000.2 8002.8 8278.7 6384.5 6488.9 6625.7 6627.5 6674.7 8070.8 8097.4 8106.7 8111.3 8357.5 3000.6 3003.9 3110.8 3185.1 3221.9 822.7 831.3 843.8 860.7 877.9 15771.4 16552.7 16583.5 16720.3 16906.3 764.0 803.2 803.7 804.2 839.3 7227.3 8912.8 9208.6 9398.8 9401.7 350701.0 351610.0 352155.0 353153.0 353536.0 71494.9 72396.0 72662.3 74298.3 75061.6 864.3 882.7 886.2 888.6 890.3 14498.2 14520.3 14522.4 14558.0 15021.6 35079.1 36022.3 36815.6 37451.6 37606.2 48802.5 48971.3 49168.3 49203.5 49245.3 6534.7 6647.7 6791.7 6803.9 7138.5 9856.5 10000.6 10076.5 10366.6 10502.9 8431.4 8496.6 8567.0 8790.9 8857.4 8222.2 8368.2 8696.9 8703.0 9231.3 8213.8 8569.3 8887.3 8946.3 9141.7 6637.3 6695.0 6740.9 6827.3 6945.5 6788.4 7615.7 8285.9 8687.3 8911.0 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | [#3] mootools.html Cycles:180 Average:4735.39 Median:5040.42 stddev:2665.15 (52.9%) stddev-sans-first:2659.30 08:23:51 INFO - PROCESS | 15589 | Values: 1188.2 1332.3 1352.1 1407.3 1651.3 6429.6 6915.7 7032.0 7341.2 7346.4 7419.7 7479.6 7487.1 7489.8 7503.2 2074.0 2105.9 2108.1 2109.4 2109.4 2061.1 2084.0 2101.2 2111.7 2113.6 2095.1 2102.0 2115.1 2122.6 2139.9 2044.3 2052.2 2053.2 2055.9 2058.4 2013.7 2014.7 2044.8 2050.0 2055.2 7281.8 7382.8 7452.6 7492.1 7504.5 4010.7 4213.8 4215.0 4261.2 4268.4 2593.2 2685.7 2711.3 2722.3 2724.5 786.1 791.3 807.6 809.7 811.4 9815.6 9969.8 9985.5 10021.0 10021.4 3686.1 3783.0 3916.8 3945.0 3968.5 7744.0 7752.2 7755.0 7755.9 7761.7 4137.8 4147.4 4150.1 4151.6 4155.8 3341.0 3481.8 3600.9 3763.4 3769.1 3185.9 3236.8 3289.6 3299.9 3334.1 972.0 975.2 991.2 996.8 1001.1 685.3 705.7 717.2 732.7 741.7 4790.6 4856.0 4884.2 4896.3 4911.9 354.2 368.8 370.0 373.2 375.1 3328.3 3336.4 3402.4 3412.0 3495.0 8391.5 8679.3 8744.7 8787.5 8809.4 8636.4 8637.0 8652.2 8652.5 8658.6 6749.4 6823.0 6825.9 6830.5 6831.3 4854.3 4952.4 5016.9 5064.0 5136.4 8052.8 8155.0 8427.2 8474.6 8563.7 7914.2 8091.6 8476.3 8631.8 8671.2 6087.6 6782.0 6855.4 6940.3 6940.8 6350.4 6493.7 6613.7 6870.9 6920.8 6272.4 6334.0 6379.6 6403.3 6492.0 6148.9 6202.4 6237.0 6266.3 6358.6 5598.2 5757.5 5764.0 5767.3 5772.7 4139.2 4172.4 4253.5 4324.4 4481.7 4273.0 4300.8 4324.6 4376.4 4425.7 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | [#4] prototype.html Cycles:180 Average:4158.30 Median:4775.52 stddev:1216.96 (25.5%) stddev-sans-first:1184.91 08:23:51 INFO - PROCESS | 15589 | Values: 272.6 277.9 281.3 286.3 287.3 4645.5 4781.8 4800.1 4862.2 4866.6 4617.9 4761.8 4764.5 4772.2 4778.9 3758.5 3765.5 3770.6 3771.2 3779.4 3570.6 3617.7 3669.8 3765.5 3781.1 3723.3 3744.2 3747.5 3755.2 3759.2 3719.2 3720.4 3726.6 3727.5 3745.9 3257.8 3260.4 3274.7 3282.2 3283.6 4541.0 4636.5 4644.1 4649.9 4659.4 4180.2 4210.4 4217.8 4220.7 4225.6 4961.5 4972.4 4993.2 4995.8 5000.3 3484.4 3521.9 3524.3 3530.9 3587.2 5174.5 5176.9 5179.8 5180.5 5183.2 3627.4 3641.0 3642.9 3647.8 3649.9 3700.3 3702.7 3707.4 3709.2 3736.4 3965.7 4167.8 4168.5 4175.9 4180.6 4951.8 4964.5 4965.0 4983.3 5004.2 1157.7 1196.8 1232.9 1246.9 1250.3 805.9 830.4 836.6 843.7 845.8 4375.5 4387.9 4392.4 4427.6 4452.8 5150.9 5161.6 5162.0 5162.5 5165.4 4258.0 4438.7 4466.3 4486.2 4511.7 2751.5 2771.6 2776.0 2778.8 2782.7 4825.8 4861.6 4880.2 4883.5 4886.6 5181.4 5271.8 5283.7 5290.5 5297.8 4836.6 4865.8 4876.6 4884.3 4884.9 5008.7 5193.6 5195.0 5197.7 5203.6 5058.1 5064.0 5081.6 5086.4 5105.7 4861.9 4868.9 4871.2 4871.6 4906.7 3604.9 3616.6 3620.7 3637.9 3641.8 4975.3 5126.6 5137.2 5151.8 5168.6 4989.4 4993.7 5003.8 5034.2 5062.4 4896.7 5030.7 5056.7 5059.3 5077.7 4708.4 4874.4 4914.1 4952.2 4974.0 4968.3 5125.3 5125.4 5126.6 5131.5 4990.3 5004.7 5011.2 5013.9 5016.0 08:23:51 INFO - PROCESS | 15589 | 08:23:51 INFO - PROCESS | 15589 | [#5] yui.html Cycles:180 Average:15807.49 Median:59309.20 stddev:22980.21 (38.7%) stddev-sans-first:23016.20 08:23:51 INFO - PROCESS | 15589 | Values: 571.4 585.1 597.3 613.9 655.2 10618.2 11503.1 11507.0 11508.8 11520.9 10923.2 12199.7 12223.0 12264.1 12325.2 600.0 733.9 750.9 751.5 752.5 626.8 730.1 759.2 765.3 767.1 797.6 800.0 800.2 801.8 802.0 637.8 657.5 782.0 783.3 783.7 567.6 583.5 587.3 588.0 588.6 10907.0 10907.5 10915.7 10945.7 10959.3 12021.3 12462.0 12626.2 12708.4 12898.7 11668.3 11942.8 12001.5 12044.2 12651.7 4213.3 4224.0 4240.0 4434.3 4437.0 59177.4 60120.4 60297.4 60682.4 61695.4 10190.3 10248.2 10278.4 10457.9 10856.5 18250.3 18273.6 18302.3 18305.0 18322.5 6240.9 6279.3 6316.2 6478.1 6538.1 3450.9 3502.4 3560.3 3601.8 3630.2 2521.6 2565.2 2568.1 2573.5 2605.1 451.8 455.5 457.8 467.9 470.5 361.7 421.1 423.7 440.4 455.1 6983.1 7319.9 7539.5 7608.8 7724.2 381.6 393.0 481.8 485.4 492.6 2977.2 3303.2 3394.0 3485.9 3631.5 52724.0 54635.5 72839.0 101798.0 102233.0 48163.5 59441.0 72568.3 84927.0 85677.0 75165.5 76614.2 77715.6 78162.0 80316.0 6352.9 6355.1 6479.1 6490.5 6667.8 43149.0 45189.3 46011.5 46522.8 47337.5 35727.6 36378.6 53661.0 63597.4 66191.3 8503.7 8953.8 9033.3 9245.7 9256.5 9490.5 9586.9 9616.3 9666.3 9685.0 8741.3 8806.9 8980.3 9085.4 9144.1 7633.4 8487.0 8795.8 9110.8 9159.3 9018.8 9121.1 9200.6 9367.2 9370.0 7303.8 7383.9 7447.7 7645.4 7704.7 7051.3 7343.0 7370.0 7404.9 7422.8 08:23:51 INFO - PROCESS | 15589 | -------- Summary: end -------- 08:23:51 INFO - PROCESS | 15589 | 08:23:52 INFO - TEST-INFO | 15589: exit 0 08:23:52 INFO - TEST-OK | dromaeo_css | took 1124001ms 08:23:52 INFO - TEST-START | kraken 08:23:52 INFO - operating with platform_type : linux_ 08:23:52 INFO - Initialising browser for kraken test... 08:23:52 INFO - TEST-INFO | started process 15897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJMxCyx/profile http://localhost:33424/getInfo.html) 08:23:57 INFO - PROCESS | 15897 | __metrics Screen width/height:1600/1200 08:23:57 INFO - PROCESS | 15897 | colorDepth:24 08:23:57 INFO - PROCESS | 15897 | Browser inner width/height: 1024/697 08:23:57 INFO - PROCESS | 15897 | __metrics 08:23:57 INFO - PROCESS | 15897 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:57 INFO - PROCESS | 15897 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:58 INFO - PROCESS | 15897 | console.error: PushService: 08:23:58 INFO - PROCESS | 15897 | stateChangeProcessEnqueue: Error transitioning state 08:23:58 INFO - PROCESS | 15897 | UnknownError 08:23:59 INFO - TEST-INFO | 15897: exit 0 08:23:59 INFO - Browser initialized. 08:23:59 INFO - Running cycle 1/1 for kraken test... 08:23:59 INFO - TEST-INFO | started process 15977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJMxCyx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:11 INFO - PROCESS | 15977 | RSS: Main: 175665152 08:24:11 INFO - PROCESS | 15977 | 08:24:14 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33424/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:15 INFO - PROCESS | 15977 | RSS: Main: 237785088 08:24:15 INFO - PROCESS | 15977 | 08:24:17 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33424/tests/kraken/driver.html?testName=audio-dft) 08:24:18 INFO - PROCESS | 15977 | RSS: Main: 218963968 08:24:18 INFO - PROCESS | 15977 | 08:24:21 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33424/tests/kraken/driver.html?testName=audio-fft) 08:24:22 INFO - PROCESS | 15977 | RSS: Main: 300949504 08:24:22 INFO - PROCESS | 15977 | 08:24:24 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33424/tests/kraken/driver.html?testName=audio-oscillator) 08:24:25 INFO - PROCESS | 15977 | RSS: Main: 212193280 08:24:25 INFO - PROCESS | 15977 | 08:24:27 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:28 INFO - PROCESS | 15977 | RSS: Main: 214401024 08:24:28 INFO - PROCESS | 15977 | 08:24:31 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33424/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:31 INFO - PROCESS | 15977 | RSS: Main: 250257408 08:24:31 INFO - PROCESS | 15977 | 08:24:35 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33424/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:35 INFO - PROCESS | 15977 | RSS: Main: 250019840 08:24:35 INFO - PROCESS | 15977 | 08:24:38 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33424/tests/kraken/driver.html?testName=json-parse-financial) 08:24:39 INFO - PROCESS | 15977 | RSS: Main: 249688064 08:24:39 INFO - PROCESS | 15977 | 08:24:41 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:41 INFO - PROCESS | 15977 | RSS: Main: 212058112 08:24:41 INFO - PROCESS | 15977 | 08:24:43 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:44 INFO - PROCESS | 15977 | RSS: Main: 218689536 08:24:44 INFO - PROCESS | 15977 | 08:24:46 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:47 INFO - PROCESS | 15977 | RSS: Main: 228442112 08:24:47 INFO - PROCESS | 15977 | 08:24:49 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:50 INFO - PROCESS | 15977 | RSS: Main: 237322240 08:24:50 INFO - PROCESS | 15977 | 08:24:53 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:54 INFO - PROCESS | 15977 | RSS: Main: 233005056 08:24:54 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | Cycle 1(1): loaded http://localhost:33424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33424/tests/kraken/driver.html?testName=ai-astar) 08:24:56 INFO - PROCESS | 15977 | RSS: Main: 284078080 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | __start_tp_report 08:24:56 INFO - PROCESS | 15977 | _x_x_mozilla_page_load 08:24:56 INFO - PROCESS | 15977 | _x_x_mozilla_page_load_details 08:24:56 INFO - PROCESS | 15977 | |i|pagename|runs| 08:24:56 INFO - PROCESS | 15977 | |0;ai-astar;113;115;116;115;115;115;115;114;116;113 08:24:56 INFO - PROCESS | 15977 | |1;audio-beat-detection;153;127;126;185;132;132;135;130;162;125 08:24:56 INFO - PROCESS | 15977 | |2;audio-dft;161;161;161;162;161;160;161;161;161;161 08:24:56 INFO - PROCESS | 15977 | |3;audio-fft;76;76;75;109;77;77;78;77;98;75 08:24:56 INFO - PROCESS | 15977 | |4;audio-oscillator;86;84;117;84;85;83;121;83;83;121 08:24:56 INFO - PROCESS | 15977 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;117;117 08:24:56 INFO - PROCESS | 15977 | |6;imaging-darkroom;148;145;147;147;147;147;147;147;147;147 08:24:56 INFO - PROCESS | 15977 | |7;imaging-desaturate;95;94;95;95;95;95;97;94;96;95 08:24:56 INFO - PROCESS | 15977 | |8;json-parse-financial;64;64;66;63;65;66;65;65;65;65 08:24:56 INFO - PROCESS | 15977 | |9;json-stringify-tinderbox;65;67;66;66;67;66;65;66;65;66 08:24:56 INFO - PROCESS | 15977 | |10;stanford-crypto-aes;84;84;83;83;84;91;83;83;85;83 08:24:56 INFO - PROCESS | 15977 | |11;stanford-crypto-ccm;138;153;139;139;139;138;138;139;176;145 08:24:56 INFO - PROCESS | 15977 | |12;stanford-crypto-pbkdf2;178;182;174;173;173;174;172;174;172;177 08:24:56 INFO - PROCESS | 15977 | |13;stanford-crypto-sha256-iterative;73;73;74;69;70;70;69;71;69;68 08:24:56 INFO - PROCESS | 15977 | __end_tp_report 08:24:56 INFO - PROCESS | 15977 | __start_cc_report 08:24:56 INFO - PROCESS | 15977 | _x_x_mozilla_cycle_collect,1940 08:24:56 INFO - PROCESS | 15977 | __end_cc_report 08:24:56 INFO - PROCESS | 15977 | __startTimestamp1475767496287__endTimestamp 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | ------- Summary: start ------- 08:24:56 INFO - PROCESS | 15977 | Number of tests: 14 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.06 (0.9%) stddev-sans-first:0.93 08:24:56 INFO - PROCESS | 15977 | Values: 113.0 115.0 116.0 115.0 115.0 115.0 115.0 114.0 116.0 113.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:133.50 stddev:19.77 (14.8%) stddev-sans-first:20.46 08:24:56 INFO - PROCESS | 15977 | Values: 153.0 127.0 126.0 185.0 132.0 132.0 135.0 130.0 162.0 125.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 08:24:56 INFO - PROCESS | 15977 | Values: 161.0 161.0 161.0 162.0 161.0 160.0 161.0 161.0 161.0 161.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.76 (15.3%) stddev-sans-first:12.29 08:24:56 INFO - PROCESS | 15977 | Values: 76.0 76.0 75.0 109.0 77.0 77.0 78.0 77.0 98.0 75.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.50 stddev:17.29 (20.7%) stddev-sans-first:18.05 08:24:56 INFO - PROCESS | 15977 | Values: 86.0 84.0 117.0 84.0 85.0 83.0 121.0 83.0 83.0 121.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:24:56 INFO - PROCESS | 15977 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 08:24:56 INFO - PROCESS | 15977 | Values: 148.0 145.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 08:24:56 INFO - PROCESS | 15977 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 97.0 94.0 96.0 95.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 08:24:56 INFO - PROCESS | 15977 | Values: 64.0 64.0 66.0 63.0 65.0 66.0 65.0 65.0 65.0 65.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 08:24:56 INFO - PROCESS | 15977 | Values: 65.0 67.0 66.0 66.0 67.0 66.0 65.0 66.0 65.0 66.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.45 (2.9%) stddev-sans-first:2.60 08:24:56 INFO - PROCESS | 15977 | Values: 84.0 84.0 83.0 83.0 84.0 91.0 83.0 83.0 85.0 83.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:139.00 stddev:12.08 (8.7%) stddev-sans-first:12.58 08:24:56 INFO - PROCESS | 15977 | Values: 138.0 153.0 139.0 139.0 139.0 138.0 138.0 139.0 176.0 145.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.00 stddev:3.18 (1.8%) stddev-sans-first:3.17 08:24:56 INFO - PROCESS | 15977 | Values: 178.0 182.0 174.0 173.0 173.0 174.0 172.0 174.0 172.0 177.0 08:24:56 INFO - PROCESS | 15977 | 08:24:56 INFO - PROCESS | 15977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:2.07 (2.9%) stddev-sans-first:2.00 08:24:56 INFO - PROCESS | 15977 | Values: 73.0 73.0 74.0 69.0 70.0 70.0 69.0 71.0 69.0 68.0 08:24:56 INFO - PROCESS | 15977 | -------- Summary: end -------- 08:24:56 INFO - PROCESS | 15977 | 08:24:57 INFO - TEST-INFO | 15977: exit 0 08:24:57 INFO - TEST-OK | kraken | took 65113ms 08:24:57 INFO - SUITE-END | took 1189s 08:24:57 INFO - Completed test suite (00:19:49) 08:24:57 INFO - javascript benchmark 08:24:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.80703947204, 2588.728183540727, 2625.3174174714572, 2631.1711810779602, 2635.9604605930904, 4573.817047318112, 4661.533846615337, 4714.622830173586, 4725.621950243981, 4732.881677958048, 4680.157571637113, 4686.2736275877205, 4710.152172608938, 4757.762111894409, 4785.0, 4302.376155457472, 4333.306670932651, 4391.5827996340295, 4423.424954755893, 4423.623991960671, 4414.337849322611, 4474.597286244238, 4475.888102797424, 4476.574725401098, 4493.68544201906, 4236.06806502572, 4316.115196384733, 4316.158349121923, 4365.672574556905, 4407.735535867858, 4227.640650544708, 4255.723377980421, 4267.039916018902, 4283.957160428387, 4343.869683909456, 4239.47006624172, 4249.32010878258, 4250.638695710868, 4306.5262821089655, 4311.417958575584, 4597.126545956257, 4602.723836569817, 4632.837850675244, 4637.814487420499, 4678.415198100238, 4888.095702295087, 4930.950690493085, 4956.925646115311, 5006.724630145341, 5039.168537191359, 5110.923336149961, 5115.155999260118, 5117.667351622133, 5141.974290128563, 5158.561522270612, 4749.2876068589985, 4757.167495688241, 4758.119747846659, 4758.381410416693, 4817.108834865561, 4995.425526064549, 5037.874053148701, 5092.6435149539175, 5193.221016847503, 5269.420363759983, 4896.0, 4963.181075122637, 4963.429205641325, 4976.701397916137, 5021.974890125526, 5031.421386540522, 5037.7733002014265, 5038.546530812245, 5044.117279476077, 5099.36257967754, 4865.9026819464125, 4931.408231012301, 5010.974945125251, 5021.974890125599, 5086.440491545927, 4915.508449155056, 4960.553550180429, 4960.677555958851, 4965.453800081988, 4976.054549635558, 4220.957790422057, 4291.270484017725, 4297.462817147856, 4299.097189590221, 4315.741055536615, 3704.6110158433517, 3716.6283371662616, 3818.3317919364, 3829.4064420014943, 3830.4637350770913, 4305.677074219446, 4313.784310784448, 4315.28797748368, 4357.9782101089295, 4361.738295702268, 4914.680545764514, 5003.149464591028, 5051.873703157377, 5054.469280725544, 5065.366829146356, 4251.702380833312, 4262.914741705211, 4286.592773686495, 4302.806373713191, 4313.1158112586845, 4522.615577675934, 4535.274356103007, 4541.931871021871, 4557.111363284128, 4611.308303754464, 4618.399608050931, 4699.741514216614, 4705.858824235278, 4708.576228139484, 4724.811007559797, 4980.377452818398, 5031.647784655039, 5096.923546146885, 5105.744712764421, 5172.948270517247, 4728.858134255978, 4757.666963312673, 4763.595094417014, 4770.928436073531, 4825.227963525819, 5033.677772670167, 5034.471380504994, 5035.16919708244, 5036.823711170092, 5101.107306221471, 4897.2654101885, 4965.503449655005, 5017.874553136201, 5065.493450655053, 5091.363579552556, 4938.308636790924, 4941.629377796751, 4941.678790878582, 4943.97528012372, 4989.476105009067, 4934.925976110289, 4938.851834444972, 4939.135651260943, 4939.827106051271, 4988.9501104988485, 4690.882727931829, 4753.857384278477, 4793.400824896888, 4833.782479788348, 4920.261960705922, 4935.777889995031, 4936.136176169084, 4939.753012349296, 4987.376577927759, 4996.800127994839, 4797.856064318076, 4835.516448355136, 4839.516048395132, 4883.706977581356, 4889.291052797395], "value": 4624.5226732673145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.6564061563063, 576.3861487515795, 580.465971306398, 585.5871610514587, 585.7217821534772, 27598.0, 36452.635473645256, 37445.43831842518, 37533.0, 37899.0, 38639.806800965955, 39044.0, 39095.60904390955, 39119.60880391195, 39186.412203816966, 7689.692412303515, 7840.372770178372, 7849.8037549061155, 7851.782973639095, 7853.371730261594, 7624.6187690615525, 7703.5377877327255, 7706.306432421081, 7707.229277072304, 7709.768706938801, 7732.30409263169, 7796.259355361231, 7801.531908085504, 7804.453688241825, 7808.219178082203, 7730.574818384986, 7748.961255193688, 7770.261825126576, 7771.028621422322, 7778.805529861742, 7700.499467534648, 7719.421043421766, 7778.6888524458955, 7779.7666070017995, 7788.727394541221, 37521.0, 37926.0, 37934.81032594847, 37943.620563794284, 37973.0, 2470.5800013997664, 2508.912188073427, 2707.5803250496206, 2793.9580906286424, 2854.5290027145497, 22606.54786904269, 22856.885715571316, 22882.542349152925, 23024.53950920972, 23237.419064523354, 3287.211069343364, 3333.183370074323, 3348.614909285415, 3348.68187522185, 3367.2928684976187, 240354.0, 241235.0, 241407.79296103583, 241458.0, 241774.0, 51406.48593514092, 51600.74199628978, 51601.48398516042, 51614.74192629013, 51686.0, 31823.204419889687, 33194.50208246878, 33228.66771332304, 34258.828705856315, 34303.0, 11508.0, 11512.424378781028, 11513.251638643462, 11519.19365644397, 11522.942385288019, 7499.550026998289, 7648.196939321291, 7661.923380766121, 7747.992760941154, 7775.961120194476, 17434.302627894995, 17612.119394030247, 17621.47135585909, 17650.323219294147, 17800.617882602262, 6739.887918493394, 6759.121314229119, 6776.7628133015105, 6854.897176542356, 6872.62200578963, 749.9587522686196, 889.5196593839383, 901.6032945504088, 919.8022425178618, 960.3469640644429, 24347.878260608937, 25560.744392556207, 26109.216723498324, 26154.6076808848, 26162.86918565433, 887.8135591525852, 896.9058248883904, 933.3793027636682, 982.8574856645746, 1027.6896956380674, 13481.865181348061, 14104.294785260696, 14259.575872101768, 14377.928110359382, 14417.927910360591, 369639.0, 371588.0, 371703.0, 371721.0, 373157.0, 47428.0, 47996.760016199696, 48062.51937480651, 48110.27834582484, 48161.75919120452, 956.990375154205, 1059.4543809937888, 1114.9498272577753, 1133.994330028361, 1174.8766379530027, 26785.598216026385, 28089.71910280871, 28654.283642909093, 28664.28339291451, 29479.85260073686, 39624.80187599044, 39882.2023559533, 40015.79992100137, 40016.79991600024, 40041.799791000856, 270061.0, 270460.0, 270466.0, 271019.0, 272194.0, 24088.63867041961, 25030.499390011733, 25271.49457010886, 25278.620820687338, 26474.338141546614, 37400.812995934844, 37551.43672844964, 38542.42186367151, 38604.80697596494, 38787.80606096952, 32315.35369292648, 32452.0, 32503.349933001682, 32511.0, 33704.66295337015, 32695.673043269264, 32994.67005330012, 33253.0, 33355.332893342485, 33873.0, 32314.676853232108, 32972.50541241835, 33090.33819323552, 33267.33465330728, 33313.0, 25425.643668364675, 27350.452990940466, 28862.567061493675, 29108.741620551682, 29909.850450748476, 22996.4250893729, 23340.014094573373, 23431.297061087513, 23596.17413390523, 23800.166994155814], "value": 16154.762282144073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.53631842783244, 342.5666531837228, 352.42202787428613, 352.50121078673686, 370.9610490898456, 12341.69145771355, 13247.7350452991, 15355.078695278276, 15522.30149643266, 16018.119003454805, 15529.922350388233, 15619.609509762262, 15754.921225393857, 15852.3659053638, 15853.603659908507, 4727.598154156901, 4835.178019736653, 4953.257011448276, 4953.678010929278, 4955.628327875405, 3701.4262789267573, 5004.474530174334, 5016.072026675077, 5016.3227964224725, 5021.221710634839, 5005.299258103868, 5010.49685094472, 5012.498750124995, 5014.122528557488, 5015.39815222172, 4761.47623761386, 4949.7772600233075, 4972.602191824645, 4973.875653108665, 4974.1543937530705, 4458.197524445631, 4462.665300102472, 4470.0, 4473.82104715811, 4474.172278128524, 18955.0, 19688.803111968984, 19786.208551657917, 19822.10800513966, 20827.791722082737, 1749.6850566897954, 1834.2479583370755, 1916.549610841451, 2037.724907137547, 2126.7873212678765, 12310.446029928675, 13563.254021028839, 13758.65603359914, 14141.575752727435, 14792.260386980608, 1802.5493626593352, 1849.3897013985352, 1855.239351865742, 1885.1422602715732, 1927.8264956154014, 74817.0, 79713.0, 79791.0, 81233.59383203105, 83988.0, 15920.601984950468, 16063.839361606468, 16153.911517871833, 16322.510324690278, 16441.58896027585, 27484.450310994067, 27628.861855690993, 27662.170134895987, 27669.169924902286, 27743.44513109767, 7954.5624990626075, 7961.36309095271, 8000.239977202156, 8002.759917202493, 8278.71024514139, 6384.521160912857, 6488.870222595521, 6625.701843417058, 6627.5029372797235, 6674.733010679518, 8070.757877263692, 8097.433179677366, 8106.675732970615, 8111.269985701315, 8357.498550087013, 3000.6099207103375, 3003.9233695055286, 3110.751139908802, 3185.0604071798875, 3221.855016524215, 822.6956026270318, 831.2767891934056, 843.8144407108023, 860.7159637319669, 877.9473231606124, 15771.369145234063, 16552.66894662124, 16583.50249492517, 16720.331186752635, 16906.323747050224, 763.9579823109782, 803.1566854802434, 803.7227156630953, 804.2199066905092, 839.3243439031638, 7227.349538541556, 8912.777180570538, 9208.631654733736, 9398.812023759487, 9401.670941517013, 350701.0, 351610.0, 352155.0, 353153.0, 353536.0, 71494.9275760864, 72396.0, 72662.27337726555, 74298.25701742913, 75061.62469187619, 864.2999170671776, 882.6734108379941, 886.1979908183105, 888.5557221389305, 890.3011136258007, 14498.202598856742, 14520.273986300432, 14522.419103235752, 14558.0, 15021.624459388166, 35079.12302192466, 36022.27955440929, 36815.63184368229, 37451.625483744814, 37606.2478750418, 48802.511974881214, 48971.265431019274, 49168.26247606217, 49203.53982300799, 49245.261321079495, 6534.693061387837, 6647.734090636321, 6791.72833086671, 6803.89794153098, 7138.46461515378, 9856.457894815567, 10000.649977251052, 10076.496175191065, 10366.637167699095, 10502.894971050191, 8431.367647426345, 8496.617652205789, 8566.957165214384, 8790.912090879265, 8857.424267422597, 8222.218889205516, 8368.20502052304, 8696.869546956674, 8702.956485217534, 9231.261499079923, 8213.83572328562, 8569.271611913056, 8887.289016878764, 8946.284297256334, 9141.725748227564, 6637.336266373324, 6694.966525167343, 6740.865182696417, 6827.283135270924, 6945.513814032969, 6788.355106264897, 7615.6953721850505, 8285.917140828757, 8687.348448866487, 8910.955445222733], "value": 8330.066142031847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.203903384732, 1332.273910718658, 1352.1211212711737, 1407.303384824512, 1651.3477176515269, 6429.614223146615, 6915.654217289134, 7031.964840175805, 7341.192468828424, 7346.449016323771, 7419.740309089183, 7479.62601869907, 7487.138979017414, 7489.812754681122, 7503.2121627229035, 2073.9792602073935, 2105.947351316214, 2108.051376880402, 2109.4199095248778, 2109.440998135495, 2061.1127837361655, 2084.0, 2101.2015434135005, 2111.7043613894066, 2113.608982338272, 2095.140992193201, 2101.957960840782, 2115.1010820401343, 2122.564874200793, 2139.9251026214088, 2044.3253726270295, 2052.2406709517427, 2053.158205135902, 2055.876647401161, 2058.4442200605904, 2013.6778115501595, 2014.74815648044, 2044.795520447958, 2050.0, 2055.1779288284656, 7281.817954551178, 7382.778516644509, 7452.627368631601, 7492.100947886234, 7504.512206706547, 4010.6991975601654, 4213.768242746648, 4214.978925105354, 4261.169072030955, 4268.445102136733, 2593.1831473085917, 2685.7179996100517, 2711.3221694576355, 2722.3058120179226, 2724.523208438515, 786.1431040166246, 791.3431851563189, 807.6325272001226, 809.7004108479841, 811.377245508982, 9815.558299876522, 9969.80060398788, 9985.450800205987, 10021.048000439947, 10021.44882031488, 3686.1153323202775, 3783.0, 3916.8433262669746, 3944.980275098606, 3968.503937007874, 7743.9612801936755, 7752.186020467882, 7755.0, 7755.92244077552, 7761.72833950809, 4137.77242251679, 4147.3986271991, 4150.107726838744, 4151.584841515884, 4155.792210389529, 3340.9665903341142, 3481.7736847104857, 3600.9099772505374, 3763.4166704160352, 3769.0577355661085, 3185.865470135015, 3236.7896086754286, 3289.588801399825, 3299.934001320008, 3334.0997930558615, 971.965981190669, 975.2003357247131, 991.1822746234242, 996.8454889492141, 1001.0540039662449, 685.2530741491798, 705.6683358821346, 717.1716667249335, 732.6593134192626, 741.7070257248357, 4790.568848803555, 4856.033306510869, 4884.218525036048, 4896.3389942358035, 4911.926321105187, 354.2136457065362, 368.778732760347, 369.9667029967316, 373.21997026214797, 375.1427987049633, 3328.284418849959, 3336.382769187708, 3402.40457919868, 3411.9829400852836, 3494.965050349515, 8391.454555453876, 8679.262262707614, 8744.69393571222, 8787.516686582172, 8809.383343166044, 8636.352273579507, 8637.0499245083, 8652.178043085896, 8652.480851148952, 8658.567071646392, 6749.380148764261, 6822.965885170543, 6825.863482730318, 6830.453563714891, 6831.316868313228, 4854.262981408311, 4952.4057113146655, 5016.874578135576, 5063.9744102359355, 5136.357955255593, 8052.83894322122, 8154.9806274215725, 8427.199416055464, 8474.618642160995, 8563.743087707378, 7914.24814642608, 8091.595420228848, 8476.321894248322, 8631.784205394915, 8671.21959023691, 6087.57386982907, 6781.966090169518, 6855.4172895304455, 6940.305969403221, 6940.7917762467205, 6350.428461438492, 6493.740250389931, 6613.6693165340575, 6870.931290687029, 6920.826979325557, 6272.40412160844, 6334.0, 6379.617222966451, 6403.263624683221, 6491.967540162269, 6148.877022459616, 6202.4417802398, 6237.033259844731, 6266.279377871603, 6358.554901156875, 5598.21624972496, 5757.453041961007, 5764.0, 5767.307923049261, 5772.6536407815665, 4139.2135494256, 4172.374143878443, 4253.5108462527205, 4324.35134729793, 4481.708688935209, 4272.957270427256, 4300.784960752013, 4324.56754324565, 4376.365427013129, 4425.668074894332], "value": 3735.27694151529, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.63875365141183, 277.9110684580934, 281.3164011452172, 286.3171336362774, 287.2889598244347, 4645.488996210414, 4781.808727650894, 4800.071956106772, 4862.222044472889, 4866.586340161086, 4617.8686221875605, 4761.833335833247, 4764.499182757429, 4772.164871147544, 4778.880527986794, 3758.530183727034, 3765.4728338032696, 3770.622937706228, 3771.17034252464, 3779.3575092234387, 3570.6429357064217, 3617.674409303162, 3669.7981611011382, 3765.4540091686827, 3781.149241420686, 3723.3111874303204, 3744.1762812181278, 3747.494088298086, 3755.192633583779, 3759.191773768639, 3719.163188282642, 3720.441933709938, 3726.6459686329754, 3727.5154229949935, 3745.9250814983684, 3257.800984335564, 3260.4131256373844, 3274.6889045540634, 3282.195862013798, 3283.6372905244293, 4540.954590454086, 4636.5131661175765, 4644.140833945731, 4649.860504184846, 4659.394278743742, 4180.16396720654, 4210.389493523453, 4217.7891105444605, 4220.746755194698, 4225.556316586745, 4961.5286547777905, 4972.428170760337, 4993.226049962262, 4995.825146119904, 5000.349954505928, 3484.372812893678, 3521.894343169709, 3524.3479956208184, 3530.8764193253114, 3587.210813620999, 5174.534291913746, 5176.922346164811, 5179.766910489037, 5180.456052114511, 5183.170692689189, 3627.437747149196, 3640.9635903641156, 3642.908927276839, 3647.7811331319676, 3649.908752281161, 3700.296943580711, 3702.6667599916136, 3707.4068149096015, 3709.221063576625, 3736.4208547675153, 3965.702572307031, 4167.770772607536, 4168.478940132483, 4175.937360939588, 4180.581941805856, 4951.8266860659705, 4964.503549645006, 4965.0, 4983.327250821165, 5004.199328107486, 1157.65270418874, 1196.7785959597502, 1232.9136960412864, 1246.8815462531045, 1250.2935841249664, 805.9435839491297, 830.3730683334044, 836.6028732017545, 843.6583183810567, 845.7970087179033, 4375.453068366454, 4387.912241755211, 4392.363107349416, 4427.645788336926, 4452.8218871245435, 5150.922736158961, 5161.612879034087, 5162.045021671003, 5162.509561591718, 5165.405978312467, 4257.978710106491, 4438.667099967515, 4466.330050492452, 4486.237339652267, 4511.729296242171, 2751.5047291487726, 2771.5981182728797, 2775.9861200693867, 2778.8054836161273, 2782.692134696689, 4825.831095911626, 4861.611071114302, 4880.243562247857, 4883.4628190898975, 4886.584640305614, 5181.3782346118705, 5271.762770675329, 5283.682979021271, 5290.470952904679, 5297.7880884764945, 4836.564709176191, 4865.756712164378, 4876.561109500162, 4884.316195732529, 4884.92531643038, 5008.749562521786, 5193.558547523503, 5194.97402512985, 5197.740112994411, 5203.635745497931, 5058.1148299048255, 5063.9616230261545, 5081.551757749024, 5086.3896332440345, 5105.744712764421, 4861.878453038702, 4868.853934381974, 4871.244957031666, 4871.585915197106, 4906.73012984275, 3604.9098772530897, 3616.6202548732003, 3620.6560376764164, 3637.927241455209, 3641.8361173746716, 4975.328330675457, 5126.56424203932, 5137.152369858932, 5151.793928242828, 5168.638195326442, 4989.403390915018, 4993.675411098267, 5003.824866129668, 5034.16936205522, 5062.417821950376, 4896.6572339935865, 5030.673006254582, 5056.721880296619, 5059.3422855030085, 5077.669951453144, 4708.411448568929, 4874.4150701916, 4914.140025495595, 4952.232403977389, 4974.030064137603, 4968.3292755479, 5125.282460455614, 5125.410577783603, 5126.589872810241, 5131.4868513148385, 4990.326305948651, 5004.749762511933, 5011.248312753116, 5013.899722005613, 5016.021875734197], "value": 3763.409797045082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4228629084624, 585.1252377695344, 597.2743117112707, 613.8741557980615, 655.1973832055729, 10618.150547956164, 11503.13726470514, 11506.999999999989, 11508.769824603503, 11520.942395288033, 10923.235373523856, 12199.695007624814, 12223.0, 12264.141510094274, 12325.198862073981, 599.9700014999232, 733.886247631618, 750.921153278906, 751.515272649141, 752.4995877741322, 626.8119564130766, 730.1384366447589, 759.2407592407592, 765.334159281426, 767.075673813054, 797.5693125712138, 800.0439474827583, 800.2477670989281, 801.8396320735847, 801.9518828870257, 637.7672149665385, 657.5200103924115, 782.0498094814799, 783.3419927261072, 783.7374479549358, 567.5544697412512, 583.5011065538988, 587.2805812879232, 587.9941200587982, 588.6291636269166, 10907.0, 10907.509162087725, 10915.672529824038, 10945.671629851116, 10959.342439453578, 12021.278723276544, 12462.0, 12626.24242545441, 12708.364581770875, 12898.742025159538, 11668.299902005907, 11942.820857687142, 12001.459934302977, 12044.156909016372, 12651.74696506074, 4213.30480470722, 4224.049588842517, 4240.0, 4434.334849772527, 4436.977815110904, 59177.40822591762, 60120.39879601192, 60297.39702602962, 60682.393176068115, 61695.383046169416, 10190.286679932482, 10248.23138264633, 10278.434686092336, 10457.947710261553, 10856.457177141112, 18250.269989200548, 18273.634527309645, 18302.26790928348, 18305.0, 18322.450326490227, 6240.920967174155, 6279.277883043417, 6316.210473690789, 6478.093066970628, 6538.084668146464, 3450.913727156791, 3502.387082260594, 3560.3235385276716, 3601.8019008954757, 3630.2013557017412, 2521.646969424282, 2565.191964531167, 2568.1011645923777, 2573.5238980788613, 2605.0751983045748, 451.7876597998935, 455.47847714366867, 457.8283143821067, 467.91343601433846, 470.53417117054556, 361.73593276908, 421.090444639577, 423.6610711430843, 440.35268155810905, 455.05802987815565, 6983.092198014328, 7319.890201646979, 7539.547627142389, 7608.771736847903, 7724.188960159215, 381.5612046146953, 392.976421414716, 481.8120932836197, 485.44174199670664, 492.58622756884387, 2977.2408035950693, 3303.174206448388, 3394.0, 3485.89542313731, 3631.473436351767, 52724.0, 54635.45364546383, 72839.0, 101798.0, 102233.0, 48163.518364816606, 59441.0, 72568.27431725615, 84927.0, 85677.0, 75165.52005655035, 76614.23385766182, 77715.61142194252, 78162.0, 80316.0, 6352.936470635234, 6355.1420558224045, 6479.092926990319, 6490.513211509061, 6667.833304167435, 43149.0, 45189.322160166965, 46011.53988460206, 46522.76738616285, 47337.52662473331, 35727.64272357347, 36378.636213637525, 53661.0, 63597.364026359144, 66191.33808661852, 8503.702370417006, 8953.776155596162, 9033.277337813091, 9245.72262832116, 9256.537173141181, 9490.525473726148, 9586.856197156909, 9616.326857119935, 9666.323357364918, 9684.983076776836, 8741.256993155654, 8806.91193088061, 8980.326475514494, 9085.409448385833, 9144.08559144107, 7633.351165150802, 8486.957565212135, 8795.826114662395, 9110.772230694285, 9159.267258619428, 9018.774530636787, 9121.087891210826, 9200.631974720936, 9367.20378767785, 9370.0, 7303.765756666467, 7383.926160738324, 7447.70209191648, 7645.426593005658, 7704.6918123274445, 7051.330123638451, 7342.9632851835395, 7370.0, 7404.888926665996, 7422.777316680508], "value": 5810.406548403923, "unit": "score"}], "name": "dromaeo_css", "value": 6086.435098439415, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 116.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 126.0, 185.0, 132.0, 132.0, 135.0, 130.0, 162.0, 125.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 109.0, 77.0, 77.0, 78.0, 77.0, 98.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 117.0, 84.0, 85.0, 83.0, 121.0, 83.0, 83.0, 121.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 97.0, 94.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 63.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 84.0, 91.0, 83.0, 83.0, 85.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 153.0, 139.0, 139.0, 139.0, 138.0, 138.0, 139.0, 176.0, 145.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 182.0, 174.0, 173.0, 173.0, 174.0, 172.0, 174.0, 172.0, 177.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 69.0, 70.0, 70.0, 69.0, 71.0, 69.0, 68.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1556.5, "alertThreshold": 2.0}]} 08:24:58 INFO - Return code: 0 08:24:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:58 INFO - # TBPL SUCCESS # 08:24:58 INFO - Running post-action listener: _resource_record_post_action 08:24:58 INFO - [mozharness: 2016-10-06 15:24:58.108787Z] Finished run-tests step (success) 08:24:58 INFO - Running post-run listener: _resource_record_post_run 08:24:58 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 390746112; Read time: 0; Write time: 280156 08:24:58 INFO - TinderboxPrint: CPU usage
13.0% 08:24:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:24:58 INFO - TinderboxPrint: I/O write bytes / time
390,746,112 / 280,156 08:24:58 INFO - TinderboxPrint: CPU idle
8,368.0 (87.0%) 08:24:58 INFO - TinderboxPrint: CPU user
1,203.8 (12.5%) 08:24:58 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99995648; Read time: 0; Write time: 124116 08:24:58 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 290750464; Read time: 0; Write time: 156040 08:24:58 INFO - Running post-run listener: _upload_blobber_files 08:24:58 INFO - Blob upload gear active. 08:24:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:24:58 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:58 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:24:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:59 INFO - (blobuploader) - INFO - Done attempting. 08:24:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:02 INFO - (blobuploader) - INFO - Done attempting. 08:25:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:03 INFO - (blobuploader) - INFO - Done attempting. 08:25:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:03 INFO - Return code: 0 08:25:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d71ba386763125478d432ddb680cf28ee2ac25fb76434a283f729d9c5b5e2cbdb4e76287918339333bbf3e5c1726d6c0e9ec188f85b5fb9a804fa3ee8e4324", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a04baa6b0336da66705e05fa377a3f9c6a53f4f81d2f10688703a7aaf5d2b2b69b4e3ee1e70bd3260937e9e9bb4793054b732ff1242495e80ed224d8217ec81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495ee1034647494f17aca990a6381a0ca9f81a220a67b01cb70e7e11bdc23ccb61f051f9daa9c0d3179fd923fadcb5693a65a0e77e3561fe06a118b5ccf4ae0c"} 08:25:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:03 INFO - Contents: 08:25:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d71ba386763125478d432ddb680cf28ee2ac25fb76434a283f729d9c5b5e2cbdb4e76287918339333bbf3e5c1726d6c0e9ec188f85b5fb9a804fa3ee8e4324", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a04baa6b0336da66705e05fa377a3f9c6a53f4f81d2f10688703a7aaf5d2b2b69b4e3ee1e70bd3260937e9e9bb4793054b732ff1242495e80ed224d8217ec81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495ee1034647494f17aca990a6381a0ca9f81a220a67b01cb70e7e11bdc23ccb61f051f9daa9c0d3179fd923fadcb5693a65a0e77e3561fe06a118b5ccf4ae0c"} 08:25:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:03 INFO - Copying logs to upload dir... 08:25:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.642880 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-06 08:25:03.479347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 08:25:03.494122) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d71ba386763125478d432ddb680cf28ee2ac25fb76434a283f729d9c5b5e2cbdb4e76287918339333bbf3e5c1726d6c0e9ec188f85b5fb9a804fa3ee8e4324", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a04baa6b0336da66705e05fa377a3f9c6a53f4f81d2f10688703a7aaf5d2b2b69b4e3ee1e70bd3260937e9e9bb4793054b732ff1242495e80ed224d8217ec81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495ee1034647494f17aca990a6381a0ca9f81a220a67b01cb70e7e11bdc23ccb61f051f9daa9c0d3179fd923fadcb5693a65a0e77e3561fe06a118b5ccf4ae0c"} build_url:https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010068 build_url: 'https://queue.taskcluster.net/v1/task/ar8OAhouSUGW6R9n0X1gnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9d71ba386763125478d432ddb680cf28ee2ac25fb76434a283f729d9c5b5e2cbdb4e76287918339333bbf3e5c1726d6c0e9ec188f85b5fb9a804fa3ee8e4324", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a04baa6b0336da66705e05fa377a3f9c6a53f4f81d2f10688703a7aaf5d2b2b69b4e3ee1e70bd3260937e9e9bb4793054b732ff1242495e80ed224d8217ec81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/495ee1034647494f17aca990a6381a0ca9f81a220a67b01cb70e7e11bdc23ccb61f051f9daa9c0d3179fd923fadcb5693a65a0e77e3561fe06a118b5ccf4ae0c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 08:25:03.518321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:25:03.518652) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475765014.206989-751447128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:25:03.572718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 08:25:03.573065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 08:25:03.576881) ========= ========= Total master_lag: 0.42 =========