builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1480939972.74 results: success (0) buildid: 20161205032438 builduid: 2602dd485acc4387b777bd4f4aa3f427 revision: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.742180) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.742707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.743010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.768334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.768609) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-05 04:12:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-12-05 04:12:54 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.906280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.906609) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.957076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:52.957407) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac --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 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac --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=3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-05 04:12:55,063 truncating revision to first 12 chars 2016-12-05 04:12:55,063 Setting DEBUG logging. 2016-12-05 04:12:55,063 attempt 1/10 2016-12-05 04:12:55,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/954a21ff3d44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-05 04:12:55,398 unpacking tar archive at: graphics-954a21ff3d44/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:53.634114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:53.634552) ========= script_repo_revision: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:53.635032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:53.635426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 04:12:53.645734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-12-05 04:12:53.646176) ========= /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=3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:55 INFO - MultiFileLogger online at 20161205 04:12:55 in /builds/slave/test 04:12:55 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 04:12:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:55 INFO - {'append_to_log': False, 04:12:55 INFO - 'base_work_dir': '/builds/slave/test', 04:12:55 INFO - 'blob_upload_branch': 'Graphics', 04:12:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:55 INFO - 'branch': 'Graphics', 04:12:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:55 INFO - 'config_files': ('talos/linux_config.py',), 04:12:55 INFO - 'default_actions': ('clobber', 04:12:55 INFO - 'read-buildbot-config', 04:12:55 INFO - 'download-and-extract', 04:12:55 INFO - 'populate-webroot', 04:12:55 INFO - 'create-virtualenv', 04:12:55 INFO - 'install', 04:12:55 INFO - 'run-tests'), 04:12:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:55 INFO - 'download_minidump_stackwalk': True, 04:12:55 INFO - 'download_symbols': 'ondemand', 04:12:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:55 INFO - 'installer_path': 'installer.exe', 04:12:55 INFO - 'log_level': 'info', 04:12:55 INFO - 'log_name': 'talos', 04:12:55 INFO - 'log_to_console': True, 04:12:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:55 INFO - 'opt_config_files': (), 04:12:55 INFO - 'pip_index': False, 04:12:55 INFO - 'sps_profile': False, 04:12:55 INFO - 'sps_profile_interval': 0, 04:12:55 INFO - 'suite': 'dromaeojs', 04:12:55 INFO - 'system_bits': '32', 04:12:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:55 INFO - 'title': 'talos-linux64-ix-059', 04:12:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:55 INFO - 'use_talos_json': True, 04:12:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:55 INFO - 'work_dir': 'build'} 04:12:55 INFO - [mozharness: 2016-12-05 12:12:55.855253Z] Running clobber step. 04:12:55 INFO - Running pre-action listener: _resource_record_pre_action 04:12:55 INFO - Running main action method: clobber 04:12:55 INFO - rmtree: /builds/slave/test/build 04:12:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:56 INFO - Running post-action listener: _resource_record_post_action 04:12:56 INFO - [mozharness: 2016-12-05 12:12:56.318865Z] Finished clobber step (success) 04:12:56 INFO - [mozharness: 2016-12-05 12:12:56.318964Z] Running read-buildbot-config step. 04:12:56 INFO - Running pre-action listener: _resource_record_pre_action 04:12:56 INFO - Running main action method: read_buildbot_config 04:12:56 INFO - Using buildbot properties: 04:12:56 INFO - { 04:12:56 INFO - "project": "", 04:12:56 INFO - "product": "firefox", 04:12:56 INFO - "script_repo_revision": "default", 04:12:56 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 04:12:56 INFO - "repository": "", 04:12:56 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 04:12:56 INFO - "buildid": "20161205032438", 04:12:56 INFO - "pgo_build": "False", 04:12:56 INFO - "basedir": "/builds/slave/test", 04:12:56 INFO - "buildnumber": 20, 04:12:56 INFO - "slavename": "talos-linux64-ix-059", 04:12:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:12:56 INFO - "platform": "ubuntu64_hw", 04:12:56 INFO - "scheduler": "tests-graphics-linux64-talos", 04:12:56 INFO - "branch": "graphics", 04:12:56 INFO - "repo_path": "projects/graphics", 04:12:56 INFO - "revision": "954a21ff3d449fddeb02cd5c9758ef89dc34d4ac", 04:12:56 INFO - "stage_platform": "linux64", 04:12:56 INFO - "builduid": "2602dd485acc4387b777bd4f4aa3f427", 04:12:56 INFO - "slavebuilddir": "test" 04:12:56 INFO - } 04:12:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:12:56 INFO - Running post-action listener: _resource_record_post_action 04:12:56 INFO - [mozharness: 2016-12-05 12:12:56.321508Z] Finished read-buildbot-config step (success) 04:12:56 INFO - [mozharness: 2016-12-05 12:12:56.321595Z] Running download-and-extract step. 04:12:56 INFO - Running pre-action listener: _resource_record_pre_action 04:12:56 INFO - Running main action method: download_and_extract 04:12:56 INFO - mkdir: /builds/slave/test/build/tests 04:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:56 INFO - trying https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:12:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/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 04:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/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 04:12:57 INFO - Downloaded 1361 bytes. 04:12:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:12:57 INFO - Using the following test package requirements: 04:12:57 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:12:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:12:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'jsshell-linux-x86_64.zip'], 04:12:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:12:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:12:57 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:12:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:12:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:12:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:12:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:12:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:12:57 INFO - Http code: 200 04:12:57 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 04:12:57 INFO - x-amz-cf-id: Q7KTpA2O4lAy6jJ26xwYJIj1ylUYVfigsdkaeB4FbahDdw9vMbqvFQ== 04:12:57 INFO - x-amz-version-id: Bd0y4Zsknqhqf1oH3e48Id4TyMKPadVO 04:12:58 INFO - Expected file size: 20217576 04:12:58 INFO - Obtained file size: 20217576 04:13:02 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 04:13:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:13:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:13:03 INFO - Http code: 200 04:13:03 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 04:13:03 INFO - x-amz-cf-id: hBSgdV1WPMG6iQa9lPFjKJOL9M0vk5uKn2Okq54ymz053by5ByTcsg== 04:13:03 INFO - x-amz-version-id: Bd0y4Zsknqhqf1oH3e48Id4TyMKPadVO 04:13:03 INFO - Expected file size: 20217576 04:13:03 INFO - Obtained file size: 20217576 04:13:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:13:08 INFO - Http code: 200 04:13:08 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 04:13:08 INFO - x-amz-cf-id: 0N1QRW80aWJ75HeVRhrFSFwulROc0CjOneGIAc3Yzqj-fJxXr4gK8Q== 04:13:08 INFO - x-amz-version-id: YdEcJUeE2dyhJ_WpfFBSFOADVzQsNcPR 04:13:09 INFO - Expected file size: 14409702 04:13:09 INFO - Obtained file size: 14409702 04:13: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')]} 04:13:09 INFO - trying https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/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 04:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/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 04:13:11 INFO - Downloaded 55684990 bytes. 04:13:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:11 INFO - mkdir: /builds/slave/test/properties 04:13:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:11 INFO - Contents: 04:13:11 INFO - build_url:https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:13:12 INFO - Running post-action listener: _resource_record_post_action 04:13:12 INFO - Running post-action listener: set_extra_try_arguments 04:13:12 INFO - [mozharness: 2016-12-05 12:13:12.446423Z] Finished download-and-extract step (success) 04:13:12 INFO - [mozharness: 2016-12-05 12:13:12.446647Z] Running populate-webroot step. 04:13:12 INFO - Running pre-action listener: _resource_record_pre_action 04:13:12 INFO - Running main action method: populate_webroot 04:13:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:12 INFO - '--tppagecycles', 04:13:12 INFO - '7'], 04:13:12 INFO - 'tests': ['tsvgm']}}, 04:13:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['damp', 'tps']}, 04:13:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'tests': ['damp', 'tps']}, 04:13:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['dromaeo_dom']}, 04:13:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['basic_compositor_video']}, 04:13:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['a11yr', 04:13:12 INFO - 'ts_paint', 04:13:12 INFO - 'tpaint', 04:13:12 INFO - 'sessionrestore', 04:13:12 INFO - 'sessionrestore_no_auto_restore', 04:13:12 INFO - 'tabpaint']}, 04:13:12 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:12 INFO - 'ts_paint', 04:13:12 INFO - 'tpaint', 04:13:12 INFO - 'sessionrestore', 04:13:12 INFO - 'sessionrestore_no_auto_restore', 04:13:12 INFO - 'tabpaint']}, 04:13:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:12 INFO - 'ts_paint', 04:13:12 INFO - 'tpaint', 04:13:12 INFO - 'sessionrestore', 04:13:12 INFO - 'sessionrestore_no_auto_restore', 04:13:12 INFO - 'tabpaint']}, 04:13:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:12 INFO - 'ts_paint', 04:13:12 INFO - 'tpaint', 04:13:12 INFO - 'sessionrestore', 04:13:12 INFO - 'sessionrestore_no_auto_restore', 04:13:12 INFO - 'tabpaint']}, 04:13:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['a11yr', 04:13:12 INFO - 'ts_paint', 04:13:12 INFO - 'tpaint', 04:13:12 INFO - 'sessionrestore', 04:13:12 INFO - 'sessionrestore_no_auto_restore', 04:13:12 INFO - 'tabpaint']}, 04:13:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['a11yr', 04:13:12 INFO - 'ts_paint', 04:13:12 INFO - 'tpaint', 04:13:12 INFO - 'sessionrestore', 04:13:12 INFO - 'sessionrestore_no_auto_restore', 04:13:12 INFO - 'tabpaint']}, 04:13:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['tsvgx', 04:13:12 INFO - 'tsvgr_opacity', 04:13:12 INFO - 'tart', 04:13:12 INFO - 'tscrollx', 04:13:12 INFO - 'cart', 04:13:12 INFO - 'tsvg_static']}, 04:13:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:12 INFO - 'tsvgr_opacity', 04:13:12 INFO - 'tart', 04:13:12 INFO - 'tscrollx', 04:13:12 INFO - 'cart', 04:13:12 INFO - 'tsvg_static']}, 04:13:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'talos_options': ['--disable-e10s'], 04:13:12 INFO - 'tests': ['tp5o']}, 04:13:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:13:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'talos_options': ['--disable-e10s', 04:13:12 INFO - '--xperf_path', 04:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:12 INFO - 'tests': ['tp5n']}, 04:13:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:13:12 INFO - 'talos_options': ['--xperf_path', 04:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:12 INFO - 'tests': ['tp5n']}}, 04:13:12 INFO - 'talos.zip': {'path': '', 04:13:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:12 INFO - Running post-action listener: _resource_record_post_action 04:13:12 INFO - [mozharness: 2016-12-05 12:13:12.462687Z] Finished populate-webroot step (success) 04:13:12 INFO - [mozharness: 2016-12-05 12:13:12.462775Z] Running create-virtualenv step. 04:13:12 INFO - Running pre-action listener: _resource_record_pre_action 04:13:12 INFO - Running main action method: create_virtualenv 04:13:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:13:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:12 INFO - Using real prefix '/usr' 04:13:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:15 INFO - Installing pip.................done. 04:13:15 INFO - Return code: 0 04:13:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:13:15 INFO - Reading from file tmpfile_stdout 04:13:15 INFO - Output received: 04:13:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:13:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:15 INFO - Using env: {'DISPLAY': ':0', 04:13:15 INFO - 'HOME': '/home/cltbld', 04:13:15 INFO - 'LANG': 'en_US.UTF-8', 04:13:15 INFO - 'LANGUAGE': 'en_US:en', 04:13:15 INFO - 'LOGNAME': 'cltbld', 04:13:15 INFO - 'MAIL': '/var/mail/cltbld', 04:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:15 INFO - 'MOZ_NO_REMOTE': '1', 04:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:15 INFO - 'NO_EM_RESTART': '1', 04:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:15 INFO - 'PWD': '/builds/slave/test', 04:13:15 INFO - 'SHELL': '/bin/bash', 04:13:15 INFO - 'SHLVL': '1', 04:13:15 INFO - 'TERM': 'linux', 04:13:15 INFO - 'TMOUT': '86400', 04:13:15 INFO - 'USER': 'cltbld', 04:13:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:15 INFO - '_': '/tools/buildbot/bin/python'} 04:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:13:15 INFO - Cleaning up... 04:13:15 INFO - Return code: 0 04:13:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:13:15 INFO - Using env: {'DISPLAY': ':0', 04:13:15 INFO - 'HOME': '/home/cltbld', 04:13:15 INFO - 'LANG': 'en_US.UTF-8', 04:13:15 INFO - 'LANGUAGE': 'en_US:en', 04:13:15 INFO - 'LOGNAME': 'cltbld', 04:13:15 INFO - 'MAIL': '/var/mail/cltbld', 04:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:15 INFO - 'MOZ_NO_REMOTE': '1', 04:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:15 INFO - 'NO_EM_RESTART': '1', 04:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:15 INFO - 'PWD': '/builds/slave/test', 04:13:15 INFO - 'SHELL': '/bin/bash', 04:13:15 INFO - 'SHLVL': '1', 04:13:15 INFO - 'TERM': 'linux', 04:13:15 INFO - 'TMOUT': '86400', 04:13:15 INFO - 'USER': 'cltbld', 04:13:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:15 INFO - '_': '/tools/buildbot/bin/python'} 04:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:15 INFO - Downloading/unpacking psutil>=3.1.1 04:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:17 INFO - Installing collected packages: psutil 04:13:17 INFO - Running setup.py install for psutil 04:13:17 INFO - building 'psutil._psutil_linux' extension 04:13:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:13:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:13:18 INFO - building 'psutil._psutil_posix' extension 04:13:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:13:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:13:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:18 INFO - Successfully installed psutil 04:13:18 INFO - Cleaning up... 04:13:18 INFO - Return code: 0 04:13:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:13:18 INFO - Using env: {'DISPLAY': ':0', 04:13:18 INFO - 'HOME': '/home/cltbld', 04:13:18 INFO - 'LANG': 'en_US.UTF-8', 04:13:18 INFO - 'LANGUAGE': 'en_US:en', 04:13:18 INFO - 'LOGNAME': 'cltbld', 04:13:18 INFO - 'MAIL': '/var/mail/cltbld', 04:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:18 INFO - 'MOZ_NO_REMOTE': '1', 04:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:18 INFO - 'NO_EM_RESTART': '1', 04:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:18 INFO - 'PWD': '/builds/slave/test', 04:13:18 INFO - 'SHELL': '/bin/bash', 04:13:18 INFO - 'SHLVL': '1', 04:13:18 INFO - 'TERM': 'linux', 04:13:18 INFO - 'TMOUT': '86400', 04:13:18 INFO - 'USER': 'cltbld', 04:13:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:18 INFO - '_': '/tools/buildbot/bin/python'} 04:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:20 INFO - Installing collected packages: mozsystemmonitor 04:13:20 INFO - Running setup.py install for mozsystemmonitor 04:13:20 INFO - Successfully installed mozsystemmonitor 04:13:20 INFO - Cleaning up... 04:13:20 INFO - Return code: 0 04:13:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:13:20 INFO - Using env: {'DISPLAY': ':0', 04:13:20 INFO - 'HOME': '/home/cltbld', 04:13:20 INFO - 'LANG': 'en_US.UTF-8', 04:13:20 INFO - 'LANGUAGE': 'en_US:en', 04:13:20 INFO - 'LOGNAME': 'cltbld', 04:13:20 INFO - 'MAIL': '/var/mail/cltbld', 04:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:20 INFO - 'MOZ_NO_REMOTE': '1', 04:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:20 INFO - 'NO_EM_RESTART': '1', 04:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:20 INFO - 'PWD': '/builds/slave/test', 04:13:20 INFO - 'SHELL': '/bin/bash', 04:13:20 INFO - 'SHLVL': '1', 04:13:20 INFO - 'TERM': 'linux', 04:13:20 INFO - 'TMOUT': '86400', 04:13:20 INFO - 'USER': 'cltbld', 04:13:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:20 INFO - '_': '/tools/buildbot/bin/python'} 04:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:23 INFO - warning: no files found matching '*.txt' 04:13:23 INFO - no previously-included directories found matching 'build' 04:13:23 INFO - no previously-included directories found matching 'dist' 04:13:23 INFO - no previously-included directories found matching '.git*' 04:13:23 INFO - Installing collected packages: jsonschema, functools32 04:13:23 INFO - Running setup.py install for functools32 04:13:23 INFO - warning: no files found matching '*.txt' 04:13:23 INFO - no previously-included directories found matching 'build' 04:13:23 INFO - no previously-included directories found matching 'dist' 04:13:23 INFO - no previously-included directories found matching '.git*' 04:13:23 INFO - Successfully installed jsonschema functools32 04:13:23 INFO - Cleaning up... 04:13:23 INFO - Return code: 0 04:13:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:13:23 INFO - Using env: {'DISPLAY': ':0', 04:13:23 INFO - 'HOME': '/home/cltbld', 04:13:23 INFO - 'LANG': 'en_US.UTF-8', 04:13:23 INFO - 'LANGUAGE': 'en_US:en', 04:13:23 INFO - 'LOGNAME': 'cltbld', 04:13:23 INFO - 'MAIL': '/var/mail/cltbld', 04:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:23 INFO - 'MOZ_NO_REMOTE': '1', 04:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:23 INFO - 'NO_EM_RESTART': '1', 04:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:23 INFO - 'PWD': '/builds/slave/test', 04:13:23 INFO - 'SHELL': '/bin/bash', 04:13:23 INFO - 'SHLVL': '1', 04:13:23 INFO - 'TERM': 'linux', 04:13:23 INFO - 'TMOUT': '86400', 04:13:23 INFO - 'USER': 'cltbld', 04:13:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:23 INFO - '_': '/tools/buildbot/bin/python'} 04:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:13:23 INFO - Cleaning up... 04:13:23 INFO - Return code: 0 04:13:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:13:23 INFO - Using env: {'DISPLAY': ':0', 04:13:23 INFO - 'HOME': '/home/cltbld', 04:13:23 INFO - 'LANG': 'en_US.UTF-8', 04:13:23 INFO - 'LANGUAGE': 'en_US:en', 04:13:23 INFO - 'LOGNAME': 'cltbld', 04:13:23 INFO - 'MAIL': '/var/mail/cltbld', 04:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:23 INFO - 'MOZ_NO_REMOTE': '1', 04:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:23 INFO - 'NO_EM_RESTART': '1', 04:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:23 INFO - 'PWD': '/builds/slave/test', 04:13:23 INFO - 'SHELL': '/bin/bash', 04:13:23 INFO - 'SHLVL': '1', 04:13:23 INFO - 'TERM': 'linux', 04:13:23 INFO - 'TMOUT': '86400', 04:13:23 INFO - 'USER': 'cltbld', 04:13:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:23 INFO - '_': '/tools/buildbot/bin/python'} 04:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:23 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:25 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 04:13:25 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 04:13:25 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 04:13:25 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 04:13:25 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 04:13:25 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 04:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:26 INFO - Downloading docopt-0.6.1.tar.gz 04:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:26 INFO - Running setup.py install for blobuploader 04:13:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:26 INFO - Running setup.py install for requests 04:13:27 INFO - Running setup.py install for docopt 04:13:27 INFO - Successfully installed blobuploader requests docopt 04:13:27 INFO - Cleaning up... 04:13:27 INFO - Return code: 0 04:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:27 INFO - Running setup.py (path:/tmp/pip-tGqYVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:27 INFO - Running setup.py (path:/tmp/pip-jolB3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:27 INFO - Running setup.py (path:/tmp/pip-IF5jc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:27 INFO - Running setup.py (path:/tmp/pip-ArwdKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:27 INFO - Running setup.py (path:/tmp/pip-KdtBSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:27 INFO - Running setup.py (path:/tmp/pip-uZbMtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:27 INFO - Running setup.py (path:/tmp/pip-9Ujtc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:27 INFO - Running setup.py (path:/tmp/pip-Ok5L6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:28 INFO - Running setup.py (path:/tmp/pip-e8qYKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:28 INFO - Running setup.py (path:/tmp/pip-wa459K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:28 INFO - Running setup.py (path:/tmp/pip-gHY0c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:28 INFO - Running setup.py (path:/tmp/pip-eBMkFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:28 INFO - Running setup.py (path:/tmp/pip-iV2PUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:28 INFO - Running setup.py (path:/tmp/pip-S_RaUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:28 INFO - Running setup.py (path:/tmp/pip-QsZzag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:28 INFO - Running setup.py (path:/tmp/pip-OBWFAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:28 INFO - Running setup.py (path:/tmp/pip-3QD6E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:28 INFO - Running setup.py install for manifestparser 04:13:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:28 INFO - Running setup.py install for mozcrash 04:13:28 INFO - Running setup.py install for mozdebug 04:13:28 INFO - Running setup.py install for mozdevice 04:13:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Running setup.py install for mozfile 04:13:29 INFO - Running setup.py install for mozhttpd 04:13:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Running setup.py install for mozinfo 04:13:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Running setup.py install for mozInstall 04:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Running setup.py install for mozleak 04:13:29 INFO - Running setup.py install for mozlog 04:13:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Running setup.py install for moznetwork 04:13:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:29 INFO - Running setup.py install for mozprocess 04:13:29 INFO - Running setup.py install for mozprofile 04:13:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:30 INFO - Running setup.py install for mozrunner 04:13:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:30 INFO - Running setup.py install for mozscreenshot 04:13:30 INFO - Running setup.py install for moztest 04:13:30 INFO - Running setup.py install for mozversion 04:13:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:30 INFO - Cleaning up... 04:13:30 INFO - Return code: 0 04:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:30 INFO - Using env: {'DISPLAY': ':0', 04:13:30 INFO - 'HOME': '/home/cltbld', 04:13:30 INFO - 'LANG': 'en_US.UTF-8', 04:13:30 INFO - 'LANGUAGE': 'en_US:en', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MAIL': '/var/mail/cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SHLVL': '1', 04:13:30 INFO - 'TERM': 'linux', 04:13:30 INFO - 'TMOUT': '86400', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - '_': '/tools/buildbot/bin/python'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:30 INFO - Running setup.py (path:/tmp/pip-F8lH6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:30 INFO - Running setup.py (path:/tmp/pip-IwuG1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:30 INFO - Running setup.py (path:/tmp/pip-hkHe7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:30 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)) 04:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:30 INFO - Running setup.py (path:/tmp/pip-F0bSpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:31 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)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:31 INFO - Running setup.py (path:/tmp/pip-Wuvy4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:31 INFO - Running setup.py (path:/tmp/pip-12JgVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:31 INFO - Running setup.py (path:/tmp/pip-1lhytm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:31 INFO - Running setup.py (path:/tmp/pip-XnNy9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:31 INFO - Running setup.py (path:/tmp/pip-k_2oRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:31 INFO - Running setup.py (path:/tmp/pip-yXskAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:31 INFO - Running setup.py (path:/tmp/pip-tNDueL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:31 INFO - Running setup.py (path:/tmp/pip-uFQEPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:31 INFO - Running setup.py (path:/tmp/pip-mqh9Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:31 INFO - Running setup.py (path:/tmp/pip-TxTM92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:31 INFO - Running setup.py (path:/tmp/pip-ZKBFjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:31 INFO - Running setup.py (path:/tmp/pip-97Ldsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:31 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)) 04:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:31 INFO - Running setup.py (path:/tmp/pip-V9nfue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:31 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)) 04:13:31 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)) 04:13:31 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)) 04:13:31 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)) 04:13:31 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)) 04:13:31 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)) 04:13:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:33 INFO - Downloading blessings-1.6.tar.gz 04:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:34 INFO - Installing collected packages: blessings 04:13:34 INFO - Running setup.py install for blessings 04:13:34 INFO - Successfully installed blessings 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:34 INFO - Reading from file tmpfile_stdout 04:13:34 INFO - Current package versions: 04:13:34 INFO - argparse == 1.2.1 04:13:34 INFO - blessings == 1.6 04:13:34 INFO - blobuploader == 1.2.4 04:13:34 INFO - docopt == 0.6.1 04:13:34 INFO - functools32 == 3.2.3-2 04:13:34 INFO - jsonschema == 2.5.1 04:13:34 INFO - manifestparser == 1.1 04:13:34 INFO - mozInstall == 1.12 04:13:34 INFO - mozcrash == 1.0 04:13:34 INFO - mozdebug == 0.1 04:13:34 INFO - mozdevice == 0.49 04:13:34 INFO - mozfile == 1.2 04:13:34 INFO - mozhttpd == 0.7 04:13:34 INFO - mozinfo == 0.9 04:13:34 INFO - mozleak == 0.1 04:13:34 INFO - mozlog == 3.4 04:13:34 INFO - moznetwork == 0.27 04:13:34 INFO - mozprocess == 0.23 04:13:34 INFO - mozprofile == 0.28 04:13:34 INFO - mozrunner == 6.13 04:13:34 INFO - mozscreenshot == 0.1 04:13:34 INFO - mozsystemmonitor == 0.3 04:13:34 INFO - moztest == 0.7 04:13:34 INFO - mozversion == 1.4 04:13:34 INFO - psutil == 3.1.1 04:13:34 INFO - requests == 1.2.3 04:13:34 INFO - wsgiref == 0.1.2 04:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:34 INFO - Using env: {'DISPLAY': ':0', 04:13:34 INFO - 'HOME': '/home/cltbld', 04:13:34 INFO - 'LANG': 'en_US.UTF-8', 04:13:34 INFO - 'LANGUAGE': 'en_US:en', 04:13:34 INFO - 'LOGNAME': 'cltbld', 04:13:34 INFO - 'MAIL': '/var/mail/cltbld', 04:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:34 INFO - 'MOZ_NO_REMOTE': '1', 04:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:34 INFO - 'NO_EM_RESTART': '1', 04:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:34 INFO - 'PWD': '/builds/slave/test', 04:13:34 INFO - 'SHELL': '/bin/bash', 04:13:34 INFO - 'SHLVL': '1', 04:13:34 INFO - 'TERM': 'linux', 04:13:34 INFO - 'TMOUT': '86400', 04:13:34 INFO - 'USER': 'cltbld', 04:13:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 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 0x7f7e93fd6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, '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': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', '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 04:13:34 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 04:13:34 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 04:13:34 INFO - Using env: {'DISPLAY': ':0', 04:13:34 INFO - 'HOME': '/home/cltbld', 04:13:34 INFO - 'LANG': 'en_US.UTF-8', 04:13:34 INFO - 'LANGUAGE': 'en_US:en', 04:13:34 INFO - 'LOGNAME': 'cltbld', 04:13:34 INFO - 'MAIL': '/var/mail/cltbld', 04:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:34 INFO - 'MOZ_NO_REMOTE': '1', 04:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:34 INFO - 'NO_EM_RESTART': '1', 04:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:34 INFO - 'PWD': '/builds/slave/test', 04:13:34 INFO - 'SHELL': '/bin/bash', 04:13:34 INFO - 'SHLVL': '1', 04:13:34 INFO - 'TERM': 'linux', 04:13:34 INFO - 'TMOUT': '86400', 04:13:34 INFO - 'USER': 'cltbld', 04:13:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - Running post-action listener: _start_resource_monitoring 04:13:34 INFO - Starting resource monitoring. 04:13:34 INFO - [mozharness: 2016-12-05 12:13:34.911180Z] Finished create-virtualenv step (success) 04:13:34 INFO - [mozharness: 2016-12-05 12:13:34.911696Z] Running install step. 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: install 04:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:35 INFO - Reading from file tmpfile_stdout 04:13:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:35 INFO - Reading from file tmpfile_stdout 04:13:35 INFO - Output received: 04:13:35 INFO - Usage: mozinstall [options] installer 04:13:35 INFO - Options: 04:13:35 INFO - -h, --help show this help message and exit 04:13:35 INFO - -d DEST, --destination=DEST 04:13:35 INFO - Directory to install application into. [default: 04:13:35 INFO - "/builds/slave/test"] 04:13:35 INFO - --app=APP Application being installed. [default: firefox] 04:13:35 INFO - mkdir: /builds/slave/test/build/application 04:13:35 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'] 04:13:35 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 04:13:51 INFO - Reading from file tmpfile_stdout 04:13:51 INFO - Output received: 04:13:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:51 INFO - Running post-action listener: _resource_record_post_action 04:13:51 INFO - [mozharness: 2016-12-05 12:13:51.260423Z] Finished install step (success) 04:13:51 INFO - [mozharness: 2016-12-05 12:13:51.260663Z] Running run-tests step. 04:13:51 INFO - Running pre-action listener: _resource_record_pre_action 04:13:51 INFO - Running main action method: run_tests 04:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:51 INFO - Python 2.7.3 04:13:51 INFO - Return code: 0 04:13:51 INFO - grabbing minidump binary from tooltool 04:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1fc0>, '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 0x13c2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c3350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:13:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:51 INFO - Return code: 0 04:13:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:51 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/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 04:13:51 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/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 04:13:51 INFO - Using env: {'DISPLAY': ':0', 04:13:51 INFO - 'HOME': '/home/cltbld', 04:13:51 INFO - 'LANG': 'en_US.UTF-8', 04:13:51 INFO - 'LANGUAGE': 'en_US:en', 04:13:51 INFO - 'LOGNAME': 'cltbld', 04:13:51 INFO - 'MAIL': '/var/mail/cltbld', 04:13:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:51 INFO - 'MOZ_NO_REMOTE': '1', 04:13:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:51 INFO - 'NO_EM_RESTART': '1', 04:13:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:51 INFO - 'PWD': '/builds/slave/test', 04:13:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:51 INFO - 'SHELL': '/bin/bash', 04:13:51 INFO - 'SHLVL': '1', 04:13:51 INFO - 'TERM': 'linux', 04:13:51 INFO - 'TMOUT': '86400', 04:13:51 INFO - 'USER': 'cltbld', 04:13:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000', 04:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:51 INFO - '_': '/tools/buildbot/bin/python'} 04:13:51 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/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 04:13:51 INFO - mozversion application_buildid: 20161205032438 04:13:51 INFO - mozversion application_changeset: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac 04:13:51 INFO - mozversion application_display_name: Nightly 04:13:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:51 INFO - mozversion application_name: Firefox 04:13:51 INFO - mozversion application_remotingname: firefox 04:13:51 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 04:13:51 INFO - mozversion application_vendor: Mozilla 04:13:51 INFO - mozversion application_version: 53.0a1 04:13:51 INFO - mozversion platform_buildid: 20161205032438 04:13:51 INFO - mozversion platform_changeset: 954a21ff3d449fddeb02cd5c9758ef89dc34d4ac 04:13:51 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 04:13:51 INFO - mozversion platform_version: 53.0a1 04:13:51 INFO - using testdate: 1480940031 04:13:51 INFO - actual date: 1480940031 04:13:51 INFO - starting webserver on 'localhost:46162' 04:13:51 INFO - SUITE-START | Running 2 tests 04:13:51 INFO - TEST-START | dromaeo_css 04:13:51 INFO - operating with platform_type : linux_ 04:13:51 INFO - Initialising browser for dromaeo_css test... 04:13:51 INFO - TEST-INFO | started process 17216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0v3Y0/profile http://localhost:46162/getInfo.html) 04:13:55 INFO - PROCESS | 17216 | __metrics Screen width/height:1600/1200 04:13:55 INFO - PROCESS | 17216 | colorDepth:24 04:13:55 INFO - PROCESS | 17216 | Browser inner width/height: 1024/697 04:13:55 INFO - PROCESS | 17216 | __metrics 04:13:56 INFO - PROCESS | 17216 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:13:56 INFO - PROCESS | 17216 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:13:57 INFO - PROCESS | 17216 | console.error: PushService: 04:13:57 INFO - PROCESS | 17216 | stateChangeProcessEnqueue: Error transitioning state 04:13:57 INFO - PROCESS | 17216 | UnknownError 04:13:57 INFO - TEST-INFO | 17216: exit 0 04:13:57 INFO - Browser initialized. 04:13:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:57 INFO - TEST-INFO | started process 17300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0v3Y0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:09 INFO - PROCESS | 17300 | RSS: Main: 175050752 04:14:09 INFO - PROCESS | 17300 | 04:15:01 INFO - PROCESS | 17300 | 1480940101206 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] 04:17:14 INFO - PROCESS | 17300 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46162/tests/dromaeo/cssquery-ext.html) 04:17:16 INFO - PROCESS | 17300 | RSS: Main: 383647744 04:17:16 INFO - PROCESS | 17300 | 04:20:19 INFO - PROCESS | 17300 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-ext.html (next: http://localhost:46162/tests/dromaeo/cssquery-jquery.html) 04:20:20 INFO - PROCESS | 17300 | RSS: Main: 290918400 04:20:20 INFO - PROCESS | 17300 | 04:23:22 INFO - PROCESS | 17300 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46162/tests/dromaeo/cssquery-mootools.html) 04:23:23 INFO - PROCESS | 17300 | RSS: Main: 223731712 04:23:23 INFO - PROCESS | 17300 | 04:26:25 INFO - PROCESS | 17300 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46162/tests/dromaeo/cssquery-prototype.html) 04:26:26 INFO - PROCESS | 17300 | RSS: Main: 224456704 04:26:26 INFO - PROCESS | 17300 | 04:29:29 INFO - PROCESS | 17300 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46162/tests/dromaeo/cssquery-yui.html) 04:29:29 INFO - PROCESS | 17300 | RSS: Main: 224301056 04:29:29 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-yui.html (next: http://localhost:46162/tests/dromaeo/cssquery-dojo.html) 04:32:33 INFO - PROCESS | 17300 | RSS: Main: 313044992 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | __start_tp_report 04:32:33 INFO - PROCESS | 17300 | _x_x_mozilla_page_load 04:32:33 INFO - PROCESS | 17300 | _x_x_mozilla_page_load_details 04:32:33 INFO - PROCESS | 17300 | |i|pagename|runs| 04:32:33 INFO - PROCESS | 17300 | |0;dojo.html;2548.9999999999995;2566.961495577568;2579.1102069785925;2601.479704059189;2610.973890261098;4479.081788233412;4530.954690453094;4565.863024109278;4574.313852922063;4588.472325682547;4572.725636461814;4574.016586433916;4574.2223821950265;4581.221192397292;4584.954150458494;4182.100848317611;4202.432671589342;4214.199302132585;4228.936565951513;4266.807993640294;4202.957970420287;4235.809388577506;4238.321868501041;4241.766702831343;4250.553691862341;4222.451081359419;4235.258829704805;4244.87265382039;4251.256030194719;4258.97870510647;4281.935770963438;4291.50647675515;4299.591538803808;4306.074194048263;4313.223619748444;4162.62536371728;4180.895477613084;4199.349100889367;4233.30150525166;4261.3607958806115;4588.839390621346;4616.976915115437;4618.584327410549;4631.560001799858;4638.350630911675;4937.5556199942175;4940.604751619898;4961.603071754287;4965.677230980011;5013.623978201613;4838.056578967103;4882.731449770261;4992.326035985132;4993.1262029144755;5034.219695947134;4598.310253461974;4612.723236605814;4614.446266448048;4645.0477652081245;4696.835610753676;5055;5066.214736715815;5066.670666406671;5071.974640126849;5107.310513080686;4879.194932836042;4886.218205087169;4889.119958407521;4890.559849613552;4925.039617274597;4811.3745213122775;4825.469198388175;4829;4843.660943733976;4874.098291816025;4903.632227582874;4914.852554423373;4917.483664215278;4918.606511479073;4924.359833221658;4825.010872771073;4833.9033219335415;4837.612990960714;4842.782074806642;4882.975585122052;4114.773687447219;4138.772367519815;4146.398772178018;4150.418941348214;4185.121124563815;3611.4582812578324;3611.7471776975885;3635.327464419091;3654.3787556115526;3654.780713157219;4266.978665106654;4272.87181384559;4288.2281189385585;4308.6983911126545;4313.784310784448;4922.801521593155;4922.975385123052;4929.876753081202;4934.062528119646;4978.10394129053;4149.585041495887;4189.0574620710095;4248.171606536757;4249.723767955073;4277.850275240352;4450.35469856869;4501.212287849613;4506.414166158444;4523.208438523246;4525.841595544141;4685.344051832814;4702.341672165968;4707.458642256184;4709.646776491845;4742.762861856962;4884.365032545888;4966.553010229097;5025.497450255091;5032.572231360229;5070.949290507047;4601.447826260736;4608.907821843477;4623.398958135421;4640.280756482751;4641.675082744176;4835.564799168092;4848.200046992207;4855.830045948375;4867.075255701406;4873.853784386474;4863;4895.094407534618;4901.5588597026435;4902.7058376497525;4904.2643603459765;4775.594074503706;4782.019685964438;4784.7607619619575;4791.185498465339;4791.281307803857;4741.383620129361;4765.428148622187;4788.521147885183;4789.880252993703;4795.496472870298;4717;4750.643701722453;4756.619470442425;4774.546418090275;4777.0207107543565;4904.092742842586;4915.557599816034;4917.139500587455;4920.360353154067;4952;4576.58125980947;4726.669133160645;4820.276958456259;4822;4861.829835955866 04:32:33 INFO - PROCESS | 17300 | |1;ext.html;556.0574825670487;568.4060157135794;587.3715124816446;590.0942053947189;593.7951406764664;26712.86643566782;29418.558721619193;36195.81902090493;37436.62563374366;37572;38378;38810.80594597023;38844;38909.41635875464;38950.61049389505;7315.4879158458925;7462.365698915599;7466.216047315035;7466.664000120008;7467.813304667399;7190.101237345332;7400.962995185017;9654.227661787076;9980.451075190862;9991.150752186037;9699.466529340883;9762.26782991275;9766.218702503782;9769.755756106084;9777.217822574177;9718.562664680107;9727.464989425614;9765.121139097444;9767.706968790948;9769.609215631366;9552.474613896233;9618.182454491376;9619.56711947957;9620.71137865865;9623.855642165303;36121.1236483074;36374.81812590946;36439.27121457556;36485.087872803124;36534.26931461356;2986.7759918006236;3155.495120780687;3249.496328069153;3370.477575975703;3390;24384.39039024021;24417.511649767082;24471.510569788505;25062;28956.565651515244;3426.4003799335264;3457.619661837196;3506.1585219547123;3544.149404142987;3556.982215088908;234999.8250008756;237009;237084;237342;237935;47678.76160619175;47902.520974789804;48035.27947080797;48041.5195848044;48062.759686202044;51578.48421515812;51820.74089629603;51835.74082129565;51933.740331298104;51948.74025629848;12837.101402901893;13075.346232688327;13087.41106650203;13090.14914030585;13091;8952.194302512806;9221;9809.460479673686;9838.803223935623;9850.359726617748;13246.139000964906;13339.932805375547;13373.799393009112;14362.425502979973;14847.2576371181;5395.62230643859;6175;6177.7837775677635;6182.196314479089;6221.8845592498765;797.4099166616662;845.0915266088979;886.4415418286438;938.8591711243369;1005.7183988483237;25622.359441014123;26426.339341516617;26667.466650666876;26687.733122668913;26932.32669183247;900.6274537122308;940.7742141886035;959.6593209410559;974.3569244298728;1014.1379827147014;14055.648608784863;14186.290685465685;14310.212938288287;14420.783688244685;14456.710865782836;350284;352919;353332;353668;383250;36883.07792305214;41266.58733412628;44219;45087;45136.77431612821;1140.241739243427;1152.1589239854952;1170.836082948405;1183.219075410225;1184.0882520459197;26091.60862587025;27321.72678273192;27479.725202748516;27517.174484765488;28069.859650701615;39846;39863.60136398715;40016.79991600024;40102.59897400989;40306;313577;314179;315383;315417;315549;32882.1779455506;34148.31703365968;34152.65847341495;34171.31657366888;34192.658073419945;38968.2206355877;39013.804930975166;39128.41307380335;39153.804230979804;39332.41001384924;32121;33377.83311083429;33462;33701.3259734799;34643;32861.17847053843;33050.66949330476;33319.66680333263;33467.66532334645;34372.14069648179;32791.67208327886;33667.13829324535;33702.662973370934;33936.66063339335;33984.83007585045;28530.429391412472;30642.693573063985;30942.22644433907;31038.53442198414;31195.84402077975;23360.415989600395;23789;23921.641175382036;24296.392590185387;24370.831791866945 04:32:33 INFO - PROCESS | 17300 | |2;jquery.html;337.5881424661912;354.97160227181826;363.2788914005698;363.75991845382043;378.1284140057169;12925;13300.201987880722;13543.593692189226;16369.59076023097;16373.754393684105;15412.922935385308;15531.53405397837;16165.595860103504;16170.919145404287;16180.676386472263;4709.670323077395;4902.166631672624;4904.4114706235305;4904.828331008415;4912.680675756064;3641.4355774854807;3824.29250588642;5527.806526771564;5780.2196703444915;5811.6803575803315;5870.236869206997;5873.2658417697785;5876.735546900379;5880.176775251468;5882.794102206423;5044.2937988681615;5297.8145764898045;5329.173978033411;5379.946200537984;5386;5107.923381149286;5192.299039629677;5200.479952004769;5201.245819356172;5201.427842937273;11426.71433214168;11671;11697.649070527897;11726.648200553997;11732.944035036888;1843.7142242952364;1853.3235369090319;1969.812867777559;2001.2195243854908;2049.241780541194;8632.482051076893;9035.333539437308;9046.77383065422;10555.313904596176;12513;1617.652204775967;1729.9913500432542;1770.2299499717665;1792.5429015601069;1890.404522575398;43949;60305.396946030414;64764.67617661929;64823.67588162076;69180.30819691789;9206.539673016456;9534.666286679932;9774.657886973922;9860.16188623975;10051.095401413762;13116.475340986444;13198.934005329911;13224;13231.139975901535;13254.668633284246;6557.475401967831;6557.475401967831;6610.0745895574655;6817.250102488722;6946.8610627788175;6227.688615569204;6340.873182536324;6434.485241180694;6479.643619600873;6500.382463665944;3942.9605703943166;4029.133736246721;4104.774237416911;4194.748315101043;4291.892702682396;1537.5617948884737;1552.6196081959993;1621.8215996240403;1624.951251462458;1652.983470165307;779.6530543907907;779.859625267446;875.9255463285692;940.830650482906;952.1763674421713;15859.207039647972;16587.253573589216;16650.250738716786;16672.833271667372;17046.23291951865;835.1898658301438;835.3275613131487;854.2354592639552;883.6156272021691;921.9400738952081;8887.066857979818;9014.729558113268;9315.34792564514;9316.720498385059;9480.288978326515;360136;362847;364056;376120;382498;77161.61419192867;78763;80084.59957700175;80102.59948700336;80530;928.7167413938679;936.3539157980971;941.2799208605422;957.8563215517728;960.8558716192488;14379.98680184796;14853.40586376576;15378.384864605738;15555.688886221986;15602.297896594453;27771.861140694167;32373;35229;35375.03114876651;36894.631053690195;49026.40090785934;49310.548261622775;49613.82144303171;49619.25571116364;51721.22418163655;7167.498275120692;7201.819954501179;7256.905636276638;7433.293837085468;7544.735934242275;8341.874871877048;11138.33170009802;11286.66140015801;11385;11626.069914406997;9689.515524223902;9748.268879834182;9875.604975800887;9881.802363952824;10144.391336519833;9792.51037448139;9852.556634951301;9935.403875767477;10088.899111008795;10229.897701022894;9967.50162491858;10147.391156530337;10480.842787358044;10488.947555262175;10687.145028397554;7012.964935175495;7247.311505406978;7277.59973201479;7485.363744081814;7504.761714317076;8733.301335892986;9822.459764713009;9948.054934781185;9986.450745208793;10312.329698569569 04:32:33 INFO - PROCESS | 17300 | |3;mootools.html;1312.2454588611547;1374.251033186913;1399.5241617849929;1620.4733461624976;1664.9677200135918;6162.106494558287;6392.20097487814;6592.967035164824;6981.860362792741;6982.650867456626;6580.605163690182;6855;6862.10792596963;7007.57954522729;7014.508984371096;2006.7993200679962;2046.5906818636258;2047.7747447780732;2064.4838790302424;2064.938051858439;1794.4078454110177;1851.592649617082;2053.4558342039372;2058.289889987959;2069.0689189864547;2006.438197304757;2101.77931317211;2102.4428526440506;2103.810657040866;2116.5343624402685;2053.835693144545;2059.4439501334705;2090.2997495838836;2097.37078876338;2097.4966008158085;2087.0608226298227;2105;2105.221068204774;2111.4088055344528;2116.121809449077;7010.228874823765;7044.788656340267;7097.112860892388;7103.431725461951;7104.573725576482;3928.7642741435607;4103.117829666636;4109.2808758467145;4121.052158003646;4135.152293779798;2602.817802753808;2779.6664400271893;2862.427514497088;2874.439484300562;2881.7118288171223;907.419251678926;919.2416256588341;927.7216834949488;939.5490164720904;946.8769060022222;9057.365984381096;9191.724248272563;9205.677801276923;9210.769730756718;9310.72067837966;3687.612800655946;3813.5423749149722;3896.4155376693157;3904.921901561953;3978.264021156095;8063.556504392197;8065.314448271963;8111.553864537507;8118.35053195743;8122.7157049502985;4225.471816022997;4231.4710661167355;4233.851815186454;4235.957640423618;4236;3802.5056742623283;3806.619338066171;3944.6055394460323;3946.033221860605;3946.1910308386714;3006.2033561106323;3041.7870749047356;3123.01624988128;3152.5586417901513;3156.71589556941;849.5582297205418;857.1942374168386;930.692871352452;940.0646356874953;948.2129832239362;722.288545782404;738.4978214813979;769.5152054205814;799.9480033797785;823.9423240373117;4840;4859.514048595183;4942.332785074041;5053.646244762831;5067.189249720027;825.7860944411705;849.1975083546113;859.9613017414231;860.0582362313257;869.222046268586;3221.6295126060336;3309.172706823294;3321.8671253150087;3386.356592247465;3404.642512536148;7871.803204919808;8392.664293428317;8405.453645513022;8407.285380742584;8412;8262.586870656443;8306.916930830736;8355.331573474108;8363.95818020906;8414.200650938274;6443.548951573345;6606.141201643755;6608.2730899601;6609.933900661124;6615;4742.857714268577;4752.643551733565;4767.189577771856;4907.582855457326;4950.356453661001;7690.961545192238;7743.92256077432;7792.18182090895;7802;7850.921490785019;7841.294283514511;7861.921380786119;7862.842743145219;7910.090339610788;8010.198980101944;5571.331440227199;5678.971605141948;5682.659040457585;5685.545156387397;5812.796552120824;6575;6636.701348439428;6710.966445167743;6711.966440167768;6719.160104986877;6048.183495228088;6104.664243466652;6141.9078713818435;6149.692515374124;6197.194364732556;5970.343262241063;6006;6016.578839481194;6029;6029.879402412015;5695.373508913934;5740.167675687086;5756.079027355603;5793.9420605795085;5798.652080875161;4106.958930410658;4196.8111434984885;4283.635890949305;4292.570742925807;4332.6317263033;4050.1899620076692;4187.162567486454;4269.7224680395675;4299.419578357007;4318.071614602875 04:32:33 INFO - PROCESS | 17300 | |4;prototype.html;271.7839317742395;285.8485002948437;285.8913612827125;297.6413421826699;304.24395377486945;4601.33280674302;4703.929441058387;4791.760411979404;4800.6399520036;4833.226683730604;4611.815527378909;4729.2501774343455;4745.644076694253;4749.216379297421;4756.381670382854;3532.841022153996;3647.58052823926;3752.212035472554;3758.327544242813;3758.830852611632;3615.9096022599383;3688.2807852468777;3689.1883785567134;3693.4644476550884;3706.518152640153;3667.559892812866;3668.743187976843;3669.9266014679692;3677.797721125337;3680.2702729717125;3681.392570225923;3687.4468829675493;3688.668019878197;3698.7780733156096;3713.795741234231;3177.1421716136747;3234.5795046643784;3238.3685181389637;3257.9022629321157;3272.4764037753844;4560.361549383089;4588.197065513522;4591.6582542903025;4594.632429405673;4614.43109342825;4168.874933751992;4203.516595591515;4212.115455754295;4220.85227017053;4237.533871274158;4734.976325118352;4941.975290123562;4973.825916092919;4978.680649627851;5002.74986250686;3516.9120771980647;3524.594671612772;3526.682598566141;3532.0640030391965;3551.982240088809;5170.715610641413;5172.379314482248;5180.818671346485;5192.273081768555;5202.557782588485;3609.1698909250495;3611.4402267648557;3620.1311685195365;3639.2357604902736;3646.781193128421;3428.451447768345;3643.4534819777246;3684.613115622875;3712.276106159327;3726.2920045191327;4164.583541645811;4185.22573323936;4185.790710464465;4192.622663960258;4196.391523229115;4737.962676049263;4826.348442960156;4885.462599114095;4976.805566664047;5025.748712564357;1208.4139192491634;1216.8296438498617;1219.384315781593;1223.7674841780033;1226.1294480918468;793.2147174297404;809.6923169195786;816.3428440105772;817.235884448043;821.117298903669;4287.785610719451;4292.390353617394;4316.848910288125;4317.330813723878;4327.398862420924;4973.303737476756;4990.850274491699;4993.550580447777;5005.899882002413;5006.220303670778;4287.421198138274;4307.095509942885;4314.223439780807;4317.11499142675;4324.589164029475;2570.1775431861624;2625.908093216728;2648.1923013480687;2658.5081759874483;2662.148112603948;4659.086367451358;4659.578828457353;4665.437078578646;4667.696599721007;4693.779617299527;5075.695458272516;5077.593792496591;5090.669106508065;5101.464346243591;5127.410347809975;4398.318260669601;4583.564561366665;4628.976855115703;4652.32541281519;4682.41469816273;4920.21276595743;4945.961348116935;4983.72589507566;5014.373203349582;5034.1923463091925;4897.191963326011;4914.967856750122;4938.802447902043;4939.333190019445;4967.577755890789;4646.767661616838;4857.198562237191;4894.167991441393;4909.5090490950615;4914.803407863646;3570.678848825847;3571.4821350903453;3581.9283614328087;3582.8925132246072;3614.9457758134176;4980.676256043345;5179.04187725272;5209.114450543341;5227.268182454535;5241.947580524146;4791.161546729239;4996.175631020841;5011.84964451067;5019.949800501949;5043.193089105725;4986.650934434555;5001.674891132065;5017.896062866163;5042.823501177441;5085;4852.733099679552;4942.777575009061;4945.629077819106;5027.748612569284;5030.62270329734;5023.171176755941;5035.546800787946;5035.759087206158;5039.546440820343;5055.797768089383;4931.211006238985;4941.456439791548;4980.655223089818;4987.80048798044;5001.974990125026 04:32:33 INFO - PROCESS | 17300 | |5;yui.html;636.6689321552793;667.3326673326674;684.7877158080998;690.5131882023175;726.7928640337504;12427.751444971094;13440;13480.932595337033;13499.055066145374;13500.729985400298;13140.080194386397;13296.867031329684;13311.068225224239;13314.334283285822;13315.733685326288;594.8958932186872;610.1823556434399;733.7798660401858;736.1791602363353;756.8032311598969;772.077367545783;775.2441369664589;775.9728409505668;776.3595034096865;776.4254451705725;813.9715109971153;814.7067055859885;815.559597817178;815.6166601697192;815.7797394703426;637.6269882118966;657.139147716493;783.4124406694979;803.7468197517821;811.2455416462687;587.9794207202727;591.7130191856946;592.0142961968318;592.351375244107;592.3661682000261;12662.810057849047;12711.237325760392;12716.364181790967;12726.745465090738;12727.872721272854;12317.384130793425;12569.245845249223;12619.810702839464;12722;12924.224546527239;10473.31923424975;10615.522301496374;10726.946365268202;10745.08666763326;10786.406747628876;4023.3964905264443;4040.0909795296116;4055.1484188320487;4121.093359460914;4124.8143833527565;62228.688856555884;62308;62331;62335;62344.07731265568;9470.242380609534;9826.115649591427;9842.65550705722;9909.851352229722;10302.484875756183;18929.526761831065;19017.714734278998;19317.323893663655;19629.411117666492;19633.509162270773;6329.430351268408;6347.460465860361;6518.250401203827;6691.330866913269;6821.249662537117;3417.419038763416;3439.673231043047;3492.1269682579355;3533.717302615785;3644.507991421124;2678.25008997481;2764.226016715323;2765.751082402553;2768.0726956469407;2768.9723102769117;445.69692609026174;456.1378993701906;461.68836035675787;465.5367908930568;467.8269040454985;537.1298496435799;538.7010209333779;553.5405613340918;562.9465200805917;582.2808831093596;7366.8526629467115;7488.438367122488;7686.423518236154;7841.2158784122275;8070.677172913135;489.44085840396593;555.0730280431608;569.3168198162222;594.04655527878;612.3111499562991;3803.980980095082;3856.8842934712;3891.7081218908697;4001.2597669430666;4263.70154089217;48771.756141219776;49312.50687493079;65589.67205164039;66519;69162;45349.09301814011;47893.76053119782;59256.407435925954;59278.70360648255;60229;53083.73458132685;53923;54681.45318546764;55476.44523554713;55728.72135639296;7134.1795693495915;7431.888521672071;7445.329920307198;7475.7009719610605;7537.2085930976455;31774.523382148825;32595.18512037218;33191.66808331886;34661.65338346584;37254.8137259312;38516;42661.57338426576;47709.28436073531;48224.75887620539;50189;10376.533056012648;10859.34843909368;10908.072813810915;11329.943350283196;11415.37215453158;13013.544525941546;13031.934840325737;13060.08579399471;13160.868391315964;14051.297435128407;9654.324197306121;11910.761784764429;11932.701682458008;12064.698382540506;12490;11839.408029598659;11975.64073077809;12046.698832529257;12087.516499339928;12091.57679481214;11535.134864885335;11557.537698491966;11703.122265829927;12153.270803751802;12480.625581232578;9764.995924210169;9842.557084931052;10023.298369114093;10176.49117544105;10189.643362482575;9418.199453046567;9944;9973.50132493387;9991.600335986479;10067.69796906094 04:32:33 INFO - PROCESS | 17300 | __end_tp_report 04:32:33 INFO - PROCESS | 17300 | __start_cc_report 04:32:33 INFO - PROCESS | 17300 | _x_x_mozilla_cycle_collect,2392 04:32:33 INFO - PROCESS | 17300 | __end_cc_report 04:32:33 INFO - PROCESS | 17300 | __startTimestamp1480941153285__endTimestamp 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | ------- Summary: start ------- 04:32:33 INFO - PROCESS | 17300 | Number of tests: 6 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | [#0] dojo.html Cycles:165 Average:4559.00 Median:4702.34 stddev:479.19 (10.2%) stddev-sans-first:453.98 04:32:33 INFO - PROCESS | 17300 | Values: 2549.0 2567.0 2579.1 2601.5 2611.0 4479.1 4531.0 4565.9 4574.3 4588.5 4572.7 4574.0 4574.2 4581.2 4585.0 4182.1 4202.4 4214.2 4228.9 4266.8 4203.0 4235.8 4238.3 4241.8 4250.6 4222.5 4235.3 4244.9 4251.3 4259.0 4281.9 4291.5 4299.6 4306.1 4313.2 4162.6 4180.9 4199.3 4233.3 4261.4 4588.8 4617.0 4618.6 4631.6 4638.4 4937.6 4940.6 4961.6 4965.7 5013.6 4838.1 4882.7 4992.3 4993.1 5034.2 4598.3 4612.7 4614.4 4645.0 4696.8 5055.0 5066.2 5066.7 5072.0 5107.3 4879.2 4886.2 4889.1 4890.6 4925.0 4811.4 4825.5 4829.0 4843.7 4874.1 4903.6 4914.9 4917.5 4918.6 4924.4 4825.0 4833.9 4837.6 4842.8 4883.0 4114.8 4138.8 4146.4 4150.4 4185.1 3611.5 3611.7 3635.3 3654.4 3654.8 4267.0 4272.9 4288.2 4308.7 4313.8 4922.8 4923.0 4929.9 4934.1 4978.1 4149.6 4189.1 4248.2 4249.7 4277.9 4450.4 4501.2 4506.4 4523.2 4525.8 4685.3 4702.3 4707.5 4709.6 4742.8 4884.4 4966.6 5025.5 5032.6 5070.9 4601.4 4608.9 4623.4 4640.3 4641.7 4835.6 4848.2 4855.8 4867.1 4873.9 4863.0 4895.1 4901.6 4902.7 4904.3 4775.6 4782.0 4784.8 4791.2 4791.3 4741.4 4765.4 4788.5 4789.9 4795.5 4717.0 4750.6 4756.6 4774.5 4777.0 4904.1 4915.6 4917.1 4920.4 4952.0 4576.6 4726.7 4820.3 4822.0 4861.8 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | [#1] ext.html Cycles:180 Average:45025.93 Median:178606.07 stddev:80883.49 (45.3%) stddev-sans-first:81041.48 04:32:33 INFO - PROCESS | 17300 | Values: 556.1 568.4 587.4 590.1 593.8 26712.9 29418.6 36195.8 37436.6 37572.0 38378.0 38810.8 38844.0 38909.4 38950.6 7315.5 7462.4 7466.2 7466.7 7467.8 7190.1 7401.0 9654.2 9980.5 9991.2 9699.5 9762.3 9766.2 9769.8 9777.2 9718.6 9727.5 9765.1 9767.7 9769.6 9552.5 9618.2 9619.6 9620.7 9623.9 36121.1 36374.8 36439.3 36485.1 36534.3 2986.8 3155.5 3249.5 3370.5 3390.0 24384.4 24417.5 24471.5 25062.0 28956.6 3426.4 3457.6 3506.2 3544.1 3557.0 234999.8 237009.0 237084.0 237342.0 237935.0 47678.8 47902.5 48035.3 48041.5 48062.8 51578.5 51820.7 51835.7 51933.7 51948.7 12837.1 13075.3 13087.4 13090.1 13091.0 8952.2 9221.0 9809.5 9838.8 9850.4 13246.1 13339.9 13373.8 14362.4 14847.3 5395.6 6175.0 6177.8 6182.2 6221.9 797.4 845.1 886.4 938.9 1005.7 25622.4 26426.3 26667.5 26687.7 26932.3 900.6 940.8 959.7 974.4 1014.1 14055.6 14186.3 14310.2 14420.8 14456.7 350284.0 352919.0 353332.0 353668.0 383250.0 36883.1 41266.6 44219.0 45087.0 45136.8 1140.2 1152.2 1170.8 1183.2 1184.1 26091.6 27321.7 27479.7 27517.2 28069.9 39846.0 39863.6 40016.8 40102.6 40306.0 313577.0 314179.0 315383.0 315417.0 315549.0 32882.2 34148.3 34152.7 34171.3 34192.7 38968.2 39013.8 39128.4 39153.8 39332.4 32121.0 33377.8 33462.0 33701.3 34643.0 32861.2 33050.7 33319.7 33467.7 34372.1 32791.7 33667.1 33702.7 33936.7 33984.8 28530.4 30642.7 30942.2 31038.5 31195.8 23360.4 23789.0 23921.6 24296.4 24370.8 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | [#2] jquery.html Cycles:180 Average:22924.51 Median:49616.54 stddev:61069.65 (123.1%) stddev-sans-first:61217.42 04:32:33 INFO - PROCESS | 17300 | Values: 337.6 355.0 363.3 363.8 378.1 12925.0 13300.2 13543.6 16369.6 16373.8 15412.9 15531.5 16165.6 16170.9 16180.7 4709.7 4902.2 4904.4 4904.8 4912.7 3641.4 3824.3 5527.8 5780.2 5811.7 5870.2 5873.3 5876.7 5880.2 5882.8 5044.3 5297.8 5329.2 5379.9 5386.0 5107.9 5192.3 5200.5 5201.2 5201.4 11426.7 11671.0 11697.6 11726.6 11732.9 1843.7 1853.3 1969.8 2001.2 2049.2 8632.5 9035.3 9046.8 10555.3 12513.0 1617.7 1730.0 1770.2 1792.5 1890.4 43949.0 60305.4 64764.7 64823.7 69180.3 9206.5 9534.7 9774.7 9860.2 10051.1 13116.5 13198.9 13224.0 13231.1 13254.7 6557.5 6557.5 6610.1 6817.3 6946.9 6227.7 6340.9 6434.5 6479.6 6500.4 3943.0 4029.1 4104.8 4194.7 4291.9 1537.6 1552.6 1621.8 1625.0 1653.0 779.7 779.9 875.9 940.8 952.2 15859.2 16587.3 16650.3 16672.8 17046.2 835.2 835.3 854.2 883.6 921.9 8887.1 9014.7 9315.3 9316.7 9480.3 360136.0 362847.0 364056.0 376120.0 382498.0 77161.6 78763.0 80084.6 80102.6 80530.0 928.7 936.4 941.3 957.9 960.9 14380.0 14853.4 15378.4 15555.7 15602.3 27771.9 32373.0 35229.0 35375.0 36894.6 49026.4 49310.5 49613.8 49619.3 51721.2 7167.5 7201.8 7256.9 7433.3 7544.7 8341.9 11138.3 11286.7 11385.0 11626.1 9689.5 9748.3 9875.6 9881.8 10144.4 9792.5 9852.6 9935.4 10088.9 10229.9 9967.5 10147.4 10480.8 10488.9 10687.1 7013.0 7247.3 7277.6 7485.4 7504.8 8733.3 9822.5 9948.1 9986.5 10312.3 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | [#3] mootools.html Cycles:180 Average:4603.63 Median:5748.12 stddev:2476.96 (43.1%) stddev-sans-first:2471.56 04:32:33 INFO - PROCESS | 17300 | Values: 1312.2 1374.3 1399.5 1620.5 1665.0 6162.1 6392.2 6593.0 6981.9 6982.7 6580.6 6855.0 6862.1 7007.6 7014.5 2006.8 2046.6 2047.8 2064.5 2064.9 1794.4 1851.6 2053.5 2058.3 2069.1 2006.4 2101.8 2102.4 2103.8 2116.5 2053.8 2059.4 2090.3 2097.4 2097.5 2087.1 2105.0 2105.2 2111.4 2116.1 7010.2 7044.8 7097.1 7103.4 7104.6 3928.8 4103.1 4109.3 4121.1 4135.2 2602.8 2779.7 2862.4 2874.4 2881.7 907.4 919.2 927.7 939.5 946.9 9057.4 9191.7 9205.7 9210.8 9310.7 3687.6 3813.5 3896.4 3904.9 3978.3 8063.6 8065.3 8111.6 8118.4 8122.7 4225.5 4231.5 4233.9 4236.0 4236.0 3802.5 3806.6 3944.6 3946.0 3946.2 3006.2 3041.8 3123.0 3152.6 3156.7 849.6 857.2 930.7 940.1 948.2 722.3 738.5 769.5 799.9 823.9 4840.0 4859.5 4942.3 5053.6 5067.2 825.8 849.2 860.0 860.1 869.2 3221.6 3309.2 3321.9 3386.4 3404.6 7871.8 8392.7 8405.5 8407.3 8412.0 8262.6 8306.9 8355.3 8364.0 8414.2 6443.5 6606.1 6608.3 6609.9 6615.0 4742.9 4752.6 4767.2 4907.6 4950.4 7691.0 7743.9 7792.2 7802.0 7850.9 7841.3 7861.9 7862.8 7910.1 8010.2 5571.3 5679.0 5682.7 5685.5 5812.8 6575.0 6636.7 6711.0 6712.0 6719.2 6048.2 6104.7 6141.9 6149.7 6197.2 5970.3 6006.0 6016.6 6029.0 6029.9 5695.4 5740.2 5756.1 5793.9 5798.7 4107.0 4196.8 4283.6 4292.6 4332.6 4050.2 4187.2 4269.7 4299.4 4318.1 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | [#4] prototype.html Cycles:180 Average:4100.17 Median:4649.55 stddev:1199.33 (25.8%) stddev-sans-first:1167.76 04:32:33 INFO - PROCESS | 17300 | Values: 271.8 285.8 285.9 297.6 304.2 4601.3 4703.9 4791.8 4800.6 4833.2 4611.8 4729.3 4745.6 4749.2 4756.4 3532.8 3647.6 3752.2 3758.3 3758.8 3615.9 3688.3 3689.2 3693.5 3706.5 3667.6 3668.7 3669.9 3677.8 3680.3 3681.4 3687.4 3688.7 3698.8 3713.8 3177.1 3234.6 3238.4 3257.9 3272.5 4560.4 4588.2 4591.7 4594.6 4614.4 4168.9 4203.5 4212.1 4220.9 4237.5 4735.0 4942.0 4973.8 4978.7 5002.7 3516.9 3524.6 3526.7 3532.1 3552.0 5170.7 5172.4 5180.8 5192.3 5202.6 3609.2 3611.4 3620.1 3639.2 3646.8 3428.5 3643.5 3684.6 3712.3 3726.3 4164.6 4185.2 4185.8 4192.6 4196.4 4738.0 4826.3 4885.5 4976.8 5025.7 1208.4 1216.8 1219.4 1223.8 1226.1 793.2 809.7 816.3 817.2 821.1 4287.8 4292.4 4316.8 4317.3 4327.4 4973.3 4990.9 4993.6 5005.9 5006.2 4287.4 4307.1 4314.2 4317.1 4324.6 2570.2 2625.9 2648.2 2658.5 2662.1 4659.1 4659.6 4665.4 4667.7 4693.8 5075.7 5077.6 5090.7 5101.5 5127.4 4398.3 4583.6 4629.0 4652.3 4682.4 4920.2 4946.0 4983.7 5014.4 5034.2 4897.2 4915.0 4938.8 4939.3 4967.6 4646.8 4857.2 4894.2 4909.5 4914.8 3570.7 3571.5 3581.9 3582.9 3614.9 4980.7 5179.0 5209.1 5227.3 5241.9 4791.2 4996.2 5011.8 5019.9 5043.2 4986.7 5001.7 5017.9 5042.8 5085.0 4852.7 4942.8 4945.6 5027.7 5030.6 5023.2 5035.5 5035.8 5039.5 5055.8 4931.2 4941.5 4980.7 4987.8 5002.0 04:32:33 INFO - PROCESS | 17300 | 04:32:33 INFO - PROCESS | 17300 | [#5] yui.html Cycles:180 Average:14546.25 Median:466.68 stddev:17949.09 (3846.1%) stddev-sans-first:17969.05 04:32:33 INFO - PROCESS | 17300 | Values: 636.7 667.3 684.8 690.5 726.8 12427.8 13440.0 13480.9 13499.1 13500.7 13140.1 13296.9 13311.1 13314.3 13315.7 594.9 610.2 733.8 736.2 756.8 772.1 775.2 776.0 776.4 776.4 814.0 814.7 815.6 815.6 815.8 637.6 657.1 783.4 803.7 811.2 588.0 591.7 592.0 592.4 592.4 12662.8 12711.2 12716.4 12726.7 12727.9 12317.4 12569.2 12619.8 12722.0 12924.2 10473.3 10615.5 10726.9 10745.1 10786.4 4023.4 4040.1 4055.1 4121.1 4124.8 62228.7 62308.0 62331.0 62335.0 62344.1 9470.2 9826.1 9842.7 9909.9 10302.5 18929.5 19017.7 19317.3 19629.4 19633.5 6329.4 6347.5 6518.3 6691.3 6821.2 3417.4 3439.7 3492.1 3533.7 3644.5 2678.3 2764.2 2765.8 2768.1 2769.0 445.7 456.1 461.7 465.5 467.8 537.1 538.7 553.5 562.9 582.3 7366.9 7488.4 7686.4 7841.2 8070.7 489.4 555.1 569.3 594.0 612.3 3804.0 3856.9 3891.7 4001.3 4263.7 48771.8 49312.5 65589.7 66519.0 69162.0 45349.1 47893.8 59256.4 59278.7 60229.0 53083.7 53923.0 54681.5 55476.4 55728.7 7134.2 7431.9 7445.3 7475.7 7537.2 31774.5 32595.2 33191.7 34661.7 37254.8 38516.0 42661.6 47709.3 48224.8 50189.0 10376.5 10859.3 10908.1 11329.9 11415.4 13013.5 13031.9 13060.1 13160.9 14051.3 9654.3 11910.8 11932.7 12064.7 12490.0 11839.4 11975.6 12046.7 12087.5 12091.6 11535.1 11557.5 11703.1 12153.3 12480.6 9765.0 9842.6 10023.3 10176.5 10189.6 9418.2 9944.0 9973.5 9991.6 10067.7 04:32:33 INFO - PROCESS | 17300 | -------- Summary: end -------- 04:32:33 INFO - PROCESS | 17300 | 04:32:34 INFO - TEST-INFO | 17300: exit 0 04:32:34 INFO - TEST-OK | dromaeo_css | took 1122753ms 04:32:34 INFO - TEST-START | kraken 04:32:34 INFO - operating with platform_type : linux_ 04:32:34 INFO - Initialising browser for kraken test... 04:32:34 INFO - TEST-INFO | started process 17610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zXHUE/profile http://localhost:46162/getInfo.html) 04:32:38 INFO - PROCESS | 17610 | __metrics Screen width/height:1600/1200 04:32:38 INFO - PROCESS | 17610 | colorDepth:24 04:32:38 INFO - PROCESS | 17610 | Browser inner width/height: 1024/697 04:32:38 INFO - PROCESS | 17610 | __metrics 04:32:39 INFO - PROCESS | 17610 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:32:39 INFO - PROCESS | 17610 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:40 INFO - TEST-INFO | 17610: exit 0 04:32:40 INFO - Browser initialized. 04:32:40 INFO - Running cycle 1/1 for kraken test... 04:32:40 INFO - TEST-INFO | started process 17691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zXHUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:52 INFO - PROCESS | 17691 | RSS: Main: 175108096 04:32:52 INFO - PROCESS | 17691 | 04:32:55 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:56 INFO - PROCESS | 17691 | RSS: Main: 236515328 04:32:56 INFO - PROCESS | 17691 | 04:32:59 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-dft) 04:32:59 INFO - PROCESS | 17691 | RSS: Main: 219009024 04:32:59 INFO - PROCESS | 17691 | 04:33:02 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-fft) 04:33:03 INFO - PROCESS | 17691 | RSS: Main: 301400064 04:33:03 INFO - PROCESS | 17691 | 04:33:05 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-oscillator) 04:33:06 INFO - PROCESS | 17691 | RSS: Main: 211988480 04:33:06 INFO - PROCESS | 17691 | 04:33:08 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:09 INFO - PROCESS | 17691 | RSS: Main: 215011328 04:33:09 INFO - PROCESS | 17691 | 04:33:12 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46162/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:12 INFO - PROCESS | 17691 | RSS: Main: 254095360 04:33:12 INFO - PROCESS | 17691 | 04:33:16 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46162/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:17 INFO - PROCESS | 17691 | RSS: Main: 248688640 04:33:17 INFO - PROCESS | 17691 | 04:33:19 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46162/tests/kraken/driver.html?testName=json-parse-financial) 04:33:20 INFO - PROCESS | 17691 | RSS: Main: 250470400 04:33:20 INFO - PROCESS | 17691 | 04:33:22 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:22 INFO - PROCESS | 17691 | RSS: Main: 213831680 04:33:22 INFO - PROCESS | 17691 | 04:33:24 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:25 INFO - PROCESS | 17691 | RSS: Main: 221405184 04:33:25 INFO - PROCESS | 17691 | 04:33:27 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:28 INFO - PROCESS | 17691 | RSS: Main: 229560320 04:33:28 INFO - PROCESS | 17691 | 04:33:31 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:31 INFO - PROCESS | 17691 | RSS: Main: 238190592 04:33:31 INFO - PROCESS | 17691 | 04:33:34 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:35 INFO - PROCESS | 17691 | RSS: Main: 236007424 04:33:35 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46162/tests/kraken/driver.html?testName=ai-astar) 04:33:37 INFO - PROCESS | 17691 | RSS: Main: 285888512 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | __start_tp_report 04:33:37 INFO - PROCESS | 17691 | _x_x_mozilla_page_load 04:33:37 INFO - PROCESS | 17691 | _x_x_mozilla_page_load_details 04:33:37 INFO - PROCESS | 17691 | |i|pagename|runs| 04:33:37 INFO - PROCESS | 17691 | |0;ai-astar;109;120;118;117;117;115;118;115;115;117 04:33:37 INFO - PROCESS | 17691 | |1;audio-beat-detection;164;130;136;180;139;131;129;131;149;132 04:33:37 INFO - PROCESS | 17691 | |2;audio-dft;161;162;162;162;162;161;161;162;161;163 04:33:37 INFO - PROCESS | 17691 | |3;audio-fft;77;78;78;104;77;77;76;77;97;77 04:33:37 INFO - PROCESS | 17691 | |4;audio-oscillator;84;84;108;83;83;83;98;83;84;120 04:33:37 INFO - PROCESS | 17691 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;117;119;117 04:33:37 INFO - PROCESS | 17691 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;147;146 04:33:37 INFO - PROCESS | 17691 | |7;imaging-desaturate;95;94;96;95;95;95;95;104;95;96 04:33:37 INFO - PROCESS | 17691 | |8;json-parse-financial;67;65;66;66;66;67;67;67;66;67 04:33:37 INFO - PROCESS | 17691 | |9;json-stringify-tinderbox;66;67;66;65;66;65;67;66;66;66 04:33:37 INFO - PROCESS | 17691 | |10;stanford-crypto-aes;86;84;92;86;91;84;85;84;84;85 04:33:37 INFO - PROCESS | 17691 | |11;stanford-crypto-ccm;149;146;143;144;144;142;144;149;180;146 04:33:37 INFO - PROCESS | 17691 | |12;stanford-crypto-pbkdf2;185;186;180;178;182;178;178;181;180;182 04:33:37 INFO - PROCESS | 17691 | |13;stanford-crypto-sha256-iterative;72;73;72;72;74;72;73;73;71;75 04:33:37 INFO - PROCESS | 17691 | __end_tp_report 04:33:37 INFO - PROCESS | 17691 | __start_cc_report 04:33:37 INFO - PROCESS | 17691 | _x_x_mozilla_cycle_collect,1996 04:33:37 INFO - PROCESS | 17691 | __end_cc_report 04:33:37 INFO - PROCESS | 17691 | __startTimestamp1480941217681__endTimestamp 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | ------- Summary: start ------- 04:33:37 INFO - PROCESS | 17691 | Number of tests: 14 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.00 stddev:2.96 (2.5%) stddev-sans-first:1.69 04:33:37 INFO - PROCESS | 17691 | Values: 109.0 120.0 118.0 117.0 117.0 115.0 118.0 115.0 115.0 117.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:137.50 stddev:17.25 (12.5%) stddev-sans-first:16.37 04:33:37 INFO - PROCESS | 17691 | Values: 164.0 130.0 136.0 180.0 139.0 131.0 129.0 131.0 149.0 132.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:33:37 INFO - PROCESS | 17691 | Values: 161.0 162.0 162.0 162.0 162.0 161.0 161.0 162.0 161.0 163.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:10.01 (13.0%) stddev-sans-first:10.46 04:33:37 INFO - PROCESS | 17691 | Values: 77.0 78.0 78.0 104.0 77.0 77.0 76.0 77.0 97.0 77.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.50 stddev:13.26 (15.9%) stddev-sans-first:13.82 04:33:37 INFO - PROCESS | 17691 | Values: 84.0 84.0 108.0 83.0 83.0 83.0 98.0 83.0 84.0 120.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 04:33:37 INFO - PROCESS | 17691 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 119.0 117.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:33:37 INFO - PROCESS | 17691 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.87 (3.0%) stddev-sans-first:3.02 04:33:37 INFO - PROCESS | 17691 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 104.0 95.0 96.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:33:37 INFO - PROCESS | 17691 | Values: 67.0 65.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:33:37 INFO - PROCESS | 17691 | Values: 66.0 67.0 66.0 65.0 66.0 65.0 67.0 66.0 66.0 66.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:2.96 (3.5%) stddev-sans-first:3.14 04:33:37 INFO - PROCESS | 17691 | Values: 86.0 84.0 92.0 86.0 91.0 84.0 85.0 84.0 84.0 85.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:146.00 stddev:11.25 (7.7%) stddev-sans-first:11.93 04:33:37 INFO - PROCESS | 17691 | Values: 149.0 146.0 143.0 144.0 144.0 142.0 144.0 149.0 180.0 146.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:181.50 stddev:2.83 (1.6%) stddev-sans-first:2.60 04:33:37 INFO - PROCESS | 17691 | Values: 185.0 186.0 180.0 178.0 182.0 178.0 178.0 181.0 180.0 182.0 04:33:37 INFO - PROCESS | 17691 | 04:33:37 INFO - PROCESS | 17691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 04:33:37 INFO - PROCESS | 17691 | Values: 72.0 73.0 72.0 72.0 74.0 72.0 73.0 73.0 71.0 75.0 04:33:37 INFO - PROCESS | 17691 | -------- Summary: end -------- 04:33:37 INFO - PROCESS | 17691 | 04:33:39 INFO - TEST-INFO | 17691: exit 0 04:33:39 INFO - TEST-OK | kraken | took 64856ms 04:33:39 INFO - SUITE-END | took 1187s 04:33:39 INFO - Completed test suite (00:19:47) 04:33:39 INFO - javascript benchmark 04:33:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.9999999999995, 2566.961495577568, 2579.1102069785925, 2601.479704059189, 2610.973890261098, 4479.081788233412, 4530.954690453094, 4565.863024109278, 4574.313852922063, 4588.472325682547, 4572.725636461814, 4574.016586433916, 4574.2223821950265, 4581.221192397292, 4584.954150458494, 4182.100848317611, 4202.432671589342, 4214.199302132585, 4228.936565951513, 4266.807993640294, 4202.957970420287, 4235.809388577506, 4238.321868501041, 4241.766702831343, 4250.553691862341, 4222.451081359419, 4235.258829704805, 4244.87265382039, 4251.256030194719, 4258.97870510647, 4281.935770963438, 4291.50647675515, 4299.591538803808, 4306.074194048263, 4313.223619748444, 4162.62536371728, 4180.895477613084, 4199.349100889367, 4233.30150525166, 4261.3607958806115, 4588.839390621346, 4616.976915115437, 4618.584327410549, 4631.560001799858, 4638.350630911675, 4937.5556199942175, 4940.604751619898, 4961.603071754287, 4965.677230980011, 5013.623978201613, 4838.056578967103, 4882.731449770261, 4992.326035985132, 4993.1262029144755, 5034.219695947134, 4598.310253461974, 4612.723236605814, 4614.446266448048, 4645.0477652081245, 4696.835610753676, 5055.0, 5066.214736715815, 5066.670666406671, 5071.974640126849, 5107.310513080686, 4879.194932836042, 4886.218205087169, 4889.119958407521, 4890.559849613552, 4925.039617274597, 4811.3745213122775, 4825.469198388175, 4829.0, 4843.660943733976, 4874.098291816025, 4903.632227582874, 4914.852554423373, 4917.483664215278, 4918.606511479073, 4924.359833221658, 4825.010872771073, 4833.9033219335415, 4837.612990960714, 4842.782074806642, 4882.975585122052, 4114.773687447219, 4138.772367519815, 4146.398772178018, 4150.418941348214, 4185.121124563815, 3611.4582812578324, 3611.7471776975885, 3635.327464419091, 3654.3787556115526, 3654.780713157219, 4266.978665106654, 4272.87181384559, 4288.2281189385585, 4308.6983911126545, 4313.784310784448, 4922.801521593155, 4922.975385123052, 4929.876753081202, 4934.062528119646, 4978.10394129053, 4149.585041495887, 4189.0574620710095, 4248.171606536757, 4249.723767955073, 4277.850275240352, 4450.35469856869, 4501.212287849613, 4506.414166158444, 4523.208438523246, 4525.841595544141, 4685.344051832814, 4702.341672165968, 4707.458642256184, 4709.646776491845, 4742.762861856962, 4884.365032545888, 4966.553010229097, 5025.497450255091, 5032.572231360229, 5070.949290507047, 4601.447826260736, 4608.907821843477, 4623.398958135421, 4640.280756482751, 4641.675082744176, 4835.564799168092, 4848.200046992207, 4855.830045948375, 4867.075255701406, 4873.853784386474, 4863.0, 4895.094407534618, 4901.5588597026435, 4902.7058376497525, 4904.2643603459765, 4775.594074503706, 4782.019685964438, 4784.7607619619575, 4791.185498465339, 4791.281307803857, 4741.383620129361, 4765.428148622187, 4788.521147885183, 4789.880252993703, 4795.496472870298, 4717.0, 4750.643701722453, 4756.619470442425, 4774.546418090275, 4777.0207107543565, 4904.092742842586, 4915.557599816034, 4917.139500587455, 4920.360353154067, 4952.0, 4576.58125980947, 4726.669133160645, 4820.276958456259, 4822.0, 4861.829835955866], "value": 4528.249668003864, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.0574825670487, 568.4060157135794, 587.3715124816446, 590.0942053947189, 593.7951406764664, 26712.86643566782, 29418.558721619193, 36195.81902090493, 37436.62563374366, 37572.0, 38378.0, 38810.80594597023, 38844.0, 38909.41635875464, 38950.61049389505, 7315.4879158458925, 7462.365698915599, 7466.216047315035, 7466.664000120008, 7467.813304667399, 7190.101237345332, 7400.962995185017, 9654.227661787076, 9980.451075190862, 9991.150752186037, 9699.466529340883, 9762.26782991275, 9766.218702503782, 9769.755756106084, 9777.217822574177, 9718.562664680107, 9727.464989425614, 9765.121139097444, 9767.706968790948, 9769.609215631366, 9552.474613896233, 9618.182454491376, 9619.56711947957, 9620.71137865865, 9623.855642165303, 36121.1236483074, 36374.81812590946, 36439.27121457556, 36485.087872803124, 36534.26931461356, 2986.7759918006236, 3155.495120780687, 3249.496328069153, 3370.477575975703, 3390.0, 24384.39039024021, 24417.511649767082, 24471.510569788505, 25062.0, 28956.565651515244, 3426.4003799335264, 3457.619661837196, 3506.1585219547123, 3544.149404142987, 3556.982215088908, 234999.8250008756, 237009.0, 237084.0, 237342.0, 237935.0, 47678.76160619175, 47902.520974789804, 48035.27947080797, 48041.5195848044, 48062.759686202044, 51578.48421515812, 51820.74089629603, 51835.74082129565, 51933.740331298104, 51948.74025629848, 12837.101402901893, 13075.346232688327, 13087.41106650203, 13090.14914030585, 13091.0, 8952.194302512806, 9221.0, 9809.460479673686, 9838.803223935623, 9850.359726617748, 13246.139000964906, 13339.932805375547, 13373.799393009112, 14362.425502979973, 14847.2576371181, 5395.62230643859, 6175.0, 6177.7837775677635, 6182.196314479089, 6221.8845592498765, 797.4099166616662, 845.0915266088979, 886.4415418286438, 938.8591711243369, 1005.7183988483237, 25622.359441014123, 26426.339341516617, 26667.466650666876, 26687.733122668913, 26932.32669183247, 900.6274537122308, 940.7742141886035, 959.6593209410559, 974.3569244298728, 1014.1379827147014, 14055.648608784863, 14186.290685465685, 14310.212938288287, 14420.783688244685, 14456.710865782836, 350284.0, 352919.0, 353332.0, 353668.0, 383250.0, 36883.07792305214, 41266.58733412628, 44219.0, 45087.0, 45136.77431612821, 1140.241739243427, 1152.1589239854952, 1170.836082948405, 1183.219075410225, 1184.0882520459197, 26091.60862587025, 27321.72678273192, 27479.725202748516, 27517.174484765488, 28069.859650701615, 39846.0, 39863.60136398715, 40016.79991600024, 40102.59897400989, 40306.0, 313577.0, 314179.0, 315383.0, 315417.0, 315549.0, 32882.1779455506, 34148.31703365968, 34152.65847341495, 34171.31657366888, 34192.658073419945, 38968.2206355877, 39013.804930975166, 39128.41307380335, 39153.804230979804, 39332.41001384924, 32121.0, 33377.83311083429, 33462.0, 33701.3259734799, 34643.0, 32861.17847053843, 33050.66949330476, 33319.66680333263, 33467.66532334645, 34372.14069648179, 32791.67208327886, 33667.13829324535, 33702.662973370934, 33936.66063339335, 33984.83007585045, 28530.429391412472, 30642.693573063985, 30942.22644433907, 31038.53442198414, 31195.84402077975, 23360.415989600395, 23789.0, 23921.641175382036, 24296.392590185387, 24370.831791866945], "value": 17026.295971815332, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5881424661912, 354.97160227181826, 363.2788914005698, 363.75991845382043, 378.1284140057169, 12925.0, 13300.201987880722, 13543.593692189226, 16369.59076023097, 16373.754393684105, 15412.922935385308, 15531.53405397837, 16165.595860103504, 16170.919145404287, 16180.676386472263, 4709.670323077395, 4902.166631672624, 4904.4114706235305, 4904.828331008415, 4912.680675756064, 3641.4355774854807, 3824.29250588642, 5527.806526771564, 5780.2196703444915, 5811.6803575803315, 5870.236869206997, 5873.2658417697785, 5876.735546900379, 5880.176775251468, 5882.794102206423, 5044.2937988681615, 5297.8145764898045, 5329.173978033411, 5379.946200537984, 5386.0, 5107.923381149286, 5192.299039629677, 5200.479952004769, 5201.245819356172, 5201.427842937273, 11426.71433214168, 11671.0, 11697.649070527897, 11726.648200553997, 11732.944035036888, 1843.7142242952364, 1853.3235369090319, 1969.812867777559, 2001.2195243854908, 2049.241780541194, 8632.482051076893, 9035.333539437308, 9046.77383065422, 10555.313904596176, 12513.0, 1617.652204775967, 1729.9913500432542, 1770.2299499717665, 1792.5429015601069, 1890.404522575398, 43949.0, 60305.396946030414, 64764.67617661929, 64823.67588162076, 69180.30819691789, 9206.539673016456, 9534.666286679932, 9774.657886973922, 9860.16188623975, 10051.095401413762, 13116.475340986444, 13198.934005329911, 13224.0, 13231.139975901535, 13254.668633284246, 6557.475401967831, 6557.475401967831, 6610.0745895574655, 6817.250102488722, 6946.8610627788175, 6227.688615569204, 6340.873182536324, 6434.485241180694, 6479.643619600873, 6500.382463665944, 3942.9605703943166, 4029.133736246721, 4104.774237416911, 4194.748315101043, 4291.892702682396, 1537.5617948884737, 1552.6196081959993, 1621.8215996240403, 1624.951251462458, 1652.983470165307, 779.6530543907907, 779.859625267446, 875.9255463285692, 940.830650482906, 952.1763674421713, 15859.207039647972, 16587.253573589216, 16650.250738716786, 16672.833271667372, 17046.23291951865, 835.1898658301438, 835.3275613131487, 854.2354592639552, 883.6156272021691, 921.9400738952081, 8887.066857979818, 9014.729558113268, 9315.34792564514, 9316.720498385059, 9480.288978326515, 360136.0, 362847.0, 364056.0, 376120.0, 382498.0, 77161.61419192867, 78763.0, 80084.59957700175, 80102.59948700336, 80530.0, 928.7167413938679, 936.3539157980971, 941.2799208605422, 957.8563215517728, 960.8558716192488, 14379.98680184796, 14853.40586376576, 15378.384864605738, 15555.688886221986, 15602.297896594453, 27771.861140694167, 32373.0, 35229.0, 35375.03114876651, 36894.631053690195, 49026.40090785934, 49310.548261622775, 49613.82144303171, 49619.25571116364, 51721.22418163655, 7167.498275120692, 7201.819954501179, 7256.905636276638, 7433.293837085468, 7544.735934242275, 8341.874871877048, 11138.33170009802, 11286.66140015801, 11385.0, 11626.069914406997, 9689.515524223902, 9748.268879834182, 9875.604975800887, 9881.802363952824, 10144.391336519833, 9792.51037448139, 9852.556634951301, 9935.403875767477, 10088.899111008795, 10229.897701022894, 9967.50162491858, 10147.391156530337, 10480.842787358044, 10488.947555262175, 10687.145028397554, 7012.964935175495, 7247.311505406978, 7277.59973201479, 7485.363744081814, 7504.761714317076, 8733.301335892986, 9822.459764713009, 9948.054934781185, 9986.450745208793, 10312.329698569569], "value": 7795.25323214142, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.2454588611547, 1374.251033186913, 1399.5241617849929, 1620.4733461624976, 1664.9677200135918, 6162.106494558287, 6392.20097487814, 6592.967035164824, 6981.860362792741, 6982.650867456626, 6580.605163690182, 6855.0, 6862.10792596963, 7007.57954522729, 7014.508984371096, 2006.7993200679962, 2046.5906818636258, 2047.7747447780732, 2064.4838790302424, 2064.938051858439, 1794.4078454110177, 1851.592649617082, 2053.4558342039372, 2058.289889987959, 2069.0689189864547, 2006.438197304757, 2101.77931317211, 2102.4428526440506, 2103.810657040866, 2116.5343624402685, 2053.835693144545, 2059.4439501334705, 2090.2997495838836, 2097.37078876338, 2097.4966008158085, 2087.0608226298227, 2105.0, 2105.221068204774, 2111.4088055344528, 2116.121809449077, 7010.228874823765, 7044.788656340267, 7097.112860892388, 7103.431725461951, 7104.573725576482, 3928.7642741435607, 4103.117829666636, 4109.2808758467145, 4121.052158003646, 4135.152293779798, 2602.817802753808, 2779.6664400271893, 2862.427514497088, 2874.439484300562, 2881.7118288171223, 907.419251678926, 919.2416256588341, 927.7216834949488, 939.5490164720904, 946.8769060022222, 9057.365984381096, 9191.724248272563, 9205.677801276923, 9210.769730756718, 9310.72067837966, 3687.612800655946, 3813.5423749149722, 3896.4155376693157, 3904.921901561953, 3978.264021156095, 8063.556504392197, 8065.314448271963, 8111.553864537507, 8118.35053195743, 8122.7157049502985, 4225.471816022997, 4231.4710661167355, 4233.851815186454, 4235.957640423618, 4236.0, 3802.5056742623283, 3806.619338066171, 3944.6055394460323, 3946.033221860605, 3946.1910308386714, 3006.2033561106323, 3041.7870749047356, 3123.01624988128, 3152.5586417901513, 3156.71589556941, 849.5582297205418, 857.1942374168386, 930.692871352452, 940.0646356874953, 948.2129832239362, 722.288545782404, 738.4978214813979, 769.5152054205814, 799.9480033797785, 823.9423240373117, 4840.0, 4859.514048595183, 4942.332785074041, 5053.646244762831, 5067.189249720027, 825.7860944411705, 849.1975083546113, 859.9613017414231, 860.0582362313257, 869.222046268586, 3221.6295126060336, 3309.172706823294, 3321.8671253150087, 3386.356592247465, 3404.642512536148, 7871.803204919808, 8392.664293428317, 8405.453645513022, 8407.285380742584, 8412.0, 8262.586870656443, 8306.916930830736, 8355.331573474108, 8363.95818020906, 8414.200650938274, 6443.548951573345, 6606.141201643755, 6608.2730899601, 6609.933900661124, 6615.0, 4742.857714268577, 4752.643551733565, 4767.189577771856, 4907.582855457326, 4950.356453661001, 7690.961545192238, 7743.92256077432, 7792.18182090895, 7802.0, 7850.921490785019, 7841.294283514511, 7861.921380786119, 7862.842743145219, 7910.090339610788, 8010.198980101944, 5571.331440227199, 5678.971605141948, 5682.659040457585, 5685.545156387397, 5812.796552120824, 6575.0, 6636.701348439428, 6710.966445167743, 6711.966440167768, 6719.160104986877, 6048.183495228088, 6104.664243466652, 6141.9078713818435, 6149.692515374124, 6197.194364732556, 5970.343262241063, 6006.0, 6016.578839481194, 6029.0, 6029.879402412015, 5695.373508913934, 5740.167675687086, 5756.079027355603, 5793.9420605795085, 5798.652080875161, 4106.958930410658, 4196.8111434984885, 4283.635890949305, 4292.570742925807, 4332.6317263033, 4050.1899620076692, 4187.162567486454, 4269.7224680395675, 4299.419578357007, 4318.071614602875], "value": 3761.5273000134907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.7839317742395, 285.8485002948437, 285.8913612827125, 297.6413421826699, 304.24395377486945, 4601.33280674302, 4703.929441058387, 4791.760411979404, 4800.6399520036, 4833.226683730604, 4611.815527378909, 4729.2501774343455, 4745.644076694253, 4749.216379297421, 4756.381670382854, 3532.841022153996, 3647.58052823926, 3752.212035472554, 3758.327544242813, 3758.830852611632, 3615.9096022599383, 3688.2807852468777, 3689.1883785567134, 3693.4644476550884, 3706.518152640153, 3667.559892812866, 3668.743187976843, 3669.9266014679692, 3677.797721125337, 3680.2702729717125, 3681.392570225923, 3687.4468829675493, 3688.668019878197, 3698.7780733156096, 3713.795741234231, 3177.1421716136747, 3234.5795046643784, 3238.3685181389637, 3257.9022629321157, 3272.4764037753844, 4560.361549383089, 4588.197065513522, 4591.6582542903025, 4594.632429405673, 4614.43109342825, 4168.874933751992, 4203.516595591515, 4212.115455754295, 4220.85227017053, 4237.533871274158, 4734.976325118352, 4941.975290123562, 4973.825916092919, 4978.680649627851, 5002.74986250686, 3516.9120771980647, 3524.594671612772, 3526.682598566141, 3532.0640030391965, 3551.982240088809, 5170.715610641413, 5172.379314482248, 5180.818671346485, 5192.273081768555, 5202.557782588485, 3609.1698909250495, 3611.4402267648557, 3620.1311685195365, 3639.2357604902736, 3646.781193128421, 3428.451447768345, 3643.4534819777246, 3684.613115622875, 3712.276106159327, 3726.2920045191327, 4164.583541645811, 4185.22573323936, 4185.790710464465, 4192.622663960258, 4196.391523229115, 4737.962676049263, 4826.348442960156, 4885.462599114095, 4976.805566664047, 5025.748712564357, 1208.4139192491634, 1216.8296438498617, 1219.384315781593, 1223.7674841780033, 1226.1294480918468, 793.2147174297404, 809.6923169195786, 816.3428440105772, 817.235884448043, 821.117298903669, 4287.785610719451, 4292.390353617394, 4316.848910288125, 4317.330813723878, 4327.398862420924, 4973.303737476756, 4990.850274491699, 4993.550580447777, 5005.899882002413, 5006.220303670778, 4287.421198138274, 4307.095509942885, 4314.223439780807, 4317.11499142675, 4324.589164029475, 2570.1775431861624, 2625.908093216728, 2648.1923013480687, 2658.5081759874483, 2662.148112603948, 4659.086367451358, 4659.578828457353, 4665.437078578646, 4667.696599721007, 4693.779617299527, 5075.695458272516, 5077.593792496591, 5090.669106508065, 5101.464346243591, 5127.410347809975, 4398.318260669601, 4583.564561366665, 4628.976855115703, 4652.32541281519, 4682.41469816273, 4920.21276595743, 4945.961348116935, 4983.72589507566, 5014.373203349582, 5034.1923463091925, 4897.191963326011, 4914.967856750122, 4938.802447902043, 4939.333190019445, 4967.577755890789, 4646.767661616838, 4857.198562237191, 4894.167991441393, 4909.5090490950615, 4914.803407863646, 3570.678848825847, 3571.4821350903453, 3581.9283614328087, 3582.8925132246072, 3614.9457758134176, 4980.676256043345, 5179.04187725272, 5209.114450543341, 5227.268182454535, 5241.947580524146, 4791.161546729239, 4996.175631020841, 5011.84964451067, 5019.949800501949, 5043.193089105725, 4986.650934434555, 5001.674891132065, 5017.896062866163, 5042.823501177441, 5085.0, 4852.733099679552, 4942.777575009061, 4945.629077819106, 5027.748612569284, 5030.62270329734, 5023.171176755941, 5035.546800787946, 5035.759087206158, 5039.546440820343, 5055.797768089383, 4931.211006238985, 4941.456439791548, 4980.655223089818, 4987.80048798044, 5001.974990125026], "value": 3714.4596738131427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.6689321552793, 667.3326673326674, 684.7877158080998, 690.5131882023175, 726.7928640337504, 12427.751444971094, 13440.0, 13480.932595337033, 13499.055066145374, 13500.729985400298, 13140.080194386397, 13296.867031329684, 13311.068225224239, 13314.334283285822, 13315.733685326288, 594.8958932186872, 610.1823556434399, 733.7798660401858, 736.1791602363353, 756.8032311598969, 772.077367545783, 775.2441369664589, 775.9728409505668, 776.3595034096865, 776.4254451705725, 813.9715109971153, 814.7067055859885, 815.559597817178, 815.6166601697192, 815.7797394703426, 637.6269882118966, 657.139147716493, 783.4124406694979, 803.7468197517821, 811.2455416462687, 587.9794207202727, 591.7130191856946, 592.0142961968318, 592.351375244107, 592.3661682000261, 12662.810057849047, 12711.237325760392, 12716.364181790967, 12726.745465090738, 12727.872721272854, 12317.384130793425, 12569.245845249223, 12619.810702839464, 12722.0, 12924.224546527239, 10473.31923424975, 10615.522301496374, 10726.946365268202, 10745.08666763326, 10786.406747628876, 4023.3964905264443, 4040.0909795296116, 4055.1484188320487, 4121.093359460914, 4124.8143833527565, 62228.688856555884, 62308.0, 62331.0, 62335.0, 62344.07731265568, 9470.242380609534, 9826.115649591427, 9842.65550705722, 9909.851352229722, 10302.484875756183, 18929.526761831065, 19017.714734278998, 19317.323893663655, 19629.411117666492, 19633.509162270773, 6329.430351268408, 6347.460465860361, 6518.250401203827, 6691.330866913269, 6821.249662537117, 3417.419038763416, 3439.673231043047, 3492.1269682579355, 3533.717302615785, 3644.507991421124, 2678.25008997481, 2764.226016715323, 2765.751082402553, 2768.0726956469407, 2768.9723102769117, 445.69692609026174, 456.1378993701906, 461.68836035675787, 465.5367908930568, 467.8269040454985, 537.1298496435799, 538.7010209333779, 553.5405613340918, 562.9465200805917, 582.2808831093596, 7366.8526629467115, 7488.438367122488, 7686.423518236154, 7841.2158784122275, 8070.677172913135, 489.44085840396593, 555.0730280431608, 569.3168198162222, 594.04655527878, 612.3111499562991, 3803.980980095082, 3856.8842934712, 3891.7081218908697, 4001.2597669430666, 4263.70154089217, 48771.756141219776, 49312.50687493079, 65589.67205164039, 66519.0, 69162.0, 45349.09301814011, 47893.76053119782, 59256.407435925954, 59278.70360648255, 60229.0, 53083.73458132685, 53923.0, 54681.45318546764, 55476.44523554713, 55728.72135639296, 7134.1795693495915, 7431.888521672071, 7445.329920307198, 7475.7009719610605, 7537.2085930976455, 31774.523382148825, 32595.18512037218, 33191.66808331886, 34661.65338346584, 37254.8137259312, 38516.0, 42661.57338426576, 47709.28436073531, 48224.75887620539, 50189.0, 10376.533056012648, 10859.34843909368, 10908.072813810915, 11329.943350283196, 11415.37215453158, 13013.544525941546, 13031.934840325737, 13060.08579399471, 13160.868391315964, 14051.297435128407, 9654.324197306121, 11910.761784764429, 11932.701682458008, 12064.698382540506, 12490.0, 11839.408029598659, 11975.64073077809, 12046.698832529257, 12087.516499339928, 12091.57679481214, 11535.134864885335, 11557.537698491966, 11703.122265829927, 12153.270803751802, 12480.625581232578, 9764.995924210169, 9842.557084931052, 10023.298369114093, 10176.49117544105, 10189.643362482575, 9418.199453046567, 9944.0, 9973.50132493387, 9991.600335986479, 10067.69796906094], "value": 6152.315412357825, "unit": "score"}], "name": "dromaeo_css", "value": 6102.934697543196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 120.0, 118.0, 117.0, 117.0, 115.0, 118.0, 115.0, 115.0, 117.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 136.0, 180.0, 139.0, 131.0, 129.0, 131.0, 149.0, 132.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 104.0, 77.0, 77.0, 76.0, 77.0, 97.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 83.0, 83.0, 83.0, 98.0, 83.0, 84.0, 120.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 104.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 92.0, 86.0, 91.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 143.0, 144.0, 144.0, 142.0, 144.0, 149.0, 180.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 180.0, 178.0, 182.0, 178.0, 178.0, 181.0, 180.0, 182.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 72.0, 73.0, 73.0, 71.0, 75.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1573.3000000000002, "alertThreshold": 2.0}]} 04:33:39 INFO - Return code: 0 04:33:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:39 INFO - # TBPL SUCCESS # 04:33:39 INFO - Running post-action listener: _resource_record_post_action 04:33:39 INFO - [mozharness: 2016-12-05 12:33:39.469831Z] Finished run-tests step (success) 04:33:39 INFO - Running post-run listener: _resource_record_post_run 04:33:39 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 393084928; Read time: 0; Write time: 206284 04:33:39 INFO - TinderboxPrint: CPU usage
13.1% 04:33:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:33:39 INFO - TinderboxPrint: I/O write bytes / time
393,084,928 / 206,284 04:33:39 INFO - TinderboxPrint: CPU idle
8,349.0 (86.9%) 04:33:39 INFO - TinderboxPrint: CPU user
1,209.5 (12.6%) 04:33:39 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99905536; Read time: 0; Write time: 71776 04:33:39 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293179392; Read time: 0; Write time: 134508 04:33:40 INFO - Running post-run listener: _upload_blobber_files 04:33:40 INFO - Blob upload gear active. 04:33:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:40 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'] 04:33:40 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 04:33:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:44 INFO - (blobuploader) - INFO - Done attempting. 04:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:44 INFO - (blobuploader) - INFO - Done attempting. 04:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:45 INFO - (blobuploader) - INFO - Done attempting. 04:33:45 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:45 INFO - Return code: 0 04:33:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/55c5aa922f4b6fbb034a9bdff8e5466c4a93af2a50b6b7cb36755cfb8b1ec030e0929acac6eb7956eb0ea171b43f75fe226f57d0b3ddb214290c04536a9f5005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad7471305e4ef703afab44eede1055af53a7d3ab64de269f1042129d69e445231a30372c11a48c8d703a20a8b36950d750338a334b918d2bf8f964f27df9cd0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bea9c66e246ee12c5f8b9227f3a69f8a1f2889ac510123afd96664e9ee0de55db93a9ef3d7052e6846c7a83aaa1fbab4bffd0b9542222a2304e92ac604917449"} 04:33:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:45 INFO - Contents: 04:33:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/55c5aa922f4b6fbb034a9bdff8e5466c4a93af2a50b6b7cb36755cfb8b1ec030e0929acac6eb7956eb0ea171b43f75fe226f57d0b3ddb214290c04536a9f5005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad7471305e4ef703afab44eede1055af53a7d3ab64de269f1042129d69e445231a30372c11a48c8d703a20a8b36950d750338a334b918d2bf8f964f27df9cd0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bea9c66e246ee12c5f8b9227f3a69f8a1f2889ac510123afd96664e9ee0de55db93a9ef3d7052e6846c7a83aaa1fbab4bffd0b9542222a2304e92ac604917449"} 04:33:45 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:45 INFO - Copying logs to upload dir... 04:33:45 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.198738 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-12-05 04:33:43.842301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 04:33:43.845956) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000 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/55c5aa922f4b6fbb034a9bdff8e5466c4a93af2a50b6b7cb36755cfb8b1ec030e0929acac6eb7956eb0ea171b43f75fe226f57d0b3ddb214290c04536a9f5005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad7471305e4ef703afab44eede1055af53a7d3ab64de269f1042129d69e445231a30372c11a48c8d703a20a8b36950d750338a334b918d2bf8f964f27df9cd0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bea9c66e246ee12c5f8b9227f3a69f8a1f2889ac510123afd96664e9ee0de55db93a9ef3d7052e6846c7a83aaa1fbab4bffd0b9542222a2304e92ac604917449"} build_url:https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/ArTDHHaRTjCdLBAmuocwuA/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/55c5aa922f4b6fbb034a9bdff8e5466c4a93af2a50b6b7cb36755cfb8b1ec030e0929acac6eb7956eb0ea171b43f75fe226f57d0b3ddb214290c04536a9f5005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ad7471305e4ef703afab44eede1055af53a7d3ab64de269f1042129d69e445231a30372c11a48c8d703a20a8b36950d750338a334b918d2bf8f964f27df9cd0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bea9c66e246ee12c5f8b9227f3a69f8a1f2889ac510123afd96664e9ee0de55db93a9ef3d7052e6846c7a83aaa1fbab4bffd0b9542222a2304e92ac604917449"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 04:33:43.871927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:33:43.872252) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480938854.383268-2057469000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 04:33:43.956385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 04:33:43.956724) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 04:33:43.957026) ========= ========= Total master_lag: 0.15 =========