builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1479518835.13 results: success (0) buildid: 20161118161321 builduid: acf217084a5243e1b6f44a188ada4bfd revision: f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.126975) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.127434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.127775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.163525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.163829) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 17:27:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.6M=0s 2016-11-18 17:27:15 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125413 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.306816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.307167) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014557 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.357105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:15.357485) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd --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=5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 17:27:15,799 truncating revision to first 12 chars 2016-11-18 17:27:15,799 Setting DEBUG logging. 2016-11-18 17:27:15,799 attempt 1/10 2016-11-18 17:27:15,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/f5bea7e99fdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 17:27:16,100 unpacking tar archive at: graphics-f5bea7e99fdc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:16.018274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:16.018635) ========= script_repo_revision: f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:16.019132) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:16.019495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 17:27:16.042988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-18 17:27:16.043436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:27:16 INFO - MultiFileLogger online at 20161118 17:27:16 in /builds/slave/test 17:27:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 17:27:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:16 INFO - {'append_to_log': False, 17:27:16 INFO - 'base_work_dir': '/builds/slave/test', 17:27:16 INFO - 'blob_upload_branch': 'Graphics', 17:27:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:16 INFO - 'branch': 'Graphics', 17:27:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:16 INFO - 'config_files': ('talos/linux_config.py',), 17:27:16 INFO - 'default_actions': ('clobber', 17:27:16 INFO - 'read-buildbot-config', 17:27:16 INFO - 'download-and-extract', 17:27:16 INFO - 'populate-webroot', 17:27:16 INFO - 'create-virtualenv', 17:27:16 INFO - 'install', 17:27:16 INFO - 'run-tests'), 17:27:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:16 INFO - 'download_minidump_stackwalk': True, 17:27:16 INFO - 'download_symbols': 'ondemand', 17:27:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:16 INFO - 'installer_path': 'installer.exe', 17:27:16 INFO - 'log_level': 'info', 17:27:16 INFO - 'log_name': 'talos', 17:27:16 INFO - 'log_to_console': True, 17:27:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:27:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:27:16 INFO - 'opt_config_files': (), 17:27:16 INFO - 'pip_index': False, 17:27:16 INFO - 'sps_profile': False, 17:27:16 INFO - 'sps_profile_interval': 0, 17:27:16 INFO - 'suite': 'dromaeojs', 17:27:16 INFO - 'system_bits': '32', 17:27:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:16 INFO - 'title': 'talos-linux64-ix-051', 17:27:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:16 INFO - 'use_talos_json': True, 17:27:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:16 INFO - 'work_dir': 'build'} 17:27:16 INFO - [mozharness: 2016-11-19 01:27:16.591108Z] Running clobber step. 17:27:16 INFO - Running pre-action listener: _resource_record_pre_action 17:27:16 INFO - Running main action method: clobber 17:27:16 INFO - rmtree: /builds/slave/test/build 17:27:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:17 INFO - Running post-action listener: _resource_record_post_action 17:27:17 INFO - [mozharness: 2016-11-19 01:27:17.057441Z] Finished clobber step (success) 17:27:17 INFO - [mozharness: 2016-11-19 01:27:17.057542Z] Running read-buildbot-config step. 17:27:17 INFO - Running pre-action listener: _resource_record_pre_action 17:27:17 INFO - Running main action method: read_buildbot_config 17:27:17 INFO - Using buildbot properties: 17:27:17 INFO - { 17:27:17 INFO - "project": "", 17:27:17 INFO - "product": "firefox", 17:27:17 INFO - "script_repo_revision": "default", 17:27:17 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 17:27:17 INFO - "repository": "", 17:27:17 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 17:27:17 INFO - "buildid": "20161118161321", 17:27:17 INFO - "pgo_build": "False", 17:27:17 INFO - "basedir": "/builds/slave/test", 17:27:17 INFO - "buildnumber": 6, 17:27:17 INFO - "slavename": "talos-linux64-ix-051", 17:27:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:27:17 INFO - "platform": "ubuntu64_hw", 17:27:17 INFO - "scheduler": "tests-graphics-linux64-talos", 17:27:17 INFO - "branch": "graphics", 17:27:17 INFO - "repo_path": "projects/graphics", 17:27:17 INFO - "revision": "f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd", 17:27:17 INFO - "stage_platform": "linux64", 17:27:17 INFO - "builduid": "acf217084a5243e1b6f44a188ada4bfd", 17:27:17 INFO - "slavebuilddir": "test" 17:27:17 INFO - } 17:27:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 17:27:17 INFO - Running post-action listener: _resource_record_post_action 17:27:17 INFO - [mozharness: 2016-11-19 01:27:17.059979Z] Finished read-buildbot-config step (success) 17:27:17 INFO - [mozharness: 2016-11-19 01:27:17.060068Z] Running download-and-extract step. 17:27:17 INFO - Running pre-action listener: _resource_record_pre_action 17:27:17 INFO - Running main action method: download_and_extract 17:27:17 INFO - mkdir: /builds/slave/test/build/tests 17:27:17 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')]} 17:27:17 INFO - trying https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:27:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:27:17 INFO - Downloaded 1361 bytes. 17:27:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:27:17 INFO - Using the following test package requirements: 17:27:17 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:27:17 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:27:17 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:27:17 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'jsshell-linux-x86_64.zip'], 17:27:17 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:27:17 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:27:17 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:27:17 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:27:17 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:27:17 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:27:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:27:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:27:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:27:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:27:18 INFO - Http code: 200 17:27:18 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 17:27:18 INFO - x-amz-cf-id: mnAimuAqTbqdUZFTXCmlAtIuq5tdseo6hPZmILGQuRRCNGY9AWzD5Q== 17:27:18 INFO - x-amz-version-id: zQXtIGmyGwZ5tHWfbRmH8tPwupJf5Ohl 17:27:18 INFO - Expected file size: 20320052 17:27:18 INFO - Obtained file size: 20320052 17:27:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:27:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:27:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:27:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:27:23 INFO - Http code: 200 17:27:23 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 17:27:23 INFO - x-amz-cf-id: TWF7vPjEO7wU1UUKFHJAk4N1rgX8PuL8z6HXizN3NSGcZZdcVASWLg== 17:27:23 INFO - x-amz-version-id: zQXtIGmyGwZ5tHWfbRmH8tPwupJf5Ohl 17:27:23 INFO - Expected file size: 20320052 17:27:23 INFO - Obtained file size: 20320052 17:27:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 17:27:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:27:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:27:28 INFO - Http code: 200 17:27:28 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 17:27:28 INFO - x-amz-cf-id: cUN6cJrrxZTP6Lt1BH3Ty7C_bAvD-cHKvEomHVdqT6LhsDsuOqEyKg== 17:27:28 INFO - x-amz-version-id: A7BILkFEBY0AyOLF9DNLWl.ui4UGjnql 17:27:28 INFO - Expected file size: 14409392 17:27:28 INFO - Obtained file size: 14409392 17:27:28 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')]} 17:27:28 INFO - trying https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:27:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:27:30 INFO - Downloaded 55703672 bytes. 17:27:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:27:30 INFO - mkdir: /builds/slave/test/properties 17:27:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:27:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:27:30 INFO - Contents: 17:27:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:27:30 INFO - Running post-action listener: _resource_record_post_action 17:27:30 INFO - Running post-action listener: set_extra_try_arguments 17:27:30 INFO - [mozharness: 2016-11-19 01:27:30.660626Z] Finished download-and-extract step (success) 17:27:30 INFO - [mozharness: 2016-11-19 01:27:30.660968Z] Running populate-webroot step. 17:27:30 INFO - Running pre-action listener: _resource_record_pre_action 17:27:30 INFO - Running main action method: populate_webroot 17:27:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:27:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:27:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:27:30 INFO - '--tppagecycles', 17:27:30 INFO - '7'], 17:27:30 INFO - 'tests': ['tsvgm']}}, 17:27:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:27:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:27:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:27:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:27:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['damp', 'tps']}, 17:27:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'tests': ['damp', 'tps']}, 17:27:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['dromaeo_dom']}, 17:27:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:27:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['basic_compositor_video']}, 17:27:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:27:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['a11yr', 17:27:30 INFO - 'ts_paint', 17:27:30 INFO - 'tpaint', 17:27:30 INFO - 'sessionrestore', 17:27:30 INFO - 'sessionrestore_no_auto_restore', 17:27:30 INFO - 'tabpaint']}, 17:27:30 INFO - 'other-e10s': {'tests': ['a11yr', 17:27:30 INFO - 'ts_paint', 17:27:30 INFO - 'tpaint', 17:27:30 INFO - 'sessionrestore', 17:27:30 INFO - 'sessionrestore_no_auto_restore', 17:27:30 INFO - 'tabpaint']}, 17:27:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:27:30 INFO - 'ts_paint', 17:27:30 INFO - 'tpaint', 17:27:30 INFO - 'sessionrestore', 17:27:30 INFO - 'sessionrestore_no_auto_restore', 17:27:30 INFO - 'tabpaint']}, 17:27:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:27:30 INFO - 'ts_paint', 17:27:30 INFO - 'tpaint', 17:27:30 INFO - 'sessionrestore', 17:27:30 INFO - 'sessionrestore_no_auto_restore', 17:27:30 INFO - 'tabpaint']}, 17:27:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['a11yr', 17:27:30 INFO - 'ts_paint', 17:27:30 INFO - 'tpaint', 17:27:30 INFO - 'sessionrestore', 17:27:30 INFO - 'sessionrestore_no_auto_restore', 17:27:30 INFO - 'tabpaint']}, 17:27:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['a11yr', 17:27:30 INFO - 'ts_paint', 17:27:30 INFO - 'tpaint', 17:27:30 INFO - 'sessionrestore', 17:27:30 INFO - 'sessionrestore_no_auto_restore', 17:27:30 INFO - 'tabpaint']}, 17:27:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['tsvgx', 17:27:30 INFO - 'tsvgr_opacity', 17:27:30 INFO - 'tart', 17:27:30 INFO - 'tscrollx', 17:27:30 INFO - 'cart']}, 17:27:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:27:30 INFO - 'tsvgr_opacity', 17:27:30 INFO - 'tart', 17:27:30 INFO - 'tscrollx', 17:27:30 INFO - 'cart']}, 17:27:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'talos_options': ['--disable-e10s'], 17:27:30 INFO - 'tests': ['tp5o']}, 17:27:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:27:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'talos_options': ['--disable-e10s', 17:27:30 INFO - '--xperf_path', 17:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:30 INFO - 'tests': ['tp5n']}, 17:27:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:27:30 INFO - 'talos_options': ['--xperf_path', 17:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:30 INFO - 'tests': ['tp5n']}}, 17:27:30 INFO - 'talos.zip': {'path': '', 17:27:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:27:30 INFO - Running post-action listener: _resource_record_post_action 17:27:30 INFO - [mozharness: 2016-11-19 01:27:30.680549Z] Finished populate-webroot step (success) 17:27:30 INFO - [mozharness: 2016-11-19 01:27:30.680641Z] Running create-virtualenv step. 17:27:30 INFO - Running pre-action listener: _resource_record_pre_action 17:27:30 INFO - Running main action method: create_virtualenv 17:27:30 INFO - Creating virtualenv /builds/slave/test/build/venv 17:27:30 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 17:27:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:27:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:27:30 INFO - Using real prefix '/usr' 17:27:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:27:31 INFO - Installing distribute.............................................................................................................................................................................................done. 17:27:33 INFO - Installing pip.................done. 17:27:33 INFO - Return code: 0 17:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:27:33 INFO - Reading from file tmpfile_stdout 17:27:33 INFO - Output received: 17:27:33 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) 17:27:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:27:33 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')]} 17:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:33 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')]} 17:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:33 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:33 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 17:27:33 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 17:27:33 INFO - Using env: {'DISPLAY': ':0', 17:27:33 INFO - 'HOME': '/home/cltbld', 17:27:33 INFO - 'LANG': 'en_US.UTF-8', 17:27:33 INFO - 'LANGUAGE': 'en_US:en', 17:27:33 INFO - 'LOGNAME': 'cltbld', 17:27:33 INFO - 'MAIL': '/var/mail/cltbld', 17:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:33 INFO - 'MOZ_NO_REMOTE': '1', 17:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:33 INFO - 'NO_EM_RESTART': '1', 17:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:33 INFO - 'PWD': '/builds/slave/test', 17:27:33 INFO - 'SHELL': '/bin/bash', 17:27:33 INFO - 'SHLVL': '1', 17:27:33 INFO - 'TERM': 'linux', 17:27:33 INFO - 'TMOUT': '86400', 17:27:33 INFO - 'USER': 'cltbld', 17:27:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:33 INFO - '_': '/tools/buildbot/bin/python'} 17:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:33 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 17:27:33 INFO - Cleaning up... 17:27:33 INFO - Return code: 0 17:27:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:27:33 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')]} 17:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:33 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')]} 17:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:33 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:33 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 17:27:33 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 17:27:33 INFO - Using env: {'DISPLAY': ':0', 17:27:33 INFO - 'HOME': '/home/cltbld', 17:27:33 INFO - 'LANG': 'en_US.UTF-8', 17:27:33 INFO - 'LANGUAGE': 'en_US:en', 17:27:33 INFO - 'LOGNAME': 'cltbld', 17:27:33 INFO - 'MAIL': '/var/mail/cltbld', 17:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:33 INFO - 'MOZ_NO_REMOTE': '1', 17:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:33 INFO - 'NO_EM_RESTART': '1', 17:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:33 INFO - 'PWD': '/builds/slave/test', 17:27:33 INFO - 'SHELL': '/bin/bash', 17:27:33 INFO - 'SHLVL': '1', 17:27:33 INFO - 'TERM': 'linux', 17:27:33 INFO - 'TMOUT': '86400', 17:27:33 INFO - 'USER': 'cltbld', 17:27:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:33 INFO - '_': '/tools/buildbot/bin/python'} 17:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:33 INFO - Downloading/unpacking psutil>=3.1.1 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:27:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:35 INFO - Installing collected packages: psutil 17:27:35 INFO - Running setup.py install for psutil 17:27:36 INFO - building 'psutil._psutil_linux' extension 17:27:36 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 17:27:36 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 17:27:36 INFO - building 'psutil._psutil_posix' extension 17:27:36 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 17:27:36 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 17:27:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:36 INFO - Successfully installed psutil 17:27:36 INFO - Cleaning up... 17:27:36 INFO - Return code: 0 17:27:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:27:36 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')]} 17:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:36 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')]} 17:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:36 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:36 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 17:27:36 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 17:27:36 INFO - Using env: {'DISPLAY': ':0', 17:27:36 INFO - 'HOME': '/home/cltbld', 17:27:36 INFO - 'LANG': 'en_US.UTF-8', 17:27:36 INFO - 'LANGUAGE': 'en_US:en', 17:27:36 INFO - 'LOGNAME': 'cltbld', 17:27:36 INFO - 'MAIL': '/var/mail/cltbld', 17:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:36 INFO - 'MOZ_NO_REMOTE': '1', 17:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:36 INFO - 'NO_EM_RESTART': '1', 17:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:36 INFO - 'PWD': '/builds/slave/test', 17:27:36 INFO - 'SHELL': '/bin/bash', 17:27:36 INFO - 'SHLVL': '1', 17:27:36 INFO - 'TERM': 'linux', 17:27:36 INFO - 'TMOUT': '86400', 17:27:36 INFO - 'USER': 'cltbld', 17:27:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:36 INFO - '_': '/tools/buildbot/bin/python'} 17:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:27:36 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 17:27:36 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 17:27:36 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 17:27:36 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 17:27:36 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 17:27:36 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 17:27:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:27:38 INFO - Installing collected packages: mozsystemmonitor 17:27:38 INFO - Running setup.py install for mozsystemmonitor 17:27:38 INFO - Successfully installed mozsystemmonitor 17:27:38 INFO - Cleaning up... 17:27:38 INFO - Return code: 0 17:27:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:27:38 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')]} 17:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:38 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')]} 17:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:38 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:38 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 17:27:38 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 17:27:38 INFO - Using env: {'DISPLAY': ':0', 17:27:38 INFO - 'HOME': '/home/cltbld', 17:27:38 INFO - 'LANG': 'en_US.UTF-8', 17:27:38 INFO - 'LANGUAGE': 'en_US:en', 17:27:38 INFO - 'LOGNAME': 'cltbld', 17:27:38 INFO - 'MAIL': '/var/mail/cltbld', 17:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:38 INFO - 'MOZ_NO_REMOTE': '1', 17:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:38 INFO - 'NO_EM_RESTART': '1', 17:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:38 INFO - 'PWD': '/builds/slave/test', 17:27:38 INFO - 'SHELL': '/bin/bash', 17:27:38 INFO - 'SHLVL': '1', 17:27:38 INFO - 'TERM': 'linux', 17:27:38 INFO - 'TMOUT': '86400', 17:27:38 INFO - 'USER': 'cltbld', 17:27:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:38 INFO - '_': '/tools/buildbot/bin/python'} 17:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:39 INFO - Downloading/unpacking jsonschema==2.5.1 17:27:39 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 17:27:39 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 17:27:39 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 17:27:39 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 17:27:39 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 17:27:39 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 17:27:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:27:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:27:41 INFO - warning: no files found matching '*.txt' 17:27:41 INFO - no previously-included directories found matching 'build' 17:27:41 INFO - no previously-included directories found matching 'dist' 17:27:41 INFO - no previously-included directories found matching '.git*' 17:27:41 INFO - Installing collected packages: jsonschema, functools32 17:27:41 INFO - Running setup.py install for functools32 17:27:41 INFO - warning: no files found matching '*.txt' 17:27:41 INFO - no previously-included directories found matching 'build' 17:27:41 INFO - no previously-included directories found matching 'dist' 17:27:41 INFO - no previously-included directories found matching '.git*' 17:27:41 INFO - Successfully installed jsonschema functools32 17:27:41 INFO - Cleaning up... 17:27:41 INFO - Return code: 0 17:27:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:27:41 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')]} 17:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:41 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')]} 17:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:41 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:41 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 17:27:41 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 17:27:41 INFO - Using env: {'DISPLAY': ':0', 17:27:41 INFO - 'HOME': '/home/cltbld', 17:27:41 INFO - 'LANG': 'en_US.UTF-8', 17:27:41 INFO - 'LANGUAGE': 'en_US:en', 17:27:41 INFO - 'LOGNAME': 'cltbld', 17:27:41 INFO - 'MAIL': '/var/mail/cltbld', 17:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:41 INFO - 'MOZ_NO_REMOTE': '1', 17:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:41 INFO - 'NO_EM_RESTART': '1', 17:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:41 INFO - 'PWD': '/builds/slave/test', 17:27:41 INFO - 'SHELL': '/bin/bash', 17:27:41 INFO - 'SHLVL': '1', 17:27:41 INFO - 'TERM': 'linux', 17:27:41 INFO - 'TMOUT': '86400', 17:27:41 INFO - 'USER': 'cltbld', 17:27:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:41 INFO - '_': '/tools/buildbot/bin/python'} 17:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:27:41 INFO - Cleaning up... 17:27:41 INFO - Return code: 0 17:27:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:27:41 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')]} 17:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:41 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')]} 17:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:41 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:41 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 17:27:41 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 17:27:41 INFO - Using env: {'DISPLAY': ':0', 17:27:41 INFO - 'HOME': '/home/cltbld', 17:27:41 INFO - 'LANG': 'en_US.UTF-8', 17:27:41 INFO - 'LANGUAGE': 'en_US:en', 17:27:41 INFO - 'LOGNAME': 'cltbld', 17:27:41 INFO - 'MAIL': '/var/mail/cltbld', 17:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:41 INFO - 'MOZ_NO_REMOTE': '1', 17:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:41 INFO - 'NO_EM_RESTART': '1', 17:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:41 INFO - 'PWD': '/builds/slave/test', 17:27:41 INFO - 'SHELL': '/bin/bash', 17:27:41 INFO - 'SHLVL': '1', 17:27:41 INFO - 'TERM': 'linux', 17:27:41 INFO - 'TMOUT': '86400', 17:27:41 INFO - 'USER': 'cltbld', 17:27:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:41 INFO - '_': '/tools/buildbot/bin/python'} 17:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 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 17:27:41 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 17:27:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:27:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:27:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:27:44 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 17:27:44 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 17:27:44 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 17:27:44 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 17:27:44 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 17:27:44 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 17:27:44 INFO - Downloading docopt-0.6.1.tar.gz 17:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:27:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:27:44 INFO - Running setup.py install for blobuploader 17:27:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:27:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:27:44 INFO - Running setup.py install for requests 17:27:45 INFO - Running setup.py install for docopt 17:27:45 INFO - Successfully installed blobuploader requests docopt 17:27:45 INFO - Cleaning up... 17:27:45 INFO - Return code: 0 17:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:45 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')]} 17:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:45 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')]} 17:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:45 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:45 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 17:27:45 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 17:27:45 INFO - Using env: {'DISPLAY': ':0', 17:27:45 INFO - 'HOME': '/home/cltbld', 17:27:45 INFO - 'LANG': 'en_US.UTF-8', 17:27:45 INFO - 'LANGUAGE': 'en_US:en', 17:27:45 INFO - 'LOGNAME': 'cltbld', 17:27:45 INFO - 'MAIL': '/var/mail/cltbld', 17:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:45 INFO - 'MOZ_NO_REMOTE': '1', 17:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:45 INFO - 'NO_EM_RESTART': '1', 17:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:45 INFO - 'PWD': '/builds/slave/test', 17:27:45 INFO - 'SHELL': '/bin/bash', 17:27:45 INFO - 'SHLVL': '1', 17:27:45 INFO - 'TERM': 'linux', 17:27:45 INFO - 'TMOUT': '86400', 17:27:45 INFO - 'USER': 'cltbld', 17:27:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:45 INFO - '_': '/tools/buildbot/bin/python'} 17:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:45 INFO - Running setup.py (path:/tmp/pip-P1iGc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:45 INFO - Running setup.py (path:/tmp/pip-imtyQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:45 INFO - Running setup.py (path:/tmp/pip-J7KE2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:45 INFO - Running setup.py (path:/tmp/pip-45a1gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:45 INFO - Running setup.py (path:/tmp/pip-VKVYkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:45 INFO - Running setup.py (path:/tmp/pip-O8NFMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:45 INFO - Running setup.py (path:/tmp/pip-bIb9OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:45 INFO - Running setup.py (path:/tmp/pip-2Jq2Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:46 INFO - Running setup.py (path:/tmp/pip-swvQeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:46 INFO - Running setup.py (path:/tmp/pip-zyu1fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:46 INFO - Running setup.py (path:/tmp/pip-dMnDQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:46 INFO - Running setup.py (path:/tmp/pip-rS2CMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:46 INFO - Running setup.py (path:/tmp/pip-_tbMah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:46 INFO - Running setup.py (path:/tmp/pip-XOjFDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:46 INFO - Running setup.py (path:/tmp/pip-MuXKIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:46 INFO - Running setup.py (path:/tmp/pip-_DX9VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:46 INFO - Running setup.py (path:/tmp/pip-cplfk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:27:46 INFO - Running setup.py install for manifestparser 17:27:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:27:46 INFO - Running setup.py install for mozcrash 17:27:46 INFO - Running setup.py install for mozdebug 17:27:46 INFO - Running setup.py install for mozdevice 17:27:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Running setup.py install for mozfile 17:27:47 INFO - Running setup.py install for mozhttpd 17:27:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Running setup.py install for mozinfo 17:27:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Running setup.py install for mozInstall 17:27:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Running setup.py install for mozleak 17:27:47 INFO - Running setup.py install for mozlog 17:27:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Running setup.py install for moznetwork 17:27:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:27:47 INFO - Running setup.py install for mozprocess 17:27:47 INFO - Running setup.py install for mozprofile 17:27:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:27:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:27:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:27:48 INFO - Running setup.py install for mozrunner 17:27:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:27:48 INFO - Running setup.py install for mozscreenshot 17:27:48 INFO - Running setup.py install for moztest 17:27:48 INFO - Running setup.py install for mozversion 17:27:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:27:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:27:48 INFO - Cleaning up... 17:27:48 INFO - Return code: 0 17:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:48 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')]} 17:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:48 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')]} 17:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:48 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:48 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 17:27:48 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 17:27:48 INFO - Using env: {'DISPLAY': ':0', 17:27:48 INFO - 'HOME': '/home/cltbld', 17:27:48 INFO - 'LANG': 'en_US.UTF-8', 17:27:48 INFO - 'LANGUAGE': 'en_US:en', 17:27:48 INFO - 'LOGNAME': 'cltbld', 17:27:48 INFO - 'MAIL': '/var/mail/cltbld', 17:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:48 INFO - 'MOZ_NO_REMOTE': '1', 17:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:48 INFO - 'NO_EM_RESTART': '1', 17:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:48 INFO - 'PWD': '/builds/slave/test', 17:27:48 INFO - 'SHELL': '/bin/bash', 17:27:48 INFO - 'SHLVL': '1', 17:27:48 INFO - 'TERM': 'linux', 17:27:48 INFO - 'TMOUT': '86400', 17:27:48 INFO - 'USER': 'cltbld', 17:27:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:48 INFO - '_': '/tools/buildbot/bin/python'} 17:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:48 INFO - Running setup.py (path:/tmp/pip-Pr0suB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:48 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)) 17:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:48 INFO - Running setup.py (path:/tmp/pip-aaHNqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:48 INFO - Running setup.py (path:/tmp/pip-IcDEEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:48 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)) 17:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:48 INFO - Running setup.py (path:/tmp/pip-udbiqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:49 INFO - Running setup.py (path:/tmp/pip-ylQeh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:49 INFO - Running setup.py (path:/tmp/pip-vQpw40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:49 INFO - Running setup.py (path:/tmp/pip-khO8xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:49 INFO - Running setup.py (path:/tmp/pip-8XHom1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:49 INFO - Running setup.py (path:/tmp/pip-f4zTiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:49 INFO - Running setup.py (path:/tmp/pip-zJ14lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:49 INFO - Running setup.py (path:/tmp/pip-_Rf9lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:49 INFO - Running setup.py (path:/tmp/pip-foKZuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:49 INFO - Running setup.py (path:/tmp/pip-rWsE_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:49 INFO - Running setup.py (path:/tmp/pip-WaX8cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:49 INFO - Running setup.py (path:/tmp/pip-Y8wSzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:49 INFO - Running setup.py (path:/tmp/pip-cHN3a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:49 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)) 17:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:49 INFO - Running setup.py (path:/tmp/pip-s47uhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27: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)) 17:27: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27: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)) 17:27: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:51 INFO - Downloading blessings-1.6.tar.gz 17:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:51 INFO - Installing collected packages: blessings 17:27:51 INFO - Running setup.py install for blessings 17:27:52 INFO - Successfully installed blessings 17:27:52 INFO - Cleaning up... 17:27:52 INFO - Return code: 0 17:27:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:52 INFO - Reading from file tmpfile_stdout 17:27:52 INFO - Current package versions: 17:27:52 INFO - argparse == 1.2.1 17:27:52 INFO - blessings == 1.6 17:27:52 INFO - blobuploader == 1.2.4 17:27:52 INFO - docopt == 0.6.1 17:27:52 INFO - functools32 == 3.2.3-2 17:27:52 INFO - jsonschema == 2.5.1 17:27:52 INFO - manifestparser == 1.1 17:27:52 INFO - mozInstall == 1.12 17:27:52 INFO - mozcrash == 1.0 17:27:52 INFO - mozdebug == 0.1 17:27:52 INFO - mozdevice == 0.49 17:27:52 INFO - mozfile == 1.2 17:27:52 INFO - mozhttpd == 0.7 17:27:52 INFO - mozinfo == 0.9 17:27:52 INFO - mozleak == 0.1 17:27:52 INFO - mozlog == 3.4 17:27:52 INFO - moznetwork == 0.27 17:27:52 INFO - mozprocess == 0.23 17:27:52 INFO - mozprofile == 0.28 17:27:52 INFO - mozrunner == 6.13 17:27:52 INFO - mozscreenshot == 0.1 17:27:52 INFO - mozsystemmonitor == 0.3 17:27:52 INFO - moztest == 0.7 17:27:52 INFO - mozversion == 1.4 17:27:52 INFO - psutil == 3.1.1 17:27:52 INFO - requests == 1.2.3 17:27:52 INFO - wsgiref == 0.1.2 17:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:52 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')]} 17:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:52 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')]} 17:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:52 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:52 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 17:27:52 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 17:27:52 INFO - Using env: {'DISPLAY': ':0', 17:27:52 INFO - 'HOME': '/home/cltbld', 17:27:52 INFO - 'LANG': 'en_US.UTF-8', 17:27:52 INFO - 'LANGUAGE': 'en_US:en', 17:27:52 INFO - 'LOGNAME': 'cltbld', 17:27:52 INFO - 'MAIL': '/var/mail/cltbld', 17:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:52 INFO - 'MOZ_NO_REMOTE': '1', 17:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:52 INFO - 'NO_EM_RESTART': '1', 17:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:52 INFO - 'PWD': '/builds/slave/test', 17:27:52 INFO - 'SHELL': '/bin/bash', 17:27:52 INFO - 'SHLVL': '1', 17:27:52 INFO - 'TERM': 'linux', 17:27:52 INFO - 'TMOUT': '86400', 17:27:52 INFO - 'USER': 'cltbld', 17:27:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:52 INFO - '_': '/tools/buildbot/bin/python'} 17:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 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)) 17:27:52 INFO - Cleaning up... 17:27:52 INFO - Return code: 0 17:27:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:52 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')]} 17:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:52 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')]} 17:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:52 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 0x7f90186c4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf63130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', '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 17:27:52 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 17:27:52 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 17:27:52 INFO - Using env: {'DISPLAY': ':0', 17:27:52 INFO - 'HOME': '/home/cltbld', 17:27:52 INFO - 'LANG': 'en_US.UTF-8', 17:27:52 INFO - 'LANGUAGE': 'en_US:en', 17:27:52 INFO - 'LOGNAME': 'cltbld', 17:27:52 INFO - 'MAIL': '/var/mail/cltbld', 17:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:52 INFO - 'MOZ_NO_REMOTE': '1', 17:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:52 INFO - 'NO_EM_RESTART': '1', 17:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:52 INFO - 'PWD': '/builds/slave/test', 17:27:52 INFO - 'SHELL': '/bin/bash', 17:27:52 INFO - 'SHLVL': '1', 17:27:52 INFO - 'TERM': 'linux', 17:27:52 INFO - 'TMOUT': '86400', 17:27:52 INFO - 'USER': 'cltbld', 17:27:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:52 INFO - '_': '/tools/buildbot/bin/python'} 17:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:52 INFO - Cleaning up... 17:27:52 INFO - Return code: 0 17:27:52 INFO - Running post-action listener: _resource_record_post_action 17:27:52 INFO - Running post-action listener: _start_resource_monitoring 17:27:52 INFO - Starting resource monitoring. 17:27:52 INFO - [mozharness: 2016-11-19 01:27:52.848659Z] Finished create-virtualenv step (success) 17:27:52 INFO - [mozharness: 2016-11-19 01:27:52.849172Z] Running install step. 17:27:52 INFO - Running pre-action listener: _resource_record_pre_action 17:27:52 INFO - Running main action method: install 17:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:53 INFO - Reading from file tmpfile_stdout 17:27:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:53 INFO - Reading from file tmpfile_stdout 17:27:53 INFO - Output received: 17:27:53 INFO - Usage: mozinstall [options] installer 17:27:53 INFO - Options: 17:27:53 INFO - -h, --help show this help message and exit 17:27:53 INFO - -d DEST, --destination=DEST 17:27:53 INFO - Directory to install application into. [default: 17:27:53 INFO - "/builds/slave/test"] 17:27:53 INFO - --app=APP Application being installed. [default: firefox] 17:27:53 INFO - mkdir: /builds/slave/test/build/application 17:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:28:09 INFO - Reading from file tmpfile_stdout 17:28:09 INFO - Output received: 17:28:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:28:09 INFO - Running post-action listener: _resource_record_post_action 17:28:09 INFO - [mozharness: 2016-11-19 01:28:09.237129Z] Finished install step (success) 17:28:09 INFO - [mozharness: 2016-11-19 01:28:09.237370Z] Running run-tests step. 17:28:09 INFO - Running pre-action listener: _resource_record_pre_action 17:28:09 INFO - Running main action method: run_tests 17:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:28:09 INFO - Python 2.7.3 17:28:09 INFO - Return code: 0 17:28:09 INFO - grabbing minidump binary from tooltool 17:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:09 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 0xff1fc0>, '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 0xff2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff3350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:28:09 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 17:28:09 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 17:28:09 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 17:28:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:28:09 INFO - Return code: 0 17:28:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:28:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:28:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:28:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:28:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 17:28:09 INFO - Using env: {'DISPLAY': ':0', 17:28:09 INFO - 'HOME': '/home/cltbld', 17:28:09 INFO - 'LANG': 'en_US.UTF-8', 17:28:09 INFO - 'LANGUAGE': 'en_US:en', 17:28:09 INFO - 'LOGNAME': 'cltbld', 17:28:09 INFO - 'MAIL': '/var/mail/cltbld', 17:28:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:28:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:09 INFO - 'MOZ_NO_REMOTE': '1', 17:28:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:09 INFO - 'NO_EM_RESTART': '1', 17:28:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:09 INFO - 'PWD': '/builds/slave/test', 17:28:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:28:09 INFO - 'SHELL': '/bin/bash', 17:28:09 INFO - 'SHLVL': '1', 17:28:09 INFO - 'TERM': 'linux', 17:28:09 INFO - 'TMOUT': '86400', 17:28:09 INFO - 'USER': 'cltbld', 17:28:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515', 17:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:09 INFO - '_': '/tools/buildbot/bin/python'} 17:28:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:28:09 INFO - mozversion application_buildid: 20161118161321 17:28:09 INFO - mozversion application_changeset: f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd 17:28:09 INFO - mozversion application_display_name: Nightly 17:28:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:28:09 INFO - mozversion application_name: Firefox 17:28:09 INFO - mozversion application_remotingname: firefox 17:28:09 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 17:28:09 INFO - mozversion application_vendor: Mozilla 17:28:09 INFO - mozversion application_version: 53.0a1 17:28:09 INFO - mozversion platform_buildid: 20161118161321 17:28:09 INFO - mozversion platform_changeset: f5bea7e99fdc6d291c4a0c138a5a704b28ce5dcd 17:28:09 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 17:28:09 INFO - mozversion platform_version: 53.0a1 17:28:09 INFO - using testdate: 1479518889 17:28:09 INFO - actual date: 1479518889 17:28:09 INFO - starting webserver on 'localhost:60977' 17:28:09 INFO - SUITE-START | Running 2 tests 17:28:09 INFO - TEST-START | dromaeo_css 17:28:09 INFO - operating with platform_type : linux_ 17:28:09 INFO - Initialising browser for dromaeo_css test... 17:28:09 INFO - TEST-INFO | started process 22656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_4Fw6F/profile http://localhost:60977/getInfo.html) 17:28:13 INFO - PROCESS | 22656 | __metrics Screen width/height:1600/1200 17:28:13 INFO - PROCESS | 22656 | colorDepth:24 17:28:13 INFO - PROCESS | 22656 | Browser inner width/height: 1024/697 17:28:13 INFO - PROCESS | 22656 | __metrics 17:28:14 INFO - PROCESS | 22656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:28:14 INFO - PROCESS | 22656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:14 INFO - PROCESS | 22656 | console.error: PushService: 17:28:14 INFO - PROCESS | 22656 | stateChangeProcessEnqueue: Error transitioning state 17:28:14 INFO - PROCESS | 22656 | UnknownError 17:28:15 INFO - TEST-INFO | 22656: exit 0 17:28:15 INFO - Browser initialized. 17:28:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:28:15 INFO - TEST-INFO | started process 22737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_4Fw6F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:28 INFO - PROCESS | 22737 | RSS: Main: 175325184 17:28:28 INFO - PROCESS | 22737 | 17:29:19 INFO - PROCESS | 22737 | 1479518959448 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] 17:31:33 INFO - PROCESS | 22737 | Cycle 1(1): loaded http://localhost:60977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60977/tests/dromaeo/cssquery-ext.html) 17:31:34 INFO - PROCESS | 22737 | RSS: Main: 315703296 17:31:34 INFO - PROCESS | 22737 | 17:34:37 INFO - PROCESS | 22737 | Cycle 1(1): loaded http://localhost:60977/tests/dromaeo/cssquery-ext.html (next: http://localhost:60977/tests/dromaeo/cssquery-jquery.html) 17:34:37 INFO - PROCESS | 22737 | RSS: Main: 279216128 17:34:37 INFO - PROCESS | 22737 | 17:37:40 INFO - PROCESS | 22737 | Cycle 1(1): loaded http://localhost:60977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60977/tests/dromaeo/cssquery-mootools.html) 17:37:40 INFO - PROCESS | 22737 | RSS: Main: 262631424 17:37:40 INFO - PROCESS | 22737 | 17:40:43 INFO - PROCESS | 22737 | Cycle 1(1): loaded http://localhost:60977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60977/tests/dromaeo/cssquery-prototype.html) 17:40:43 INFO - PROCESS | 22737 | RSS: Main: 223694848 17:40:43 INFO - PROCESS | 22737 | 17:43:47 INFO - PROCESS | 22737 | Cycle 1(1): loaded http://localhost:60977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60977/tests/dromaeo/cssquery-yui.html) 17:43:47 INFO - PROCESS | 22737 | RSS: Main: 223920128 17:43:47 INFO - PROCESS | 22737 | 17:46:50 INFO - PROCESS | 22737 | Cycle 1(1): loaded http://localhost:60977/tests/dromaeo/cssquery-yui.html (next: http://localhost:60977/tests/dromaeo/cssquery-dojo.html) 17:46:51 INFO - PROCESS | 22737 | RSS: Main: 313171968 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | __start_tp_report 17:46:51 INFO - PROCESS | 22737 | _x_x_mozilla_page_load 17:46:51 INFO - PROCESS | 22737 | _x_x_mozilla_page_load_details 17:46:51 INFO - PROCESS | 22737 | |i|pagename|runs| 17:46:51 INFO - PROCESS | 22737 | |0;dojo.html;2515.7232704402513;2563.7948964082875;2578.4714133602615;2597.6493173421595;2606.1920804550577;4484.282514797633;4568.90862182757;4575.8398456054;4603.7928293226805;4615.215413379725;4604.217283061879;4611.5619016193405;4618.699784514012;4621.191291523978;4633.930491042629;4203.537610862811;4224.239636865363;4233.1956928183545;4248.617624413802;4313.935290970638;4289.420928174688;4292.463442069741;4297.742135471882;4317.503487098977;4321.654267658596;4284.957150428487;4293.29160688486;4314;4322.697411181203;4372.038151606642;4401.977990110045;4403.493598236212;4411.382406463098;4412.294032954744;4448.021435284232;4146.253674338618;4193.958060419387;4198.3702444633545;4325.978370108161;4362.454693163355;4570.382998295221;4641;4649.070185962787;4652.255639097728;4655.11552804966;4939.135651261051;4971.577415919651;4983.302337672729;4984.22744474607;5025.974870125626;4837.9032419351415;4947.777350019258;5002.674826136289;5015.39815222172;5046.09170349337;4600.378948841931;4631.212693842055;4673.252279635242;4712.434507859079;4714.764261786897;5116.309298244763;5116.744162791845;5118;5121.436641969381;5166.948330516722;4876.902461950741;4886.193778026657;4887.29134275528;4894.363732714724;4930.038642464757;4758.714477131383;4822.107910036654;4826.32431459596;4847.515248475124;4905.23968784839;4854.368932038812;4857.635677324215;4882.267659851051;4907.337509436252;4907.950920490821;4831.661783675179;4858.17411040124;4874.658773885865;4878.82924097662;4910.386201724785;3946.1910308386714;4065.3495440729343;4070.6132917373393;4093.2427500912427;4137.317342638491;3568.4468907319406;3581.391163502211;3588.2823435313044;3647.908802279911;3649.2883887641656;4351.26028575143;4353.73877567347;4379.386885835986;4391.5827996340295;4397.1205758848355;5029.924551131736;5032.521910418504;5035.395752509722;5038.823641172615;5056.696598204119;4167.8332866685;4223.049813791934;4326.15639950213;4329.956700433018;4368.716033457815;4289;4432.955670443319;4481.574250446268;4491.752953587584;4535.115652447807;4780.737059461763;4818.4217893852265;4821.590164836029;4823.903521929542;4864.440589332131;4785.425748910153;4839.612830973584;5034.84895453137;5036.697798132123;5090.08378491875;4667.229907065296;4695.5304469552775;4766.428028636586;4776.546228108324;4839.95160048395;4952.2819191217795;4962.925556116734;4965.4041515018425;4966.826161084345;5000.2499625056535;4990.451050384382;5027.044861476308;5036.345275114211;5037.093323201859;5062.82280120194;4675.812967481263;4703.318018887174;4730.952690473051;4752.2158843790385;4794.712317260975;4828.66199366041;4835.057163853015;4835.492273311252;4855.635827313036;4877.170880950318;4741.83403580873;4749.881252968704;4752;4752.6197904168275;4796.856094317176;4678.60231880294;4736.313234581035;4740.170470167638;4857.975710121426;4894.828680996148;4763.595094417014;4784.210605250095;4808.711477311373;4838.782254798472;4881.365422495053 17:46:51 INFO - PROCESS | 22737 | |1;ext.html;553.521204158403;566.0151336674186;578.1097110449907;589.172213040678;592.899207134787;28458.14625561231;39125.217495650104;40226.59773402265;40236.79881600588;43470.34794478078;39944.80027599865;40392.19215615693;40400.79799601005;40410.7979460103;40462.393064104064;7505.099388073425;7650.617469126521;7651.961740191291;7657.846843063136;7658.693652253904;7342.632868356587;7433.628318584077;7434.962825185867;7441.25587441257;7445.81385465365;7440.888386674204;7457.216992215821;7479.326860582546;7482;7485.812854678622;7373.668184931691;7377.963110184468;7416.147143078534;7449.739259125959;7464.514806537585;7289.489735718502;7404.111506619241;7429;7430.628468576603;7436.814079647998;37300.06749831276;37485.25029499422;37638.62361376406;37663.62336376629;37714.43428348577;2975.61317028787;3012.7891047626676;3172;3344.347852168828;3628.6008539060945;28053.298667533272;28597.14208573746;28633.57049644257;28769.71230287712;28891;3265.4448743713624;3288.095773662238;3357.529945807589;3385.847636856323;3452.2750222453064;231585.84207079024;233249;234194;234553;235006;29148.27129321784;50700.23949640759;51004.489955099976;51058.23412648813;51137.744311278206;29060;30690.38619227603;30882;31021.224469388446;31233.375332493222;11092.722681933015;11100;11108.666739997652;11138.888611113785;11206.663800086011;9964;10024.54889529973;10050.246231532665;10052.246081543914;10063;6881.449484041264;6956.686949087303;7058.61177635235;7144.571325720473;7319.780406587811;2730.235534050469;2733.1253998720217;2797.818141820816;2824.8022638415523;2844.857757112136;809.906860711014;896.5562046786882;946.1002028781762;969.2343048991218;979.8677178580942;26129.216123516326;26604.56052614591;27044;27094.5935810963;27283.31791705223;722.5953466059024;896.8161526886972;900.090908182727;904.3036861616519;916.6425094213262;13352.399142038632;14737.705245895237;15369.769453458208;16200.432984845474;16406.83593164077;351591;352527;352821;353710;354322;48220.27669584959;48639.51360486421;48640.27039594409;48663;48733.756331218116;1041.5000799616228;1083.5557421457006;1137.2891942535914;1160.2632328471482;1191.2852288626927;25279.87360063188;27659;28382.29044273827;29049.12852614425;29076.56385154182;40034.79982600185;40810.1837963245;40878.38682419706;41063.38404923988;41082.17835643211;282462;282751.3449731035;283724;284786;285143;22408.66387004229;23423.297301080995;23454.76545234526;24276.757232427448;24462.143824966042;39074.60925390823;39245.2150956985;39272;39723.40414893721;40544.391834121925;33646.327073457905;33758.8312058448;33827.492587610715;33987.49018764671;34191.31617367688;33719.325613487104;34064.82967585146;34075;34200.65799341975;35045.299094017464;33587.66412335845;34209;34397.82801085978;34507;34610;27209.047683330988;28190.71809281881;30850.845745772025;31123.68876311208;31646.683533164374;23572.29283121509;24170.637440438055;24251.39371515726;24793.380165496008;26172.635436218767 17:46:51 INFO - PROCESS | 22737 | |2;jquery.html;329.52219282041017;343.9294944536372;350.72643338196207;352.2356486424459;369.1969965325417;12372.690682732926;15416.537503874888;15775.684486310267;17483.300667973297;17693.203805828736;15434.228288585582;15699.764503532457;16009.19954002301;16083.678326433464;16106.194690265469;4840.370751802261;4846.515348465143;5007.574356179729;5007.899842003158;5028.094942910275;4890.462049174588;4950.504949505057;4964.677295975768;4974.328465657126;4975.2039673652225;3588.1388466767917;3776.678982286509;5463.289772329612;5703.914441283384;5738.856528586798;5032.547070763649;5799.159121927339;5819.418058194168;5821.068629019379;5825.097109947944;5127.333446651912;5234.42421333653;5238.580913526908;5240.580753539708;5241.606879484016;19835.603287934304;19927.501812454804;19947.202111915507;19971.700424493643;20024.69962950557;1734.54901725551;1844.170123444442;1990.3531352310556;2062.4740691123666;2246.2811900191946;8394.538300393477;8500.914990850075;8667.21995020445;8834.07242239562;13862.861371386258;1729.8270172982727;1769.646070785835;1827.3330234464458;1864.5431869192134;1870.6632806094897;78437;83496;84252.57873710654;85408.57295713543;86276.56861715714;15713.921430392775;16337;16541;16697.582560435843;17298;29007.41985160285;29028.7097129026;29049;29092.127236182947;29130;8149.877751833727;8447.155284471504;8491.532965686947;8600.655973760979;8706.564671766386;6774.288699686561;6803.557768745016;6818.693158807866;6944.652318376445;7138.179109402381;8310;8324.750257492286;8611.741647750578;8770.780730481789;8793.120687931283;3179.300553878143;3211.566438530768;3351.379994700988;3352.446846270338;3452.375006243434;705.8447141628833;777.9066512018594;828.9088200297963;842.688205364007;878.1745159550003;16125.919370403308;16417.261223244983;16501;16678.749818752727;16879.493615191564;795.9562224077731;808.7048227397075;834.6828205281954;843.7974886027309;850.459957926721;8884;9061.275097992146;9483.620655173854;9517.524123793783;9675.806483870423;346907.26546367106;352119;355732;357676;362642;74593;74971.62514187394;75378.24621753712;75462;77682.22317776862;834.0741776627938;849.295085079395;861.280830506534;875.2035647560816;875.2910142784365;14486;14722.337494812546;15092.39630414771;15157.317920693375;15230.182416253028;24387.878060609582;24649.38376540529;34536.48195277023;35214.29571408609;36227.63772362243;48454.515454845;49227.75386123046;49655.75172124116;49922.50077499324;50108.49891501184;6825.453963682993;6927.307269273032;7030;7131.714731410893;7471;7601.0878694557005;9980.650677226553;10197.439140847324;10511.316764410289;11031.062359699516;6562.7202695475835;9250.21373183287;9423.434593924387;9470.431774093577;9650.517474126405;8987.955060224656;9211.078892110736;9607.759806004626;9653.476481084213;10045.447500387549;9041.638334466548;9132.452052876848;9157.587908543997;9233.215176710055;9808.117269445498;7035.487370215224;7156.212816590275;7202.819929501804;7239.565626062453;7294.452916031425;7906.802329941797;9350.298727595593;9358.578863951274;9368.203702685076;9633 17:46:51 INFO - PROCESS | 22737 | |3;mootools.html;1162.9244099133562;1323.444153455549;1360.8843248323892;1425.7504936636087;1664.1429663723184;5956.702164891754;6654.966725166373;6982.057422247989;6993.405560527362;7144.178419481761;7001;7038.366547010768;7043.26045765195;7045.048918396015;7045.295470452965;2045.877247365159;2076.940760212295;2078.8544801863877;2079.61527117483;2082.1567265257595;2045.1410407628832;2058.711780350752;2080.459080639037;2094.413564202026;2099.2442720620566;2033.3188381892085;2042.8059334363286;2053.609814135317;2055.4758536573154;2056.876587404753;2000.3198912369792;2027.2397850805949;2031.2992017753852;2032.9288474903308;2033.66444536652;2006.6287736768745;2012.0241682783837;2060.103854823142;2062.577171679802;2063.3603582889205;6714;6845.657717114124;6890.552114112616;6948.374646281859;6998.405135563483;3951.249262640089;4127.009517715756;4131.628153466172;4133.731307465036;4140.834366625331;2568.4349443122483;2715.185444366682;2757.8621068946472;2763.6130941668184;2773.1819113361607;837.9078301386843;852.433131967241;856.943335993614;860.2859626509982;904.5658084119659;9077.863832042525;9149.405288656217;9166.26669866409;9173.31200159984;9174.633014679404;3382.9661703383144;3519.419295816213;3582.480540321691;3588.1926566522325;3588.2823435313044;7445.85108297831;7448.031755871811;7448.329650331388;7455.142658594223;7464.1416237132335;4050.8987275318354;4053.7162398632404;4058.8782336529953;4062.512498500199;4064.634182923551;3331.6168640606156;3440.501127336522;3618.2582570572968;3722.6091260417807;3794.449804778347;2959.5560665899857;2973.3904549567287;3026.7427268681968;3062.632484101922;3090.752739780857;900.4867225681298;901.6618767962015;905.8097799462055;906.7687739626354;908.0873721909571;614.5022531749208;659.6899457255082;739.3973911262304;782.6243403166512;796.6733639207897;4470.016596348798;4509.278515437514;4521.299198624219;4535.274356103007;4658.95341046592;389.95515515716056;390.7323483413871;405.5397124263982;406.83523173114935;412.22501696809803;3187.565201331724;3344.4481660526226;3355.177981394574;3372.8144952027383;3426.7087297579487;7984.880226796603;8263;8348.749537513884;8352.8329433411;8358.874616880752;8292.37807164465;8294.253517183482;8314.459560128693;8323.625436855356;8325.583720813935;6075.787347442818;6369.363063693593;6390.201224846895;6452.838679032968;6530.67346632676;4839.733814640088;4872.171730805842;4904.950950490592;4928.926066109083;4997.775100120431;7510.662020209213;7642.3504002158215;7675.61621918913;7696.576688282198;7800.102988156435;7755.069391673035;7809.804754881174;7897.407694422826;7929.286364227247;8002.07976082758;6047.848803779941;6109.602875813058;6113.174721412553;6170.568060235741;6182.103594978613;6565.212174539086;6630.635315057718;6631.204255489372;6632.1709786276715;6651.933480665131;5826.359100498857;5912.49743771767;5923.170756094064;5976.193213916065;6065.8180254592435;5905.822825315247;5914;5922.526197904243;5929.555283353852;5932.2584676915385;5360.222767698584;5360.517553420211;5402.432744561765;5407.83776486706;5407.864803379947;3865.6520913117956;3938.803059846939;3953.4069889516804;3969.285528604879;3990.880273591797;3934.7048971326694;4083.428320035257;4155.854545090907;4181.644560212416;4203.579642035895 17:46:51 INFO - PROCESS | 22737 | |4;prototype.html;278.43894552476763;284.11073340444403;289.48616206233936;295.6437492821151;296.09985643643324;4510.391097201885;4664;4673.462551806543;4703.9529604703985;4721.0343311618235;4455.643548516119;4584.381108550345;4607.562281583244;4611.33135695324;4628.583427491525;3441.2257242120572;3672.797996110213;3676.2279921216577;3696.242270334575;3696.2607478504406;3522.594901586312;3524.3479956208057;3530.5763308402898;3534.982325088371;3536.646335366456;3433.7768045077114;3598;3600.3339382214376;3606.71146308296;3621.782693038413;3608.6210947850623;3616.3309787689363;3617.2765446910594;3619.2761447710564;3623.184783423735;3117.345357474933;3182.745380369565;3188.952165717493;3192.776505644606;3210.3739770744714;4501.639868810487;4512.638988880882;4514.164879497303;4522.163399771053;4542.500324964251;4106.958930410688;4130.451080844683;4134.1731653669085;4169.187008533338;4190.664746820247;4675.462321832999;4813.879653008667;4829.782659780319;4886.975565122151;4895.290182923456;3511.8068506232403;3516.5757868063474;3534.2578058607724;3534.9823250883837;3550.840212190458;5099.23511473282;5112.71880046601;5126.384833819965;5126.846194614168;5130.589552835764;3519.8416071276342;3655.5796083450214;3658.7804731716183;3662.322470342995;3662.9450558241647;3690.409534474525;3713.628637136319;3718.475425075706;3721.9255614888093;3733.3093377724663;4154.169166166718;4170.332746760504;4175.937360939588;4179.686523510749;4184.560621134798;4834.59796658972;4836.443808962014;4852.369192005017;4855.717812628059;4867.902641947212;1218.506504865513;1220.791416497661;1236.3385588709998;1244.3591550351575;1248.5380409248455;841.7937605286744;874.3267683883502;877.4077497689034;878.7232021913077;880.5289170293862;4202.117555313418;4211.894702632459;4221.256183480762;4227.408162857141;4228.217779710763;4831.685940413862;4843.39457567804;4848.151573474628;4852.272159176152;4889.413270407503;4226;4228.505181942669;4236.173946080547;4238.6397156242065;4265.210935976792;2490.514349701827;2575.7166711661703;2577.3943123365993;2588.831725937808;2598.311447466423;4660.743659098782;4675.555822196886;4691.718496890129;4709.95290047102;4712.5994290485005;5026.824061157842;5044.924326135111;5051.368578927634;5053.974730126326;5056.82301119459;4565.771711414416;4641.5652417211695;4669.41632295963;4690.273007683814;4706.976465117653;4873.879007828148;4898.755062246944;4904.994476132313;4919.581835544019;4932.408111026556;4780.6653534253655;4781.832635857728;4787.234042553175;4826.734529600905;4832.613390928787;4526.8189272428735;4674.22875225584;4857.465678775261;4892.143874821821;4900.215965445655;3219.340035292806;3550.5265314895064;3563.429851223792;3580.874669386559;3584.121890136933;4910.386201724785;4944.381952255968;5072.34059572268;5072.67027643202;5078.365204349457;4918.729469879191;4919.754012299442;4923.704577725204;4924.753762311799;4927.556519913225;4707.328283938534;4916.975415122902;4924.4090709115135;4928.950710492849;4933.802647894044;4837;4859.586935110414;4870;4872.074305881871;4879.658423910292;4976.676516026447;4985.102681517362;5001.899582091934;5003;5005.398272552894;4748.192807222711;4870.902581948412;4881.438634557071;4885.949520853033;4892.779824907959 17:46:51 INFO - PROCESS | 22737 | |5;yui.html;587.007110858635;638.4254171245879;675.5136301862657;685.9862802743945;696.1437431958689;11205.439728013598;11794.23337483063;12167.08746843987;12463.501459941614;12581.18222315551;11896.226745261574;12098.092643051763;12107.091968102384;12107.394630268496;12117;605.7455868535204;759.1687102622647;772.1082150116596;773.6750564762813;774.3263360876017;617.4350469320566;735.4226931858492;764.678834889345;770.96916123355;774.0711146624045;813.2436833744615;813.7477382011596;814.5927036481759;815.2255357410484;815.7022686719334;624.8281722526297;808.1070417189039;809.3282575462352;809.5142914251461;809.7530253272749;472.0158469590907;565.4486875296594;585.7452008376328;586.3403670870271;588.0326862311516;12238.938805306005;12284.815727764091;12291.56979505713;12314.692132696755;12354.567590134302;9058.864117038183;10560.841587376195;11559.884401155965;11801.527938882435;12039.819402708967;9437.292203084728;9678.661246856396;10776.515056822383;10826.512806923629;11066.612668556561;3937.1141493164096;3953.5453422856453;3998.5001874765653;4003.03927057507;4176.644985176264;46707.53292467066;47367.28949065732;48150.85133824562;48320.55038348855;48749;9231.723048308562;9436.292278079172;9447.102525260088;9537.427754334623;9538.666146684833;15401.845981540042;15515.612109697347;15944.601384965237;15959.122248276457;15983.60040998961;6115.449609535074;6336.58812177207;6487.772927947499;6490.935090649033;6542.574732642363;3358.8152651604396;3387.6612338766417;3421.0934102462866;3468.6878180963836;3492.7729697569575;2600.622909678086;2689.3814422682894;2693.340131667754;2694.1378758797387;2696.150712525548;466.7362939938924;472.32457585652844;473.5217430395257;474.594221940243;483.80889548628096;449.66499957531846;449.9460064792246;463.1547425947659;471.86315968369473;495.6951474842946;6469.51478639104;6509.641969691713;6536.7712130075215;6539.2479864815205;6546.476281897437;452.42767898608287;485.6406259368042;486.6496122791584;491.7541229385307;497.4478329054746;3272.6236482804306;3272.9508115450835;3290.670932906738;3297.7196938260518;3377.189474526145;66997.66501167463;68759.3124068753;69598.65200673965;72017.6399118001;72112.63943680248;59247;60652;61349.38650613437;61690.383096168465;62618.68690656518;54518;55169.44830551643;55622.72188639031;55892.161617575766;56218.71890640521;6269.122322874892;6367.61794292344;6442.133250703392;6539.378759017885;6689.69896354675;37637.24725505529;38267.61732382752;38799;39029;39173.804130979166;45196.54803451923;51801.970694542404;51825;52342;52643.47356526539;7907.723229687163;7971.402144839044;8094.271515563628;8229.753107406787;8260.380471464785;9164.266858651159;9308.860367094363;9376.906230937604;9386.436813791195;9748.707538773848;8572.957135214285;8695.217430431292;8908.821823563621;8920.24177944856;9875.024995000886;9868.703938881845;10050.001984205514;10290.3825770454;10522.21083418762;10717.464126793786;9948.45283509414;10179.949100254451;10214.489275536045;10440.53017614194;10682.519286631965;8746.956265218632;8948.68679596211;9009.189172974464;9117.544122793966;9381.296402769683;8872.600732966903;9232.015116749932;9470.00349667832;9474.810503790024;9514.476703781358 17:46:51 INFO - PROCESS | 22737 | __end_tp_report 17:46:51 INFO - PROCESS | 22737 | __start_cc_report 17:46:51 INFO - PROCESS | 22737 | _x_x_mozilla_cycle_collect,1346 17:46:51 INFO - PROCESS | 22737 | __end_cc_report 17:46:51 INFO - PROCESS | 22737 | __startTimestamp1479520011013__endTimestamp 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | ------- Summary: start ------- 17:46:51 INFO - PROCESS | 22737 | Number of tests: 6 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | [#0] dojo.html Cycles:165 Average:4588.45 Median:4740.17 stddev:488.99 (10.3%) stddev-sans-first:462.67 17:46:51 INFO - PROCESS | 22737 | Values: 2515.7 2563.8 2578.5 2597.6 2606.2 4484.3 4568.9 4575.8 4603.8 4615.2 4604.2 4611.6 4618.7 4621.2 4633.9 4203.5 4224.2 4233.2 4248.6 4313.9 4289.4 4292.5 4297.7 4317.5 4321.7 4285.0 4293.3 4314.0 4322.7 4372.0 4402.0 4403.5 4411.4 4412.3 4448.0 4146.3 4194.0 4198.4 4326.0 4362.5 4570.4 4641.0 4649.1 4652.3 4655.1 4939.1 4971.6 4983.3 4984.2 5026.0 4837.9 4947.8 5002.7 5015.4 5046.1 4600.4 4631.2 4673.3 4712.4 4714.8 5116.3 5116.7 5118.0 5121.4 5166.9 4876.9 4886.2 4887.3 4894.4 4930.0 4758.7 4822.1 4826.3 4847.5 4905.2 4854.4 4857.6 4882.3 4907.3 4908.0 4831.7 4858.2 4874.7 4878.8 4910.4 3946.2 4065.3 4070.6 4093.2 4137.3 3568.4 3581.4 3588.3 3647.9 3649.3 4351.3 4353.7 4379.4 4391.6 4397.1 5029.9 5032.5 5035.4 5038.8 5056.7 4167.8 4223.0 4326.2 4330.0 4368.7 4289.0 4433.0 4481.6 4491.8 4535.1 4780.7 4818.4 4821.6 4823.9 4864.4 4785.4 4839.6 5034.8 5036.7 5090.1 4667.2 4695.5 4766.4 4776.5 4840.0 4952.3 4962.9 4965.4 4966.8 5000.2 4990.5 5027.0 5036.3 5037.1 5062.8 4675.8 4703.3 4731.0 4752.2 4794.7 4828.7 4835.1 4835.5 4855.6 4877.2 4741.8 4749.9 4752.0 4752.6 4796.9 4678.6 4736.3 4740.2 4858.0 4894.8 4763.6 4784.2 4808.7 4838.8 4881.4 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | [#1] ext.html Cycles:180 Average:43057.87 Median:34452.41 stddev:77496.36 (224.9%) stddev-sans-first:77648.05 17:46:51 INFO - PROCESS | 22737 | Values: 553.5 566.0 578.1 589.2 592.9 28458.1 39125.2 40226.6 40236.8 43470.3 39944.8 40392.2 40400.8 40410.8 40462.4 7505.1 7650.6 7652.0 7657.8 7658.7 7342.6 7433.6 7435.0 7441.3 7445.8 7440.9 7457.2 7479.3 7482.0 7485.8 7373.7 7378.0 7416.1 7449.7 7464.5 7289.5 7404.1 7429.0 7430.6 7436.8 37300.1 37485.3 37638.6 37663.6 37714.4 2975.6 3012.8 3172.0 3344.3 3628.6 28053.3 28597.1 28633.6 28769.7 28891.0 3265.4 3288.1 3357.5 3385.8 3452.3 231585.8 233249.0 234194.0 234553.0 235006.0 29148.3 50700.2 51004.5 51058.2 51137.7 29060.0 30690.4 30882.0 31021.2 31233.4 11092.7 11100.0 11108.7 11138.9 11206.7 9964.0 10024.5 10050.2 10052.2 10063.0 6881.4 6956.7 7058.6 7144.6 7319.8 2730.2 2733.1 2797.8 2824.8 2844.9 809.9 896.6 946.1 969.2 979.9 26129.2 26604.6 27044.0 27094.6 27283.3 722.6 896.8 900.1 904.3 916.6 13352.4 14737.7 15369.8 16200.4 16406.8 351591.0 352527.0 352821.0 353710.0 354322.0 48220.3 48639.5 48640.3 48663.0 48733.8 1041.5 1083.6 1137.3 1160.3 1191.3 25279.9 27659.0 28382.3 29049.1 29076.6 40034.8 40810.2 40878.4 41063.4 41082.2 282462.0 282751.3 283724.0 284786.0 285143.0 22408.7 23423.3 23454.8 24276.8 24462.1 39074.6 39245.2 39272.0 39723.4 40544.4 33646.3 33758.8 33827.5 33987.5 34191.3 33719.3 34064.8 34075.0 34200.7 35045.3 33587.7 34209.0 34397.8 34507.0 34610.0 27209.0 28190.7 30850.8 31123.7 31646.7 23572.3 24170.6 24251.4 24793.4 26172.6 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | [#2] jquery.html Cycles:180 Average:23962.62 Median:5239.58 stddev:59120.07 (1128.3%) stddev-sans-first:59259.29 17:46:51 INFO - PROCESS | 22737 | Values: 329.5 343.9 350.7 352.2 369.2 12372.7 15416.5 15775.7 17483.3 17693.2 15434.2 15699.8 16009.2 16083.7 16106.2 4840.4 4846.5 5007.6 5007.9 5028.1 4890.5 4950.5 4964.7 4974.3 4975.2 3588.1 3776.7 5463.3 5703.9 5738.9 5032.5 5799.2 5819.4 5821.1 5825.1 5127.3 5234.4 5238.6 5240.6 5241.6 19835.6 19927.5 19947.2 19971.7 20024.7 1734.5 1844.2 1990.4 2062.5 2246.3 8394.5 8500.9 8667.2 8834.1 13862.9 1729.8 1769.6 1827.3 1864.5 1870.7 78437.0 83496.0 84252.6 85408.6 86276.6 15713.9 16337.0 16541.0 16697.6 17298.0 29007.4 29028.7 29049.0 29092.1 29130.0 8149.9 8447.2 8491.5 8600.7 8706.6 6774.3 6803.6 6818.7 6944.7 7138.2 8310.0 8324.8 8611.7 8770.8 8793.1 3179.3 3211.6 3351.4 3352.4 3452.4 705.8 777.9 828.9 842.7 878.2 16125.9 16417.3 16501.0 16678.7 16879.5 796.0 808.7 834.7 843.8 850.5 8884.0 9061.3 9483.6 9517.5 9675.8 346907.3 352119.0 355732.0 357676.0 362642.0 74593.0 74971.6 75378.2 75462.0 77682.2 834.1 849.3 861.3 875.2 875.3 14486.0 14722.3 15092.4 15157.3 15230.2 24387.9 24649.4 34536.5 35214.3 36227.6 48454.5 49227.8 49655.8 49922.5 50108.5 6825.5 6927.3 7030.0 7131.7 7471.0 7601.1 9980.7 10197.4 10511.3 11031.1 6562.7 9250.2 9423.4 9470.4 9650.5 8988.0 9211.1 9607.8 9653.5 10045.4 9041.6 9132.5 9157.6 9233.2 9808.1 7035.5 7156.2 7202.8 7239.6 7294.5 7906.8 9350.3 9358.6 9368.2 9633.0 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | [#3] mootools.html Cycles:180 Average:4503.35 Median:5360.37 stddev:2477.89 (46.2%) stddev-sans-first:2472.12 17:46:51 INFO - PROCESS | 22737 | Values: 1162.9 1323.4 1360.9 1425.8 1664.1 5956.7 6655.0 6982.1 6993.4 7144.2 7001.0 7038.4 7043.3 7045.0 7045.3 2045.9 2076.9 2078.9 2079.6 2082.2 2045.1 2058.7 2080.5 2094.4 2099.2 2033.3 2042.8 2053.6 2055.5 2056.9 2000.3 2027.2 2031.3 2032.9 2033.7 2006.6 2012.0 2060.1 2062.6 2063.4 6714.0 6845.7 6890.6 6948.4 6998.4 3951.2 4127.0 4131.6 4133.7 4140.8 2568.4 2715.2 2757.9 2763.6 2773.2 837.9 852.4 856.9 860.3 904.6 9077.9 9149.4 9166.3 9173.3 9174.6 3383.0 3519.4 3582.5 3588.2 3588.3 7445.9 7448.0 7448.3 7455.1 7464.1 4050.9 4053.7 4058.9 4062.5 4064.6 3331.6 3440.5 3618.3 3722.6 3794.4 2959.6 2973.4 3026.7 3062.6 3090.8 900.5 901.7 905.8 906.8 908.1 614.5 659.7 739.4 782.6 796.7 4470.0 4509.3 4521.3 4535.3 4659.0 390.0 390.7 405.5 406.8 412.2 3187.6 3344.4 3355.2 3372.8 3426.7 7984.9 8263.0 8348.7 8352.8 8358.9 8292.4 8294.3 8314.5 8323.6 8325.6 6075.8 6369.4 6390.2 6452.8 6530.7 4839.7 4872.2 4905.0 4928.9 4997.8 7510.7 7642.4 7675.6 7696.6 7800.1 7755.1 7809.8 7897.4 7929.3 8002.1 6047.8 6109.6 6113.2 6170.6 6182.1 6565.2 6630.6 6631.2 6632.2 6651.9 5826.4 5912.5 5923.2 5976.2 6065.8 5905.8 5914.0 5922.5 5929.6 5932.3 5360.2 5360.5 5402.4 5407.8 5407.9 3865.7 3938.8 3953.4 3969.3 3990.9 3934.7 4083.4 4155.9 4181.6 4203.6 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | [#4] prototype.html Cycles:180 Average:4040.08 Median:4609.45 stddev:1171.25 (25.4%) stddev-sans-first:1140.00 17:46:51 INFO - PROCESS | 22737 | Values: 278.4 284.1 289.5 295.6 296.1 4510.4 4664.0 4673.5 4704.0 4721.0 4455.6 4584.4 4607.6 4611.3 4628.6 3441.2 3672.8 3676.2 3696.2 3696.3 3522.6 3524.3 3530.6 3535.0 3536.6 3433.8 3598.0 3600.3 3606.7 3621.8 3608.6 3616.3 3617.3 3619.3 3623.2 3117.3 3182.7 3189.0 3192.8 3210.4 4501.6 4512.6 4514.2 4522.2 4542.5 4107.0 4130.5 4134.2 4169.2 4190.7 4675.5 4813.9 4829.8 4887.0 4895.3 3511.8 3516.6 3534.3 3535.0 3550.8 5099.2 5112.7 5126.4 5126.8 5130.6 3519.8 3655.6 3658.8 3662.3 3662.9 3690.4 3713.6 3718.5 3721.9 3733.3 4154.2 4170.3 4175.9 4179.7 4184.6 4834.6 4836.4 4852.4 4855.7 4867.9 1218.5 1220.8 1236.3 1244.4 1248.5 841.8 874.3 877.4 878.7 880.5 4202.1 4211.9 4221.3 4227.4 4228.2 4831.7 4843.4 4848.2 4852.3 4889.4 4226.0 4228.5 4236.2 4238.6 4265.2 2490.5 2575.7 2577.4 2588.8 2598.3 4660.7 4675.6 4691.7 4710.0 4712.6 5026.8 5044.9 5051.4 5054.0 5056.8 4565.8 4641.6 4669.4 4690.3 4707.0 4873.9 4898.8 4905.0 4919.6 4932.4 4780.7 4781.8 4787.2 4826.7 4832.6 4526.8 4674.2 4857.5 4892.1 4900.2 3219.3 3550.5 3563.4 3580.9 3584.1 4910.4 4944.4 5072.3 5072.7 5078.4 4918.7 4919.8 4923.7 4924.8 4927.6 4707.3 4917.0 4924.4 4929.0 4933.8 4837.0 4859.6 4870.0 4872.1 4879.7 4976.7 4985.1 5001.9 5003.0 5005.4 4748.2 4870.9 4881.4 4885.9 4892.8 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - PROCESS | 22737 | [#5] yui.html Cycles:180 Average:14182.48 Median:28392.08 stddev:18780.97 (66.1%) stddev-sans-first:18805.91 17:46:51 INFO - PROCESS | 22737 | Values: 587.0 638.4 675.5 686.0 696.1 11205.4 11794.2 12167.1 12463.5 12581.2 11896.2 12098.1 12107.1 12107.4 12117.0 605.7 759.2 772.1 773.7 774.3 617.4 735.4 764.7 771.0 774.1 813.2 813.7 814.6 815.2 815.7 624.8 808.1 809.3 809.5 809.8 472.0 565.4 585.7 586.3 588.0 12238.9 12284.8 12291.6 12314.7 12354.6 9058.9 10560.8 11559.9 11801.5 12039.8 9437.3 9678.7 10776.5 10826.5 11066.6 3937.1 3953.5 3998.5 4003.0 4176.6 46707.5 47367.3 48150.9 48320.6 48749.0 9231.7 9436.3 9447.1 9537.4 9538.7 15401.8 15515.6 15944.6 15959.1 15983.6 6115.4 6336.6 6487.8 6490.9 6542.6 3358.8 3387.7 3421.1 3468.7 3492.8 2600.6 2689.4 2693.3 2694.1 2696.2 466.7 472.3 473.5 474.6 483.8 449.7 449.9 463.2 471.9 495.7 6469.5 6509.6 6536.8 6539.2 6546.5 452.4 485.6 486.6 491.8 497.4 3272.6 3273.0 3290.7 3297.7 3377.2 66997.7 68759.3 69598.7 72017.6 72112.6 59247.0 60652.0 61349.4 61690.4 62618.7 54518.0 55169.4 55622.7 55892.2 56218.7 6269.1 6367.6 6442.1 6539.4 6689.7 37637.2 38267.6 38799.0 39029.0 39173.8 45196.5 51802.0 51825.0 52342.0 52643.5 7907.7 7971.4 8094.3 8229.8 8260.4 9164.3 9308.9 9376.9 9386.4 9748.7 8573.0 8695.2 8908.8 8920.2 9875.0 9868.7 10050.0 10290.4 10522.2 10717.5 9948.5 10179.9 10214.5 10440.5 10682.5 8747.0 8948.7 9009.2 9117.5 9381.3 8872.6 9232.0 9470.0 9474.8 9514.5 17:46:51 INFO - PROCESS | 22737 | -------- Summary: end -------- 17:46:51 INFO - PROCESS | 22737 | 17:46:51 INFO - TEST-INFO | 22737: exit 0 17:46:51 INFO - TEST-OK | dromaeo_css | took 1122472ms 17:46:51 INFO - TEST-START | kraken 17:46:51 INFO - operating with platform_type : linux_ 17:46:51 INFO - Initialising browser for kraken test... 17:46:52 INFO - TEST-INFO | started process 23036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPEQgRn/profile http://localhost:60977/getInfo.html) 17:46:56 INFO - PROCESS | 23036 | __metrics Screen width/height:1600/1200 17:46:56 INFO - PROCESS | 23036 | colorDepth:24 17:46:56 INFO - PROCESS | 23036 | Browser inner width/height: 1024/697 17:46:56 INFO - PROCESS | 23036 | __metrics 17:46:56 INFO - PROCESS | 23036 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:46:56 INFO - PROCESS | 23036 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:57 INFO - PROCESS | 23036 | console.error: PushService: 17:46:57 INFO - PROCESS | 23036 | stateChangeProcessEnqueue: Error transitioning state 17:46:57 INFO - PROCESS | 23036 | UnknownError 17:46:58 INFO - TEST-INFO | 23036: exit 0 17:46:58 INFO - Browser initialized. 17:46:58 INFO - Running cycle 1/1 for kraken test... 17:46:58 INFO - TEST-INFO | started process 23119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPEQgRn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:10 INFO - PROCESS | 23119 | RSS: Main: 175656960 17:47:10 INFO - PROCESS | 23119 | 17:47:13 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60977/tests/kraken/driver.html?testName=audio-beat-detection) 17:47:14 INFO - PROCESS | 23119 | RSS: Main: 232427520 17:47:14 INFO - PROCESS | 23119 | 17:47:17 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60977/tests/kraken/driver.html?testName=audio-dft) 17:47:17 INFO - PROCESS | 23119 | RSS: Main: 218984448 17:47:17 INFO - PROCESS | 23119 | 17:47:20 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60977/tests/kraken/driver.html?testName=audio-fft) 17:47:21 INFO - PROCESS | 23119 | RSS: Main: 300961792 17:47:21 INFO - PROCESS | 23119 | 17:47:23 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60977/tests/kraken/driver.html?testName=audio-oscillator) 17:47:24 INFO - PROCESS | 23119 | RSS: Main: 211746816 17:47:24 INFO - PROCESS | 23119 | 17:47:26 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:47:27 INFO - PROCESS | 23119 | RSS: Main: 214642688 17:47:27 INFO - PROCESS | 23119 | 17:47:30 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60977/tests/kraken/driver.html?testName=imaging-darkroom) 17:47:31 INFO - PROCESS | 23119 | RSS: Main: 254578688 17:47:31 INFO - PROCESS | 23119 | 17:47:34 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60977/tests/kraken/driver.html?testName=imaging-desaturate) 17:47:35 INFO - PROCESS | 23119 | RSS: Main: 248934400 17:47:35 INFO - PROCESS | 23119 | 17:47:38 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60977/tests/kraken/driver.html?testName=json-parse-financial) 17:47:38 INFO - PROCESS | 23119 | RSS: Main: 251219968 17:47:38 INFO - PROCESS | 23119 | 17:47:40 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:47:41 INFO - PROCESS | 23119 | RSS: Main: 214376448 17:47:41 INFO - PROCESS | 23119 | 17:47:42 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:47:43 INFO - PROCESS | 23119 | RSS: Main: 220844032 17:47:43 INFO - PROCESS | 23119 | 17:47:45 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:47:46 INFO - PROCESS | 23119 | RSS: Main: 230305792 17:47:46 INFO - PROCESS | 23119 | 17:47:49 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:47:50 INFO - PROCESS | 23119 | RSS: Main: 239513600 17:47:50 INFO - PROCESS | 23119 | 17:47:53 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:53 INFO - PROCESS | 23119 | RSS: Main: 235241472 17:47:53 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | Cycle 1(1): loaded http://localhost:60977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60977/tests/kraken/driver.html?testName=ai-astar) 17:47:55 INFO - PROCESS | 23119 | RSS: Main: 286949376 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | __start_tp_report 17:47:55 INFO - PROCESS | 23119 | _x_x_mozilla_page_load 17:47:55 INFO - PROCESS | 23119 | _x_x_mozilla_page_load_details 17:47:55 INFO - PROCESS | 23119 | |i|pagename|runs| 17:47:55 INFO - PROCESS | 23119 | |0;ai-astar;110;117;116;117;116;118;117;116;118;115 17:47:55 INFO - PROCESS | 23119 | |1;audio-beat-detection;153;129;131;184;129;129;133;127;166;130 17:47:55 INFO - PROCESS | 23119 | |2;audio-dft;162;162;164;163;161;162;162;160;163;161 17:47:55 INFO - PROCESS | 23119 | |3;audio-fft;76;77;77;112;80;77;77;76;103;76 17:47:55 INFO - PROCESS | 23119 | |4;audio-oscillator;84;83;118;84;83;83;113;84;84;117 17:47:55 INFO - PROCESS | 23119 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;116;118;117 17:47:55 INFO - PROCESS | 23119 | |6;imaging-darkroom;147;146;147;148;146;146;147;148;147;146 17:47:55 INFO - PROCESS | 23119 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 17:47:55 INFO - PROCESS | 23119 | |8;json-parse-financial;65;66;64;66;66;66;66;65;65;65 17:47:55 INFO - PROCESS | 23119 | |9;json-stringify-tinderbox;66;66;65;66;67;66;66;65;66;66 17:47:55 INFO - PROCESS | 23119 | |10;stanford-crypto-aes;85;88;91;93;85;85;83;89;85;84 17:47:55 INFO - PROCESS | 23119 | |11;stanford-crypto-ccm;150;164;142;144;143;163;142;148;185;147 17:47:55 INFO - PROCESS | 23119 | |12;stanford-crypto-pbkdf2;180;177;179;177;181;180;178;177;177;182 17:47:55 INFO - PROCESS | 23119 | |13;stanford-crypto-sha256-iterative;74;72;71;69;71;70;68;69;69;68 17:47:55 INFO - PROCESS | 23119 | __end_tp_report 17:47:55 INFO - PROCESS | 23119 | __start_cc_report 17:47:55 INFO - PROCESS | 23119 | _x_x_mozilla_cycle_collect,2019 17:47:55 INFO - PROCESS | 23119 | __end_cc_report 17:47:55 INFO - PROCESS | 23119 | __startTimestamp1479520075671__endTimestamp 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | ------- Summary: start ------- 17:47:55 INFO - PROCESS | 23119 | Number of tests: 14 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#0] ai-astar Cycles:10 Average:116.00 Median:117.00 stddev:2.31 (2.0%) stddev-sans-first:1.00 17:47:55 INFO - PROCESS | 23119 | Values: 110.0 117.0 116.0 117.0 116.0 118.0 117.0 116.0 118.0 115.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:132.00 stddev:19.81 (15.0%) stddev-sans-first:20.54 17:47:55 INFO - PROCESS | 23119 | Values: 153.0 129.0 131.0 184.0 129.0 129.0 133.0 127.0 166.0 130.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 17:47:55 INFO - PROCESS | 23119 | Values: 162.0 162.0 164.0 163.0 161.0 162.0 162.0 160.0 163.0 161.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:13.08 (17.0%) stddev-sans-first:13.62 17:47:55 INFO - PROCESS | 23119 | Values: 76.0 77.0 77.0 112.0 80.0 77.0 77.0 76.0 103.0 76.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.50 stddev:15.72 (18.8%) stddev-sans-first:16.31 17:47:55 INFO - PROCESS | 23119 | Values: 84.0 83.0 118.0 84.0 83.0 83.0 113.0 84.0 84.0 117.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:47:55 INFO - PROCESS | 23119 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:47:55 INFO - PROCESS | 23119 | Values: 147.0 146.0 147.0 148.0 146.0 146.0 147.0 148.0 147.0 146.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:47:55 INFO - PROCESS | 23119 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 17:47:55 INFO - PROCESS | 23119 | Values: 65.0 66.0 64.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:47:55 INFO - PROCESS | 23119 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 66.0 65.0 66.0 66.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.29 (3.8%) stddev-sans-first:3.43 17:47:55 INFO - PROCESS | 23119 | Values: 85.0 88.0 91.0 93.0 85.0 85.0 83.0 89.0 85.0 84.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:149.00 stddev:13.89 (9.3%) stddev-sans-first:14.70 17:47:55 INFO - PROCESS | 23119 | Values: 150.0 164.0 142.0 144.0 143.0 163.0 142.0 148.0 185.0 147.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:179.50 stddev:1.87 (1.0%) stddev-sans-first:1.94 17:47:55 INFO - PROCESS | 23119 | Values: 180.0 177.0 179.0 177.0 181.0 180.0 178.0 177.0 177.0 182.0 17:47:55 INFO - PROCESS | 23119 | 17:47:55 INFO - PROCESS | 23119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.91 (2.7%) stddev-sans-first:1.41 17:47:55 INFO - PROCESS | 23119 | Values: 74.0 72.0 71.0 69.0 71.0 70.0 68.0 69.0 69.0 68.0 17:47:55 INFO - PROCESS | 23119 | -------- Summary: end -------- 17:47:55 INFO - PROCESS | 23119 | 17:47:56 INFO - TEST-INFO | 23119: exit 0 17:47:57 INFO - TEST-OK | kraken | took 65002ms 17:47:57 INFO - SUITE-END | took 1187s 17:47:57 INFO - Completed test suite (00:19:47) 17:47:57 INFO - javascript benchmark 17:47:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2515.7232704402513, 2563.7948964082875, 2578.4714133602615, 2597.6493173421595, 2606.1920804550577, 4484.282514797633, 4568.90862182757, 4575.8398456054, 4603.7928293226805, 4615.215413379725, 4604.217283061879, 4611.5619016193405, 4618.699784514012, 4621.191291523978, 4633.930491042629, 4203.537610862811, 4224.239636865363, 4233.1956928183545, 4248.617624413802, 4313.935290970638, 4289.420928174688, 4292.463442069741, 4297.742135471882, 4317.503487098977, 4321.654267658596, 4284.957150428487, 4293.29160688486, 4314.0, 4322.697411181203, 4372.038151606642, 4401.977990110045, 4403.493598236212, 4411.382406463098, 4412.294032954744, 4448.021435284232, 4146.253674338618, 4193.958060419387, 4198.3702444633545, 4325.978370108161, 4362.454693163355, 4570.382998295221, 4641.0, 4649.070185962787, 4652.255639097728, 4655.11552804966, 4939.135651261051, 4971.577415919651, 4983.302337672729, 4984.22744474607, 5025.974870125626, 4837.9032419351415, 4947.777350019258, 5002.674826136289, 5015.39815222172, 5046.09170349337, 4600.378948841931, 4631.212693842055, 4673.252279635242, 4712.434507859079, 4714.764261786897, 5116.309298244763, 5116.744162791845, 5118.0, 5121.436641969381, 5166.948330516722, 4876.902461950741, 4886.193778026657, 4887.29134275528, 4894.363732714724, 4930.038642464757, 4758.714477131383, 4822.107910036654, 4826.32431459596, 4847.515248475124, 4905.23968784839, 4854.368932038812, 4857.635677324215, 4882.267659851051, 4907.337509436252, 4907.950920490821, 4831.661783675179, 4858.17411040124, 4874.658773885865, 4878.82924097662, 4910.386201724785, 3946.1910308386714, 4065.3495440729343, 4070.6132917373393, 4093.2427500912427, 4137.317342638491, 3568.4468907319406, 3581.391163502211, 3588.2823435313044, 3647.908802279911, 3649.2883887641656, 4351.26028575143, 4353.73877567347, 4379.386885835986, 4391.5827996340295, 4397.1205758848355, 5029.924551131736, 5032.521910418504, 5035.395752509722, 5038.823641172615, 5056.696598204119, 4167.8332866685, 4223.049813791934, 4326.15639950213, 4329.956700433018, 4368.716033457815, 4289.0, 4432.955670443319, 4481.574250446268, 4491.752953587584, 4535.115652447807, 4780.737059461763, 4818.4217893852265, 4821.590164836029, 4823.903521929542, 4864.440589332131, 4785.425748910153, 4839.612830973584, 5034.84895453137, 5036.697798132123, 5090.08378491875, 4667.229907065296, 4695.5304469552775, 4766.428028636586, 4776.546228108324, 4839.95160048395, 4952.2819191217795, 4962.925556116734, 4965.4041515018425, 4966.826161084345, 5000.2499625056535, 4990.451050384382, 5027.044861476308, 5036.345275114211, 5037.093323201859, 5062.82280120194, 4675.812967481263, 4703.318018887174, 4730.952690473051, 4752.2158843790385, 4794.712317260975, 4828.66199366041, 4835.057163853015, 4835.492273311252, 4855.635827313036, 4877.170880950318, 4741.83403580873, 4749.881252968704, 4752.0, 4752.6197904168275, 4796.856094317176, 4678.60231880294, 4736.313234581035, 4740.170470167638, 4857.975710121426, 4894.828680996148, 4763.595094417014, 4784.210605250095, 4808.711477311373, 4838.782254798472, 4881.365422495053], "value": 4556.586786361503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.521204158403, 566.0151336674186, 578.1097110449907, 589.172213040678, 592.899207134787, 28458.14625561231, 39125.217495650104, 40226.59773402265, 40236.79881600588, 43470.34794478078, 39944.80027599865, 40392.19215615693, 40400.79799601005, 40410.7979460103, 40462.393064104064, 7505.099388073425, 7650.617469126521, 7651.961740191291, 7657.846843063136, 7658.693652253904, 7342.632868356587, 7433.628318584077, 7434.962825185867, 7441.25587441257, 7445.81385465365, 7440.888386674204, 7457.216992215821, 7479.326860582546, 7482.0, 7485.812854678622, 7373.668184931691, 7377.963110184468, 7416.147143078534, 7449.739259125959, 7464.514806537585, 7289.489735718502, 7404.111506619241, 7429.0, 7430.628468576603, 7436.814079647998, 37300.06749831276, 37485.25029499422, 37638.62361376406, 37663.62336376629, 37714.43428348577, 2975.61317028787, 3012.7891047626676, 3172.0, 3344.347852168828, 3628.6008539060945, 28053.298667533272, 28597.14208573746, 28633.57049644257, 28769.71230287712, 28891.0, 3265.4448743713624, 3288.095773662238, 3357.529945807589, 3385.847636856323, 3452.2750222453064, 231585.84207079024, 233249.0, 234194.0, 234553.0, 235006.0, 29148.27129321784, 50700.23949640759, 51004.489955099976, 51058.23412648813, 51137.744311278206, 29060.0, 30690.38619227603, 30882.0, 31021.224469388446, 31233.375332493222, 11092.722681933015, 11100.0, 11108.666739997652, 11138.888611113785, 11206.663800086011, 9964.0, 10024.54889529973, 10050.246231532665, 10052.246081543914, 10063.0, 6881.449484041264, 6956.686949087303, 7058.61177635235, 7144.571325720473, 7319.780406587811, 2730.235534050469, 2733.1253998720217, 2797.818141820816, 2824.8022638415523, 2844.857757112136, 809.906860711014, 896.5562046786882, 946.1002028781762, 969.2343048991218, 979.8677178580942, 26129.216123516326, 26604.56052614591, 27044.0, 27094.5935810963, 27283.31791705223, 722.5953466059024, 896.8161526886972, 900.090908182727, 904.3036861616519, 916.6425094213262, 13352.399142038632, 14737.705245895237, 15369.769453458208, 16200.432984845474, 16406.83593164077, 351591.0, 352527.0, 352821.0, 353710.0, 354322.0, 48220.27669584959, 48639.51360486421, 48640.27039594409, 48663.0, 48733.756331218116, 1041.5000799616228, 1083.5557421457006, 1137.2891942535914, 1160.2632328471482, 1191.2852288626927, 25279.87360063188, 27659.0, 28382.29044273827, 29049.12852614425, 29076.56385154182, 40034.79982600185, 40810.1837963245, 40878.38682419706, 41063.38404923988, 41082.17835643211, 282462.0, 282751.3449731035, 283724.0, 284786.0, 285143.0, 22408.66387004229, 23423.297301080995, 23454.76545234526, 24276.757232427448, 24462.143824966042, 39074.60925390823, 39245.2150956985, 39272.0, 39723.40414893721, 40544.391834121925, 33646.327073457905, 33758.8312058448, 33827.492587610715, 33987.49018764671, 34191.31617367688, 33719.325613487104, 34064.82967585146, 34075.0, 34200.65799341975, 35045.299094017464, 33587.66412335845, 34209.0, 34397.82801085978, 34507.0, 34610.0, 27209.047683330988, 28190.71809281881, 30850.845745772025, 31123.68876311208, 31646.683533164374, 23572.29283121509, 24170.637440438055, 24251.39371515726, 24793.380165496008, 26172.635436218767], "value": 15634.924314446267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.52219282041017, 343.9294944536372, 350.72643338196207, 352.2356486424459, 369.1969965325417, 12372.690682732926, 15416.537503874888, 15775.684486310267, 17483.300667973297, 17693.203805828736, 15434.228288585582, 15699.764503532457, 16009.19954002301, 16083.678326433464, 16106.194690265469, 4840.370751802261, 4846.515348465143, 5007.574356179729, 5007.899842003158, 5028.094942910275, 4890.462049174588, 4950.504949505057, 4964.677295975768, 4974.328465657126, 4975.2039673652225, 3588.1388466767917, 3776.678982286509, 5463.289772329612, 5703.914441283384, 5738.856528586798, 5032.547070763649, 5799.159121927339, 5819.418058194168, 5821.068629019379, 5825.097109947944, 5127.333446651912, 5234.42421333653, 5238.580913526908, 5240.580753539708, 5241.606879484016, 19835.603287934304, 19927.501812454804, 19947.202111915507, 19971.700424493643, 20024.69962950557, 1734.54901725551, 1844.170123444442, 1990.3531352310556, 2062.4740691123666, 2246.2811900191946, 8394.538300393477, 8500.914990850075, 8667.21995020445, 8834.07242239562, 13862.861371386258, 1729.8270172982727, 1769.646070785835, 1827.3330234464458, 1864.5431869192134, 1870.6632806094897, 78437.0, 83496.0, 84252.57873710654, 85408.57295713543, 86276.56861715714, 15713.921430392775, 16337.0, 16541.0, 16697.582560435843, 17298.0, 29007.41985160285, 29028.7097129026, 29049.0, 29092.127236182947, 29130.0, 8149.877751833727, 8447.155284471504, 8491.532965686947, 8600.655973760979, 8706.564671766386, 6774.288699686561, 6803.557768745016, 6818.693158807866, 6944.652318376445, 7138.179109402381, 8310.0, 8324.750257492286, 8611.741647750578, 8770.780730481789, 8793.120687931283, 3179.300553878143, 3211.566438530768, 3351.379994700988, 3352.446846270338, 3452.375006243434, 705.8447141628833, 777.9066512018594, 828.9088200297963, 842.688205364007, 878.1745159550003, 16125.919370403308, 16417.261223244983, 16501.0, 16678.749818752727, 16879.493615191564, 795.9562224077731, 808.7048227397075, 834.6828205281954, 843.7974886027309, 850.459957926721, 8884.0, 9061.275097992146, 9483.620655173854, 9517.524123793783, 9675.806483870423, 346907.26546367106, 352119.0, 355732.0, 357676.0, 362642.0, 74593.0, 74971.62514187394, 75378.24621753712, 75462.0, 77682.22317776862, 834.0741776627938, 849.295085079395, 861.280830506534, 875.2035647560816, 875.2910142784365, 14486.0, 14722.337494812546, 15092.39630414771, 15157.317920693375, 15230.182416253028, 24387.878060609582, 24649.38376540529, 34536.48195277023, 35214.29571408609, 36227.63772362243, 48454.515454845, 49227.75386123046, 49655.75172124116, 49922.50077499324, 50108.49891501184, 6825.453963682993, 6927.307269273032, 7030.0, 7131.714731410893, 7471.0, 7601.0878694557005, 9980.650677226553, 10197.439140847324, 10511.316764410289, 11031.062359699516, 6562.7202695475835, 9250.21373183287, 9423.434593924387, 9470.431774093577, 9650.517474126405, 8987.955060224656, 9211.078892110736, 9607.759806004626, 9653.476481084213, 10045.447500387549, 9041.638334466548, 9132.452052876848, 9157.587908543997, 9233.215176710055, 9808.117269445498, 7035.487370215224, 7156.212816590275, 7202.819929501804, 7239.565626062453, 7294.452916031425, 7906.802329941797, 9350.298727595593, 9358.578863951274, 9368.203702685076, 9633.0], "value": 8488.502567731233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1162.9244099133562, 1323.444153455549, 1360.8843248323892, 1425.7504936636087, 1664.1429663723184, 5956.702164891754, 6654.966725166373, 6982.057422247989, 6993.405560527362, 7144.178419481761, 7001.0, 7038.366547010768, 7043.26045765195, 7045.048918396015, 7045.295470452965, 2045.877247365159, 2076.940760212295, 2078.8544801863877, 2079.61527117483, 2082.1567265257595, 2045.1410407628832, 2058.711780350752, 2080.459080639037, 2094.413564202026, 2099.2442720620566, 2033.3188381892085, 2042.8059334363286, 2053.609814135317, 2055.4758536573154, 2056.876587404753, 2000.3198912369792, 2027.2397850805949, 2031.2992017753852, 2032.9288474903308, 2033.66444536652, 2006.6287736768745, 2012.0241682783837, 2060.103854823142, 2062.577171679802, 2063.3603582889205, 6714.0, 6845.657717114124, 6890.552114112616, 6948.374646281859, 6998.405135563483, 3951.249262640089, 4127.009517715756, 4131.628153466172, 4133.731307465036, 4140.834366625331, 2568.4349443122483, 2715.185444366682, 2757.8621068946472, 2763.6130941668184, 2773.1819113361607, 837.9078301386843, 852.433131967241, 856.943335993614, 860.2859626509982, 904.5658084119659, 9077.863832042525, 9149.405288656217, 9166.26669866409, 9173.31200159984, 9174.633014679404, 3382.9661703383144, 3519.419295816213, 3582.480540321691, 3588.1926566522325, 3588.2823435313044, 7445.85108297831, 7448.031755871811, 7448.329650331388, 7455.142658594223, 7464.1416237132335, 4050.8987275318354, 4053.7162398632404, 4058.8782336529953, 4062.512498500199, 4064.634182923551, 3331.6168640606156, 3440.501127336522, 3618.2582570572968, 3722.6091260417807, 3794.449804778347, 2959.5560665899857, 2973.3904549567287, 3026.7427268681968, 3062.632484101922, 3090.752739780857, 900.4867225681298, 901.6618767962015, 905.8097799462055, 906.7687739626354, 908.0873721909571, 614.5022531749208, 659.6899457255082, 739.3973911262304, 782.6243403166512, 796.6733639207897, 4470.016596348798, 4509.278515437514, 4521.299198624219, 4535.274356103007, 4658.95341046592, 389.95515515716056, 390.7323483413871, 405.5397124263982, 406.83523173114935, 412.22501696809803, 3187.565201331724, 3344.4481660526226, 3355.177981394574, 3372.8144952027383, 3426.7087297579487, 7984.880226796603, 8263.0, 8348.749537513884, 8352.8329433411, 8358.874616880752, 8292.37807164465, 8294.253517183482, 8314.459560128693, 8323.625436855356, 8325.583720813935, 6075.787347442818, 6369.363063693593, 6390.201224846895, 6452.838679032968, 6530.67346632676, 4839.733814640088, 4872.171730805842, 4904.950950490592, 4928.926066109083, 4997.775100120431, 7510.662020209213, 7642.3504002158215, 7675.61621918913, 7696.576688282198, 7800.102988156435, 7755.069391673035, 7809.804754881174, 7897.407694422826, 7929.286364227247, 8002.07976082758, 6047.848803779941, 6109.602875813058, 6113.174721412553, 6170.568060235741, 6182.103594978613, 6565.212174539086, 6630.635315057718, 6631.204255489372, 6632.1709786276715, 6651.933480665131, 5826.359100498857, 5912.49743771767, 5923.170756094064, 5976.193213916065, 6065.8180254592435, 5905.822825315247, 5914.0, 5922.526197904243, 5929.555283353852, 5932.2584676915385, 5360.222767698584, 5360.517553420211, 5402.432744561765, 5407.83776486706, 5407.864803379947, 3865.6520913117956, 3938.803059846939, 3953.4069889516804, 3969.285528604879, 3990.880273591797, 3934.7048971326694, 4083.428320035257, 4155.854545090907, 4181.644560212416, 4203.579642035895], "value": 3600.7919289754304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.43894552476763, 284.11073340444403, 289.48616206233936, 295.6437492821151, 296.09985643643324, 4510.391097201885, 4664.0, 4673.462551806543, 4703.9529604703985, 4721.0343311618235, 4455.643548516119, 4584.381108550345, 4607.562281583244, 4611.33135695324, 4628.583427491525, 3441.2257242120572, 3672.797996110213, 3676.2279921216577, 3696.242270334575, 3696.2607478504406, 3522.594901586312, 3524.3479956208057, 3530.5763308402898, 3534.982325088371, 3536.646335366456, 3433.7768045077114, 3598.0, 3600.3339382214376, 3606.71146308296, 3621.782693038413, 3608.6210947850623, 3616.3309787689363, 3617.2765446910594, 3619.2761447710564, 3623.184783423735, 3117.345357474933, 3182.745380369565, 3188.952165717493, 3192.776505644606, 3210.3739770744714, 4501.639868810487, 4512.638988880882, 4514.164879497303, 4522.163399771053, 4542.500324964251, 4106.958930410688, 4130.451080844683, 4134.1731653669085, 4169.187008533338, 4190.664746820247, 4675.462321832999, 4813.879653008667, 4829.782659780319, 4886.975565122151, 4895.290182923456, 3511.8068506232403, 3516.5757868063474, 3534.2578058607724, 3534.9823250883837, 3550.840212190458, 5099.23511473282, 5112.71880046601, 5126.384833819965, 5126.846194614168, 5130.589552835764, 3519.8416071276342, 3655.5796083450214, 3658.7804731716183, 3662.322470342995, 3662.9450558241647, 3690.409534474525, 3713.628637136319, 3718.475425075706, 3721.9255614888093, 3733.3093377724663, 4154.169166166718, 4170.332746760504, 4175.937360939588, 4179.686523510749, 4184.560621134798, 4834.59796658972, 4836.443808962014, 4852.369192005017, 4855.717812628059, 4867.902641947212, 1218.506504865513, 1220.791416497661, 1236.3385588709998, 1244.3591550351575, 1248.5380409248455, 841.7937605286744, 874.3267683883502, 877.4077497689034, 878.7232021913077, 880.5289170293862, 4202.117555313418, 4211.894702632459, 4221.256183480762, 4227.408162857141, 4228.217779710763, 4831.685940413862, 4843.39457567804, 4848.151573474628, 4852.272159176152, 4889.413270407503, 4226.0, 4228.505181942669, 4236.173946080547, 4238.6397156242065, 4265.210935976792, 2490.514349701827, 2575.7166711661703, 2577.3943123365993, 2588.831725937808, 2598.311447466423, 4660.743659098782, 4675.555822196886, 4691.718496890129, 4709.95290047102, 4712.5994290485005, 5026.824061157842, 5044.924326135111, 5051.368578927634, 5053.974730126326, 5056.82301119459, 4565.771711414416, 4641.5652417211695, 4669.41632295963, 4690.273007683814, 4706.976465117653, 4873.879007828148, 4898.755062246944, 4904.994476132313, 4919.581835544019, 4932.408111026556, 4780.6653534253655, 4781.832635857728, 4787.234042553175, 4826.734529600905, 4832.613390928787, 4526.8189272428735, 4674.22875225584, 4857.465678775261, 4892.143874821821, 4900.215965445655, 3219.340035292806, 3550.5265314895064, 3563.429851223792, 3580.874669386559, 3584.121890136933, 4910.386201724785, 4944.381952255968, 5072.34059572268, 5072.67027643202, 5078.365204349457, 4918.729469879191, 4919.754012299442, 4923.704577725204, 4924.753762311799, 4927.556519913225, 4707.328283938534, 4916.975415122902, 4924.4090709115135, 4928.950710492849, 4933.802647894044, 4837.0, 4859.586935110414, 4870.0, 4872.074305881871, 4879.658423910292, 4976.676516026447, 4985.102681517362, 5001.899582091934, 5003.0, 5005.398272552894, 4748.192807222711, 4870.902581948412, 4881.438634557071, 4885.949520853033, 4892.779824907959], "value": 3670.4183708193045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.007110858635, 638.4254171245879, 675.5136301862657, 685.9862802743945, 696.1437431958689, 11205.439728013598, 11794.23337483063, 12167.08746843987, 12463.501459941614, 12581.18222315551, 11896.226745261574, 12098.092643051763, 12107.091968102384, 12107.394630268496, 12117.0, 605.7455868535204, 759.1687102622647, 772.1082150116596, 773.6750564762813, 774.3263360876017, 617.4350469320566, 735.4226931858492, 764.678834889345, 770.96916123355, 774.0711146624045, 813.2436833744615, 813.7477382011596, 814.5927036481759, 815.2255357410484, 815.7022686719334, 624.8281722526297, 808.1070417189039, 809.3282575462352, 809.5142914251461, 809.7530253272749, 472.0158469590907, 565.4486875296594, 585.7452008376328, 586.3403670870271, 588.0326862311516, 12238.938805306005, 12284.815727764091, 12291.56979505713, 12314.692132696755, 12354.567590134302, 9058.864117038183, 10560.841587376195, 11559.884401155965, 11801.527938882435, 12039.819402708967, 9437.292203084728, 9678.661246856396, 10776.515056822383, 10826.512806923629, 11066.612668556561, 3937.1141493164096, 3953.5453422856453, 3998.5001874765653, 4003.03927057507, 4176.644985176264, 46707.53292467066, 47367.28949065732, 48150.85133824562, 48320.55038348855, 48749.0, 9231.723048308562, 9436.292278079172, 9447.102525260088, 9537.427754334623, 9538.666146684833, 15401.845981540042, 15515.612109697347, 15944.601384965237, 15959.122248276457, 15983.60040998961, 6115.449609535074, 6336.58812177207, 6487.772927947499, 6490.935090649033, 6542.574732642363, 3358.8152651604396, 3387.6612338766417, 3421.0934102462866, 3468.6878180963836, 3492.7729697569575, 2600.622909678086, 2689.3814422682894, 2693.340131667754, 2694.1378758797387, 2696.150712525548, 466.7362939938924, 472.32457585652844, 473.5217430395257, 474.594221940243, 483.80889548628096, 449.66499957531846, 449.9460064792246, 463.1547425947659, 471.86315968369473, 495.6951474842946, 6469.51478639104, 6509.641969691713, 6536.7712130075215, 6539.2479864815205, 6546.476281897437, 452.42767898608287, 485.6406259368042, 486.6496122791584, 491.7541229385307, 497.4478329054746, 3272.6236482804306, 3272.9508115450835, 3290.670932906738, 3297.7196938260518, 3377.189474526145, 66997.66501167463, 68759.3124068753, 69598.65200673965, 72017.6399118001, 72112.63943680248, 59247.0, 60652.0, 61349.38650613437, 61690.383096168465, 62618.68690656518, 54518.0, 55169.44830551643, 55622.72188639031, 55892.161617575766, 56218.71890640521, 6269.122322874892, 6367.61794292344, 6442.133250703392, 6539.378759017885, 6689.69896354675, 37637.24725505529, 38267.61732382752, 38799.0, 39029.0, 39173.804130979166, 45196.54803451923, 51801.970694542404, 51825.0, 52342.0, 52643.47356526539, 7907.723229687163, 7971.402144839044, 8094.271515563628, 8229.753107406787, 8260.380471464785, 9164.266858651159, 9308.860367094363, 9376.906230937604, 9386.436813791195, 9748.707538773848, 8572.957135214285, 8695.217430431292, 8908.821823563621, 8920.24177944856, 9875.024995000886, 9868.703938881845, 10050.001984205514, 10290.3825770454, 10522.21083418762, 10717.464126793786, 9948.45283509414, 10179.949100254451, 10214.489275536045, 10440.53017614194, 10682.519286631965, 8746.956265218632, 8948.68679596211, 9009.189172974464, 9117.544122793966, 9381.296402769683, 8872.600732966903, 9232.015116749932, 9470.00349667832, 9474.810503790024, 9514.476703781358], "value": 5716.763685066133, "unit": "score"}], "name": "dromaeo_css", "value": 5979.257830036867, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0, 116.0, 118.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 131.0, 184.0, 129.0, 129.0, 133.0, 127.0, 166.0, 130.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 161.0, 162.0, 162.0, 160.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 112.0, 80.0, 77.0, 77.0, 76.0, 103.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 84.0, 83.0, 83.0, 113.0, 84.0, 84.0, 117.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 91.0, 93.0, 85.0, 85.0, 83.0, 89.0, 85.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 164.0, 142.0, 144.0, 143.0, 163.0, 142.0, 148.0, 185.0, 147.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 179.0, 177.0, 181.0, 180.0, 178.0, 177.0, 177.0, 182.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 69.0, 71.0, 70.0, 68.0, 69.0, 69.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1574.3999999999999, "alertThreshold": 2.0}]} 17:47:57 INFO - Return code: 0 17:47:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:47:57 INFO - # TBPL SUCCESS # 17:47:57 INFO - Running post-action listener: _resource_record_post_action 17:47:57 INFO - [mozharness: 2016-11-19 01:47:57.486380Z] Finished run-tests step (success) 17:47:57 INFO - Running post-run listener: _resource_record_post_run 17:47:57 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 402747392; Read time: 20; Write time: 273416 17:47:57 INFO - TinderboxPrint: CPU usage
13.1% 17:47:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 17:47:57 INFO - TinderboxPrint: I/O write bytes / time
402,747,392 / 273,416 17:47:57 INFO - TinderboxPrint: CPU idle
8,350.6 (86.9%) 17:47:57 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 17:47:57 INFO - TinderboxPrint: Swap in / out
0 / 0 17:47:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110759936; Read time: 0; Write time: 65248 17:47:57 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291987456; Read time: 0; Write time: 208168 17:47:58 INFO - Running post-run listener: _upload_blobber_files 17:47:58 INFO - Blob upload gear active. 17:47:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47: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 17:47: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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:47: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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:47:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:59 INFO - (blobuploader) - INFO - Done attempting. 17:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:01 INFO - (blobuploader) - INFO - Done attempting. 17:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:05 INFO - (blobuploader) - INFO - Done attempting. 17:48:05 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:05 INFO - Return code: 0 17:48:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59da295c6a6dc31c429dce1d734cf90685f11f128318fd32dcf442e5d19a11b5e1658bacecba5b3827045ac5d97fe04360f92ef7167ccc67ebc1ae81ec02726b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c36d25a945f3285df48c8689af04b9cececc4d6fd34ada9bc8fd0a8aead79cee958f25e557c59ef5f972142c6b310eb1b56766151433adf6514560049174a45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba4aab63e1a7ed20e84b65139784299a166dfa41136d0bfe0f487e26b65d05bf50d41d921fb81afb46be606e7304dfa1e43679cffe23c9b3b5be3729ee650f88"} 17:48:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:05 INFO - Contents: 17:48:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59da295c6a6dc31c429dce1d734cf90685f11f128318fd32dcf442e5d19a11b5e1658bacecba5b3827045ac5d97fe04360f92ef7167ccc67ebc1ae81ec02726b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c36d25a945f3285df48c8689af04b9cececc4d6fd34ada9bc8fd0a8aead79cee958f25e557c59ef5f972142c6b310eb1b56766151433adf6514560049174a45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba4aab63e1a7ed20e84b65139784299a166dfa41136d0bfe0f487e26b65d05bf50d41d921fb81afb46be606e7304dfa1e43679cffe23c9b3b5be3729ee650f88"} 17:48:05 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:05 INFO - Copying logs to upload dir... 17:48:05 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.642940 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-18 17:48:04.698577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 17:48:04.702567) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59da295c6a6dc31c429dce1d734cf90685f11f128318fd32dcf442e5d19a11b5e1658bacecba5b3827045ac5d97fe04360f92ef7167ccc67ebc1ae81ec02726b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c36d25a945f3285df48c8689af04b9cececc4d6fd34ada9bc8fd0a8aead79cee958f25e557c59ef5f972142c6b310eb1b56766151433adf6514560049174a45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba4aab63e1a7ed20e84b65139784299a166dfa41136d0bfe0f487e26b65d05bf50d41d921fb81afb46be606e7304dfa1e43679cffe23c9b3b5be3729ee650f88"} build_url:https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011563 build_url: 'https://queue.taskcluster.net/v1/task/Dp-oZuTIToq9INmGn29_-w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/59da295c6a6dc31c429dce1d734cf90685f11f128318fd32dcf442e5d19a11b5e1658bacecba5b3827045ac5d97fe04360f92ef7167ccc67ebc1ae81ec02726b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c36d25a945f3285df48c8689af04b9cececc4d6fd34ada9bc8fd0a8aead79cee958f25e557c59ef5f972142c6b310eb1b56766151433adf6514560049174a45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba4aab63e1a7ed20e84b65139784299a166dfa41136d0bfe0f487e26b65d05bf50d41d921fb81afb46be606e7304dfa1e43679cffe23c9b3b5be3729ee650f88"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 17:48:04.728500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:48:04.728834) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1479514968.225506-984449515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 17:48:04.815175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 17:48:04.816037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 17:48:04.816738) ========= ========= Total master_lag: 0.18 =========