builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1480329784.28 results: success (0) buildid: 20161128010700 builduid: 528e122e07e44a36bbfa17de85d66ba8 revision: 3c3cd985155f9a0c016b2087fce7a41482dfda5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.279108) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.279631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.279936) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.309384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.309665) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-28 02:43:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 309K=0.04s 2016-11-28 02:43:05 (309 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.287321 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.611198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.611549) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013946 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.661735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:04.662139) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 3c3cd985155f9a0c016b2087fce7a41482dfda5f --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 3c3cd985155f9a0c016b2087fce7a41482dfda5f --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=5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-28 02:43:05,832 truncating revision to first 12 chars 2016-11-28 02:43:05,832 Setting DEBUG logging. 2016-11-28 02:43:05,832 attempt 1/10 2016-11-28 02:43:05,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/3c3cd985155f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 02:43:06,397 unpacking tar archive at: graphics-3c3cd985155f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:05.559513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:05.559845) ========= script_repo_revision: 3c3cd985155f9a0c016b2087fce7a41482dfda5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:05.560256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:05.560545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 02:43:05.570278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-28 02:43:05.570691) ========= /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=5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:43:06 INFO - MultiFileLogger online at 20161128 02:43:06 in /builds/slave/test 02:43:06 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 02:43:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:43:06 INFO - {'append_to_log': False, 02:43:06 INFO - 'base_work_dir': '/builds/slave/test', 02:43:06 INFO - 'blob_upload_branch': 'Graphics', 02:43:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:43:06 INFO - 'branch': 'Graphics', 02:43:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:43:06 INFO - 'config_files': ('talos/linux_config.py',), 02:43:06 INFO - 'default_actions': ('clobber', 02:43:06 INFO - 'read-buildbot-config', 02:43:06 INFO - 'download-and-extract', 02:43:06 INFO - 'populate-webroot', 02:43:06 INFO - 'create-virtualenv', 02:43:06 INFO - 'install', 02:43:06 INFO - 'run-tests'), 02:43:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:43:06 INFO - 'download_minidump_stackwalk': True, 02:43:06 INFO - 'download_symbols': 'ondemand', 02:43:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:43:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:43:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:43:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:43:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:43:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:43:06 INFO - 'installer_path': 'installer.exe', 02:43:06 INFO - 'log_level': 'info', 02:43:06 INFO - 'log_name': 'talos', 02:43:06 INFO - 'log_to_console': True, 02:43:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:43:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:43:06 INFO - 'opt_config_files': (), 02:43:06 INFO - 'pip_index': False, 02:43:06 INFO - 'sps_profile': False, 02:43:06 INFO - 'sps_profile_interval': 0, 02:43:06 INFO - 'suite': 'dromaeojs', 02:43:06 INFO - 'system_bits': '32', 02:43:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:43:06 INFO - 'title': 'talos-linux64-ix-011', 02:43:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:43:06 INFO - 'use_talos_json': True, 02:43:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:43:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:43:06 INFO - 'work_dir': 'build'} 02:43:06 INFO - [mozharness: 2016-11-28 10:43:06.841611Z] Running clobber step. 02:43:06 INFO - Running pre-action listener: _resource_record_pre_action 02:43:06 INFO - Running main action method: clobber 02:43:06 INFO - rmtree: /builds/slave/test/build 02:43:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:43:07 INFO - Running post-action listener: _resource_record_post_action 02:43:07 INFO - [mozharness: 2016-11-28 10:43:07.302808Z] Finished clobber step (success) 02:43:07 INFO - [mozharness: 2016-11-28 10:43:07.302907Z] Running read-buildbot-config step. 02:43:07 INFO - Running pre-action listener: _resource_record_pre_action 02:43:07 INFO - Running main action method: read_buildbot_config 02:43:07 INFO - Using buildbot properties: 02:43:07 INFO - { 02:43:07 INFO - "project": "", 02:43:07 INFO - "product": "firefox", 02:43:07 INFO - "script_repo_revision": "default", 02:43:07 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 02:43:07 INFO - "repository": "", 02:43:07 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 02:43:07 INFO - "buildid": "20161128010700", 02:43:07 INFO - "pgo_build": "False", 02:43:07 INFO - "basedir": "/builds/slave/test", 02:43:07 INFO - "buildnumber": 12, 02:43:07 INFO - "slavename": "talos-linux64-ix-011", 02:43:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:43:07 INFO - "platform": "ubuntu64_hw", 02:43:07 INFO - "scheduler": "tests-graphics-linux64-talos", 02:43:07 INFO - "branch": "graphics", 02:43:07 INFO - "repo_path": "projects/graphics", 02:43:07 INFO - "revision": "3c3cd985155f9a0c016b2087fce7a41482dfda5f", 02:43:07 INFO - "stage_platform": "linux64", 02:43:07 INFO - "builduid": "528e122e07e44a36bbfa17de85d66ba8", 02:43:07 INFO - "slavebuilddir": "test" 02:43:07 INFO - } 02:43:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 02:43:07 INFO - Running post-action listener: _resource_record_post_action 02:43:07 INFO - [mozharness: 2016-11-28 10:43:07.305334Z] Finished read-buildbot-config step (success) 02:43:07 INFO - [mozharness: 2016-11-28 10:43:07.305423Z] Running download-and-extract step. 02:43:07 INFO - Running pre-action listener: _resource_record_pre_action 02:43:07 INFO - Running main action method: download_and_extract 02:43:07 INFO - mkdir: /builds/slave/test/build/tests 02:43:07 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')]} 02:43:07 INFO - trying https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:43:07 INFO - Downloading https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/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 02:43:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/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 02:43:07 INFO - Downloaded 1361 bytes. 02:43:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:43:07 INFO - Using the following test package requirements: 02:43:07 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:43:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:43:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:43:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'jsshell-linux-x86_64.zip'], 02:43:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:43:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:43:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:43:07 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:43:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:43:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:43:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:43:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:43:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:43:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:43:07 INFO - Fetch https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:43:08 INFO - Http code: 200 02:43:08 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 02:43:08 INFO - x-amz-cf-id: 6nLeGF9cD0ajYm4JBkxG7RYKaystf2g2hqhE9TZVxQNnFLuagP0Wlg== 02:43:08 INFO - x-amz-version-id: _rnAqg7oWSfxtzM1_8rGlc1SKvYRSb.U 02:43:09 INFO - Expected file size: 20217576 02:43:09 INFO - Obtained file size: 20217576 02:43:13 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 02:43:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:43:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:43:13 INFO - Fetch https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:43:14 INFO - Http code: 200 02:43:14 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 02:43:14 INFO - x-amz-cf-id: w48R6lL9CbYkfnZheHxuUKSW93Aw_G_EFca9cOMPB_nIEcGchuLWUQ== 02:43:14 INFO - x-amz-version-id: _rnAqg7oWSfxtzM1_8rGlc1SKvYRSb.U 02:43:17 INFO - Expected file size: 20217576 02:43:17 INFO - Obtained file size: 20217576 02:43:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 02:43:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:43:21 INFO - Fetch https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:43:22 INFO - Http code: 200 02:43:22 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 02:43:22 INFO - x-amz-cf-id: 0GUOtSmLbA9xK9yuoNXkVBpYaa8xa6h43EtIF94BeXsqc72i-Lr7IA== 02:43:22 INFO - x-amz-version-id: jHcwoNIeHs_2cTedexe1mUFSjmFfmR10 02:43:25 INFO - Expected file size: 14409702 02:43:25 INFO - Obtained file size: 14409702 02:43:25 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')]} 02:43:25 INFO - trying https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:43:25 INFO - Downloading https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/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 02:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/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 02:43:38 INFO - Downloaded 55688640 bytes. 02:43:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:43:38 INFO - mkdir: /builds/slave/test/properties 02:43:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:43:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:43:38 INFO - Contents: 02:43:38 INFO - build_url:https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:43:40 INFO - Running post-action listener: _resource_record_post_action 02:43:40 INFO - Running post-action listener: set_extra_try_arguments 02:43:40 INFO - [mozharness: 2016-11-28 10:43:40.082248Z] Finished download-and-extract step (success) 02:43:40 INFO - [mozharness: 2016-11-28 10:43:40.082475Z] Running populate-webroot step. 02:43:40 INFO - Running pre-action listener: _resource_record_pre_action 02:43:40 INFO - Running main action method: populate_webroot 02:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:43:40 INFO - '--tppagecycles', 02:43:40 INFO - '7'], 02:43:40 INFO - 'tests': ['tsvgm']}}, 02:43:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:43:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:43:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:43:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:43:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:43:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:43:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['damp', 'tps']}, 02:43:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'tests': ['damp', 'tps']}, 02:43:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['dromaeo_dom']}, 02:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:43:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['basic_compositor_video']}, 02:43:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:43:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['a11yr', 02:43:40 INFO - 'ts_paint', 02:43:40 INFO - 'tpaint', 02:43:40 INFO - 'sessionrestore', 02:43:40 INFO - 'sessionrestore_no_auto_restore', 02:43:40 INFO - 'tabpaint']}, 02:43:40 INFO - 'other-e10s': {'tests': ['a11yr', 02:43:40 INFO - 'ts_paint', 02:43:40 INFO - 'tpaint', 02:43:40 INFO - 'sessionrestore', 02:43:40 INFO - 'sessionrestore_no_auto_restore', 02:43:40 INFO - 'tabpaint']}, 02:43:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:43:40 INFO - 'ts_paint', 02:43:40 INFO - 'tpaint', 02:43:40 INFO - 'sessionrestore', 02:43:40 INFO - 'sessionrestore_no_auto_restore', 02:43:40 INFO - 'tabpaint']}, 02:43:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:43:40 INFO - 'ts_paint', 02:43:40 INFO - 'tpaint', 02:43:40 INFO - 'sessionrestore', 02:43:40 INFO - 'sessionrestore_no_auto_restore', 02:43:40 INFO - 'tabpaint']}, 02:43:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['a11yr', 02:43:40 INFO - 'ts_paint', 02:43:40 INFO - 'tpaint', 02:43:40 INFO - 'sessionrestore', 02:43:40 INFO - 'sessionrestore_no_auto_restore', 02:43:40 INFO - 'tabpaint']}, 02:43:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['a11yr', 02:43:40 INFO - 'ts_paint', 02:43:40 INFO - 'tpaint', 02:43:40 INFO - 'sessionrestore', 02:43:40 INFO - 'sessionrestore_no_auto_restore', 02:43:40 INFO - 'tabpaint']}, 02:43:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['tsvgx', 02:43:40 INFO - 'tsvgr_opacity', 02:43:40 INFO - 'tart', 02:43:40 INFO - 'tscrollx', 02:43:40 INFO - 'cart', 02:43:40 INFO - 'tsvg_static']}, 02:43:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:43:40 INFO - 'tsvgr_opacity', 02:43:40 INFO - 'tart', 02:43:40 INFO - 'tscrollx', 02:43:40 INFO - 'cart', 02:43:40 INFO - 'tsvg_static']}, 02:43:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'talos_options': ['--disable-e10s'], 02:43:40 INFO - 'tests': ['tp5o']}, 02:43:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:43:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'talos_options': ['--disable-e10s', 02:43:40 INFO - '--xperf_path', 02:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:43:40 INFO - 'tests': ['tp5n']}, 02:43:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:43:40 INFO - 'talos_options': ['--xperf_path', 02:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:43:40 INFO - 'tests': ['tp5n']}}, 02:43:40 INFO - 'talos.zip': {'path': '', 02:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:43:40 INFO - Running post-action listener: _resource_record_post_action 02:43:40 INFO - [mozharness: 2016-11-28 10:43:40.102778Z] Finished populate-webroot step (success) 02:43:40 INFO - [mozharness: 2016-11-28 10:43:40.102866Z] Running create-virtualenv step. 02:43:40 INFO - Running pre-action listener: _resource_record_pre_action 02:43:40 INFO - Running main action method: create_virtualenv 02:43:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:43:40 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 02:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:43:40 INFO - Using real prefix '/usr' 02:43:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:43:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:43:42 INFO - Installing pip.................done. 02:43:42 INFO - Return code: 0 02:43:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:43:42 INFO - Reading from file tmpfile_stdout 02:43:42 INFO - Output received: 02:43:42 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) 02:43:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:43:42 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')]} 02:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:42 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')]} 02:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:43 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:43 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 02:43:43 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 02:43:43 INFO - Using env: {'DISPLAY': ':0', 02:43:43 INFO - 'HOME': '/home/cltbld', 02:43:43 INFO - 'LANG': 'en_US.UTF-8', 02:43:43 INFO - 'LANGUAGE': 'en_US:en', 02:43:43 INFO - 'LOGNAME': 'cltbld', 02:43:43 INFO - 'MAIL': '/var/mail/cltbld', 02:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:43 INFO - 'MOZ_NO_REMOTE': '1', 02:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:43 INFO - 'NO_EM_RESTART': '1', 02:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:43 INFO - 'PWD': '/builds/slave/test', 02:43:43 INFO - 'SHELL': '/bin/bash', 02:43:43 INFO - 'SHLVL': '1', 02:43:43 INFO - 'TERM': 'linux', 02:43:43 INFO - 'TMOUT': '86400', 02:43:43 INFO - 'USER': 'cltbld', 02:43:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:43 INFO - '_': '/tools/buildbot/bin/python'} 02:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:43 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 02:43:43 INFO - Cleaning up... 02:43:43 INFO - Return code: 0 02:43:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:43:43 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')]} 02:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:43 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')]} 02:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:43 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:43 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 02:43:43 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 02:43:43 INFO - Using env: {'DISPLAY': ':0', 02:43:43 INFO - 'HOME': '/home/cltbld', 02:43:43 INFO - 'LANG': 'en_US.UTF-8', 02:43:43 INFO - 'LANGUAGE': 'en_US:en', 02:43:43 INFO - 'LOGNAME': 'cltbld', 02:43:43 INFO - 'MAIL': '/var/mail/cltbld', 02:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:43 INFO - 'MOZ_NO_REMOTE': '1', 02:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:43 INFO - 'NO_EM_RESTART': '1', 02:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:43 INFO - 'PWD': '/builds/slave/test', 02:43:43 INFO - 'SHELL': '/bin/bash', 02:43:43 INFO - 'SHLVL': '1', 02:43:43 INFO - 'TERM': 'linux', 02:43:43 INFO - 'TMOUT': '86400', 02:43:43 INFO - 'USER': 'cltbld', 02:43:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:43 INFO - '_': '/tools/buildbot/bin/python'} 02:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:43 INFO - Downloading/unpacking psutil>=3.1.1 02:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:46 INFO - Installing collected packages: psutil 02:43:46 INFO - Running setup.py install for psutil 02:43:46 INFO - building 'psutil._psutil_linux' extension 02:43:46 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 02:43:46 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 02:43:46 INFO - building 'psutil._psutil_posix' extension 02:43:46 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 02:43:46 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 02:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:46 INFO - Successfully installed psutil 02:43:46 INFO - Cleaning up... 02:43:46 INFO - Return code: 0 02:43:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:43:46 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')]} 02:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:46 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')]} 02:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:46 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:46 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 02:43:46 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 02:43:46 INFO - Using env: {'DISPLAY': ':0', 02:43:46 INFO - 'HOME': '/home/cltbld', 02:43:46 INFO - 'LANG': 'en_US.UTF-8', 02:43:46 INFO - 'LANGUAGE': 'en_US:en', 02:43:46 INFO - 'LOGNAME': 'cltbld', 02:43:46 INFO - 'MAIL': '/var/mail/cltbld', 02:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:46 INFO - 'MOZ_NO_REMOTE': '1', 02:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:46 INFO - 'NO_EM_RESTART': '1', 02:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:46 INFO - 'PWD': '/builds/slave/test', 02:43:46 INFO - 'SHELL': '/bin/bash', 02:43:46 INFO - 'SHLVL': '1', 02:43:46 INFO - 'TERM': 'linux', 02:43:46 INFO - 'TMOUT': '86400', 02:43:46 INFO - 'USER': 'cltbld', 02:43:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:46 INFO - '_': '/tools/buildbot/bin/python'} 02:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:43:47 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 02:43:47 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 02:43:47 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 02:43:47 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 02:43:47 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 02:43:47 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 02:43:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:43:51 INFO - Installing collected packages: mozsystemmonitor 02:43:51 INFO - Running setup.py install for mozsystemmonitor 02:43:51 INFO - Successfully installed mozsystemmonitor 02:43:51 INFO - Cleaning up... 02:43:51 INFO - Return code: 0 02:43:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:43: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')]} 02:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43: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')]} 02:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:43:51 INFO - Using env: {'DISPLAY': ':0', 02:43:51 INFO - 'HOME': '/home/cltbld', 02:43:51 INFO - 'LANG': 'en_US.UTF-8', 02:43:51 INFO - 'LANGUAGE': 'en_US:en', 02:43:51 INFO - 'LOGNAME': 'cltbld', 02:43:51 INFO - 'MAIL': '/var/mail/cltbld', 02:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:51 INFO - 'MOZ_NO_REMOTE': '1', 02:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:51 INFO - 'NO_EM_RESTART': '1', 02:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:51 INFO - 'PWD': '/builds/slave/test', 02:43:51 INFO - 'SHELL': '/bin/bash', 02:43:51 INFO - 'SHLVL': '1', 02:43:51 INFO - 'TERM': 'linux', 02:43:51 INFO - 'TMOUT': '86400', 02:43:51 INFO - 'USER': 'cltbld', 02:43:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:51 INFO - '_': '/tools/buildbot/bin/python'} 02:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:51 INFO - Downloading/unpacking jsonschema==2.5.1 02:43:51 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 02:43:51 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 02:43:51 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 02:43:51 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 02:43:51 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 02:43:51 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 02:43:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:43:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:43:54 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 02:43:54 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 02:43:54 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 02:43:54 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 02:43:54 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 02:43:54 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 02:43:54 INFO - Downloading functools32-3.2.3-2.tar.gz 02:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:43:54 INFO - warning: no files found matching '*.txt' 02:43:54 INFO - no previously-included directories found matching 'build' 02:43:54 INFO - no previously-included directories found matching 'dist' 02:43:54 INFO - no previously-included directories found matching '.git*' 02:43:54 INFO - Installing collected packages: jsonschema, functools32 02:43:54 INFO - Running setup.py install for functools32 02:43:54 INFO - warning: no files found matching '*.txt' 02:43:54 INFO - no previously-included directories found matching 'build' 02:43:54 INFO - no previously-included directories found matching 'dist' 02:43:54 INFO - no previously-included directories found matching '.git*' 02:43:54 INFO - Successfully installed jsonschema functools32 02:43:54 INFO - Cleaning up... 02:43:54 INFO - Return code: 0 02:43:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:43:54 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')]} 02:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:54 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')]} 02:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:54 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:54 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 02:43:54 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 02:43:54 INFO - Using env: {'DISPLAY': ':0', 02:43:54 INFO - 'HOME': '/home/cltbld', 02:43:54 INFO - 'LANG': 'en_US.UTF-8', 02:43:54 INFO - 'LANGUAGE': 'en_US:en', 02:43:54 INFO - 'LOGNAME': 'cltbld', 02:43:54 INFO - 'MAIL': '/var/mail/cltbld', 02:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:54 INFO - 'MOZ_NO_REMOTE': '1', 02:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:54 INFO - 'NO_EM_RESTART': '1', 02:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:54 INFO - 'PWD': '/builds/slave/test', 02:43:54 INFO - 'SHELL': '/bin/bash', 02:43:54 INFO - 'SHLVL': '1', 02:43:54 INFO - 'TERM': 'linux', 02:43:54 INFO - 'TMOUT': '86400', 02:43:54 INFO - 'USER': 'cltbld', 02:43:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:54 INFO - '_': '/tools/buildbot/bin/python'} 02:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:43:54 INFO - Cleaning up... 02:43:54 INFO - Return code: 0 02:43:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:43:54 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')]} 02:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:54 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')]} 02:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:55 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:55 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 02:43:55 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 02:43:55 INFO - Using env: {'DISPLAY': ':0', 02:43:55 INFO - 'HOME': '/home/cltbld', 02:43:55 INFO - 'LANG': 'en_US.UTF-8', 02:43:55 INFO - 'LANGUAGE': 'en_US:en', 02:43:55 INFO - 'LOGNAME': 'cltbld', 02:43:55 INFO - 'MAIL': '/var/mail/cltbld', 02:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:55 INFO - 'MOZ_NO_REMOTE': '1', 02:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:55 INFO - 'NO_EM_RESTART': '1', 02:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:55 INFO - 'PWD': '/builds/slave/test', 02:43:55 INFO - 'SHELL': '/bin/bash', 02:43:55 INFO - 'SHLVL': '1', 02:43:55 INFO - 'TERM': 'linux', 02:43:55 INFO - 'TMOUT': '86400', 02:43:55 INFO - 'USER': 'cltbld', 02:43:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:55 INFO - '_': '/tools/buildbot/bin/python'} 02:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:55 INFO - Downloading/unpacking blobuploader==1.2.4 02:43:55 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 02:43:55 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 02:43:55 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 02:43:55 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 02:43:55 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 02:43:55 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 02:43:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:43:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:43:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 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 02:43:58 INFO - Downloading docopt-0.6.1.tar.gz 02:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:43:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:43:58 INFO - Running setup.py install for blobuploader 02:43:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:43:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:43:58 INFO - Running setup.py install for requests 02:43:59 INFO - Running setup.py install for docopt 02:43:59 INFO - Successfully installed blobuploader requests docopt 02:43:59 INFO - Cleaning up... 02:43:59 INFO - Return code: 0 02:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:59 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')]} 02:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:59 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')]} 02:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:59 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:43:59 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 02:43:59 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 02:43:59 INFO - Using env: {'DISPLAY': ':0', 02:43:59 INFO - 'HOME': '/home/cltbld', 02:43:59 INFO - 'LANG': 'en_US.UTF-8', 02:43:59 INFO - 'LANGUAGE': 'en_US:en', 02:43:59 INFO - 'LOGNAME': 'cltbld', 02:43:59 INFO - 'MAIL': '/var/mail/cltbld', 02:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:59 INFO - 'MOZ_NO_REMOTE': '1', 02:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:43:59 INFO - 'NO_EM_RESTART': '1', 02:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:59 INFO - 'PWD': '/builds/slave/test', 02:43:59 INFO - 'SHELL': '/bin/bash', 02:43:59 INFO - 'SHLVL': '1', 02:43:59 INFO - 'TERM': 'linux', 02:43:59 INFO - 'TMOUT': '86400', 02:43:59 INFO - 'USER': 'cltbld', 02:43:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:59 INFO - '_': '/tools/buildbot/bin/python'} 02:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:59 INFO - Running setup.py (path:/tmp/pip-cjWbbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:59 INFO - Running setup.py (path:/tmp/pip-xA6qyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:00 INFO - Running setup.py (path:/tmp/pip-uYZCL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:00 INFO - Running setup.py (path:/tmp/pip-TUDIjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:00 INFO - Running setup.py (path:/tmp/pip-ojfaqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:00 INFO - Running setup.py (path:/tmp/pip-OiJxRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:00 INFO - Running setup.py (path:/tmp/pip-flTKon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:00 INFO - Running setup.py (path:/tmp/pip-POX4yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:00 INFO - Running setup.py (path:/tmp/pip-m_Hk0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:00 INFO - Running setup.py (path:/tmp/pip-TNo2tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:00 INFO - Running setup.py (path:/tmp/pip-SlsMaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:00 INFO - Running setup.py (path:/tmp/pip-O3uGyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:00 INFO - Running setup.py (path:/tmp/pip-NBBC2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:00 INFO - Running setup.py (path:/tmp/pip-y7KkF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:00 INFO - Running setup.py (path:/tmp/pip-GgD3RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:00 INFO - Running setup.py (path:/tmp/pip-NTBfb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:01 INFO - Running setup.py (path:/tmp/pip-pG4GxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:01 INFO - Running setup.py install for manifestparser 02:44:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Running setup.py install for mozcrash 02:44:01 INFO - Running setup.py install for mozdebug 02:44:01 INFO - Running setup.py install for mozdevice 02:44:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Running setup.py install for mozfile 02:44:01 INFO - Running setup.py install for mozhttpd 02:44:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Running setup.py install for mozinfo 02:44:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Running setup.py install for mozInstall 02:44:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:01 INFO - Running setup.py install for mozleak 02:44:02 INFO - Running setup.py install for mozlog 02:44:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Running setup.py install for moznetwork 02:44:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Running setup.py install for mozprocess 02:44:02 INFO - Running setup.py install for mozprofile 02:44:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Running setup.py install for mozrunner 02:44:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Running setup.py install for mozscreenshot 02:44:02 INFO - Running setup.py install for moztest 02:44:02 INFO - Running setup.py install for mozversion 02:44:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:44:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:44:02 INFO - Cleaning up... 02:44:02 INFO - Return code: 0 02:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:02 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')]} 02:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:02 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')]} 02:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:03 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:44:03 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 02:44:03 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 02:44:03 INFO - Using env: {'DISPLAY': ':0', 02:44:03 INFO - 'HOME': '/home/cltbld', 02:44:03 INFO - 'LANG': 'en_US.UTF-8', 02:44:03 INFO - 'LANGUAGE': 'en_US:en', 02:44:03 INFO - 'LOGNAME': 'cltbld', 02:44:03 INFO - 'MAIL': '/var/mail/cltbld', 02:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:03 INFO - 'MOZ_NO_REMOTE': '1', 02:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:03 INFO - 'NO_EM_RESTART': '1', 02:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:03 INFO - 'PWD': '/builds/slave/test', 02:44:03 INFO - 'SHELL': '/bin/bash', 02:44:03 INFO - 'SHLVL': '1', 02:44:03 INFO - 'TERM': 'linux', 02:44:03 INFO - 'TMOUT': '86400', 02:44:03 INFO - 'USER': 'cltbld', 02:44:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:03 INFO - '_': '/tools/buildbot/bin/python'} 02:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:03 INFO - Running setup.py (path:/tmp/pip-YETrb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:03 INFO - Running setup.py (path:/tmp/pip-FCbIqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:03 INFO - Running setup.py (path:/tmp/pip-q6VwuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:03 INFO - Running setup.py (path:/tmp/pip-sOpXuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:03 INFO - Running setup.py (path:/tmp/pip-feKLEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:03 INFO - Running setup.py (path:/tmp/pip-fr698m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:03 INFO - Running setup.py (path:/tmp/pip-7ZkdXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:03 INFO - Running setup.py (path:/tmp/pip-6X9kwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:03 INFO - Running setup.py (path:/tmp/pip-CVXcI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:03 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)) 02:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:03 INFO - Running setup.py (path:/tmp/pip-d1cbGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:04 INFO - Running setup.py (path:/tmp/pip-F_jjXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:04 INFO - Running setup.py (path:/tmp/pip-sO0qFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:04 INFO - Running setup.py (path:/tmp/pip-WUjyVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:04 INFO - Running setup.py (path:/tmp/pip-BFISXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:04 INFO - Running setup.py (path:/tmp/pip-y6qGpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:04 INFO - Running setup.py (path:/tmp/pip-xnuA3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:04 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)) 02:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:04 INFO - Running setup.py (path:/tmp/pip-ex7Z2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:04 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)) 02:44:04 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)) 02:44:04 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)) 02:44:04 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)) 02:44:04 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)) 02:44:04 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)) 02:44:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:09 INFO - Downloading blessings-1.6.tar.gz 02:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:44:09 INFO - Installing collected packages: blessings 02:44:09 INFO - Running setup.py install for blessings 02:44:09 INFO - Successfully installed blessings 02:44:09 INFO - Cleaning up... 02:44:09 INFO - Return code: 0 02:44:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:09 INFO - Reading from file tmpfile_stdout 02:44:09 INFO - Current package versions: 02:44:09 INFO - argparse == 1.2.1 02:44:09 INFO - blessings == 1.6 02:44:09 INFO - blobuploader == 1.2.4 02:44:09 INFO - docopt == 0.6.1 02:44:09 INFO - functools32 == 3.2.3-2 02:44:09 INFO - jsonschema == 2.5.1 02:44:09 INFO - manifestparser == 1.1 02:44:09 INFO - mozInstall == 1.12 02:44:09 INFO - mozcrash == 1.0 02:44:09 INFO - mozdebug == 0.1 02:44:09 INFO - mozdevice == 0.49 02:44:09 INFO - mozfile == 1.2 02:44:09 INFO - mozhttpd == 0.7 02:44:09 INFO - mozinfo == 0.9 02:44:09 INFO - mozleak == 0.1 02:44:09 INFO - mozlog == 3.4 02:44:09 INFO - moznetwork == 0.27 02:44:09 INFO - mozprocess == 0.23 02:44:09 INFO - mozprofile == 0.28 02:44:09 INFO - mozrunner == 6.13 02:44:09 INFO - mozscreenshot == 0.1 02:44:09 INFO - mozsystemmonitor == 0.3 02:44:09 INFO - moztest == 0.7 02:44:09 INFO - mozversion == 1.4 02:44:09 INFO - psutil == 3.1.1 02:44:09 INFO - requests == 1.2.3 02:44:09 INFO - wsgiref == 0.1.2 02:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:09 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:44:09 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 02:44:09 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 02:44:09 INFO - Using env: {'DISPLAY': ':0', 02:44:09 INFO - 'HOME': '/home/cltbld', 02:44:09 INFO - 'LANG': 'en_US.UTF-8', 02:44:09 INFO - 'LANGUAGE': 'en_US:en', 02:44:09 INFO - 'LOGNAME': 'cltbld', 02:44:09 INFO - 'MAIL': '/var/mail/cltbld', 02:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:09 INFO - 'MOZ_NO_REMOTE': '1', 02:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:09 INFO - 'NO_EM_RESTART': '1', 02:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:09 INFO - 'PWD': '/builds/slave/test', 02:44:09 INFO - 'SHELL': '/bin/bash', 02:44:09 INFO - 'SHLVL': '1', 02:44:09 INFO - 'TERM': 'linux', 02:44:09 INFO - 'TMOUT': '86400', 02:44:09 INFO - 'USER': 'cltbld', 02:44:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:09 INFO - '_': '/tools/buildbot/bin/python'} 02:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 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)) 02:44:10 INFO - Cleaning up... 02:44:10 INFO - Return code: 0 02:44:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:44:10 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')]} 02:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:10 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')]} 02:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:10 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 0x7f0409c11e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', '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 02:44:10 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 02:44:10 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 02:44:10 INFO - Using env: {'DISPLAY': ':0', 02:44:10 INFO - 'HOME': '/home/cltbld', 02:44:10 INFO - 'LANG': 'en_US.UTF-8', 02:44:10 INFO - 'LANGUAGE': 'en_US:en', 02:44:10 INFO - 'LOGNAME': 'cltbld', 02:44:10 INFO - 'MAIL': '/var/mail/cltbld', 02:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:10 INFO - 'MOZ_NO_REMOTE': '1', 02:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:10 INFO - 'NO_EM_RESTART': '1', 02:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:10 INFO - 'PWD': '/builds/slave/test', 02:44:10 INFO - 'SHELL': '/bin/bash', 02:44:10 INFO - 'SHLVL': '1', 02:44:10 INFO - 'TERM': 'linux', 02:44:10 INFO - 'TMOUT': '86400', 02:44:10 INFO - 'USER': 'cltbld', 02:44:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:10 INFO - '_': '/tools/buildbot/bin/python'} 02:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:44:10 INFO - Cleaning up... 02:44:10 INFO - Return code: 0 02:44:10 INFO - Running post-action listener: _resource_record_post_action 02:44:10 INFO - Running post-action listener: _start_resource_monitoring 02:44:10 INFO - Starting resource monitoring. 02:44:10 INFO - [mozharness: 2016-11-28 10:44:10.686801Z] Finished create-virtualenv step (success) 02:44:10 INFO - [mozharness: 2016-11-28 10:44:10.687323Z] Running install step. 02:44:10 INFO - Running pre-action listener: _resource_record_pre_action 02:44:10 INFO - Running main action method: install 02:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:10 INFO - Reading from file tmpfile_stdout 02:44:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:44:10 INFO - Reading from file tmpfile_stdout 02:44:10 INFO - Output received: 02:44:10 INFO - Usage: mozinstall [options] installer 02:44:10 INFO - Options: 02:44:10 INFO - -h, --help show this help message and exit 02:44:10 INFO - -d DEST, --destination=DEST 02:44:10 INFO - Directory to install application into. [default: 02:44:10 INFO - "/builds/slave/test"] 02:44:10 INFO - --app=APP Application being installed. [default: firefox] 02:44:10 INFO - mkdir: /builds/slave/test/build/application 02:44:10 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'] 02:44:10 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 02:44:27 INFO - Reading from file tmpfile_stdout 02:44:27 INFO - Output received: 02:44:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:44:27 INFO - Running post-action listener: _resource_record_post_action 02:44:27 INFO - [mozharness: 2016-11-28 10:44:27.031735Z] Finished install step (success) 02:44:27 INFO - [mozharness: 2016-11-28 10:44:27.031977Z] Running run-tests step. 02:44:27 INFO - Running pre-action listener: _resource_record_pre_action 02:44:27 INFO - Running main action method: run_tests 02:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:44:27 INFO - Python 2.7.3 02:44:27 INFO - Return code: 0 02:44:27 INFO - grabbing minidump binary from tooltool 02:44: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')]} 02:44:27 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 0x1c41fc0>, '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 0x1c42ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c43350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:44:27 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 02:44:27 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 02:44:27 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 02:44:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:44:27 INFO - Return code: 0 02:44:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:44:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:44:27 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/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 02:44:27 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/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 02:44:27 INFO - Using env: {'DISPLAY': ':0', 02:44:27 INFO - 'HOME': '/home/cltbld', 02:44:27 INFO - 'LANG': 'en_US.UTF-8', 02:44:27 INFO - 'LANGUAGE': 'en_US:en', 02:44:27 INFO - 'LOGNAME': 'cltbld', 02:44:27 INFO - 'MAIL': '/var/mail/cltbld', 02:44:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:44:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:27 INFO - 'MOZ_NO_REMOTE': '1', 02:44:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:27 INFO - 'NO_EM_RESTART': '1', 02:44:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:27 INFO - 'PWD': '/builds/slave/test', 02:44:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:44:27 INFO - 'SHELL': '/bin/bash', 02:44:27 INFO - 'SHLVL': '1', 02:44:27 INFO - 'TERM': 'linux', 02:44:27 INFO - 'TMOUT': '86400', 02:44:27 INFO - 'USER': 'cltbld', 02:44:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922', 02:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:27 INFO - '_': '/tools/buildbot/bin/python'} 02:44:27 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/F5g7bqeFRWGkfjFzEqQYHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 02:44:27 INFO - mozversion application_buildid: 20161128010700 02:44:27 INFO - mozversion application_changeset: 3c3cd985155f9a0c016b2087fce7a41482dfda5f 02:44:27 INFO - mozversion application_display_name: Nightly 02:44:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:44:27 INFO - mozversion application_name: Firefox 02:44:27 INFO - mozversion application_remotingname: firefox 02:44:27 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 02:44:27 INFO - mozversion application_vendor: Mozilla 02:44:27 INFO - mozversion application_version: 53.0a1 02:44:27 INFO - mozversion platform_buildid: 20161128010700 02:44:27 INFO - mozversion platform_changeset: 3c3cd985155f9a0c016b2087fce7a41482dfda5f 02:44:27 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 02:44:27 INFO - mozversion platform_version: 53.0a1 02:44:27 INFO - using testdate: 1480329867 02:44:27 INFO - actual date: 1480329867 02:44:27 INFO - starting webserver on 'localhost:41557' 02:44:27 INFO - SUITE-START | Running 2 tests 02:44:27 INFO - TEST-START | dromaeo_css 02:44:27 INFO - operating with platform_type : linux_ 02:44:27 INFO - Initialising browser for dromaeo_css test... 02:44:27 INFO - TEST-INFO | started process 28589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe9jNxP/profile http://localhost:41557/getInfo.html) 02:44:32 INFO - PROCESS | 28589 | __metrics Screen width/height:1600/1200 02:44:32 INFO - PROCESS | 28589 | colorDepth:24 02:44:32 INFO - PROCESS | 28589 | Browser inner width/height: 1024/697 02:44:32 INFO - PROCESS | 28589 | __metrics 02:44:33 INFO - PROCESS | 28589 | 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" 02:44:33 INFO - PROCESS | 28589 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:44:33 INFO - PROCESS | 28589 | console.error: PushService: 02:44:33 INFO - PROCESS | 28589 | stateChangeProcessEnqueue: Error transitioning state 02:44:33 INFO - PROCESS | 28589 | UnknownError 02:44:34 INFO - TEST-INFO | 28589: exit 0 02:44:34 INFO - Browser initialized. 02:44:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:44:34 INFO - TEST-INFO | started process 28671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe9jNxP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:44:46 INFO - PROCESS | 28671 | RSS: Main: 174825472 02:44:46 INFO - PROCESS | 28671 | 02:45:37 INFO - PROCESS | 28671 | 1480329937704 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] 02:47:51 INFO - PROCESS | 28671 | Cycle 1(1): loaded http://localhost:41557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41557/tests/dromaeo/cssquery-ext.html) 02:47:53 INFO - PROCESS | 28671 | RSS: Main: 314331136 02:47:53 INFO - PROCESS | 28671 | 02:50:55 INFO - PROCESS | 28671 | Cycle 1(1): loaded http://localhost:41557/tests/dromaeo/cssquery-ext.html (next: http://localhost:41557/tests/dromaeo/cssquery-jquery.html) 02:50:56 INFO - PROCESS | 28671 | RSS: Main: 285233152 02:50:56 INFO - PROCESS | 28671 | 02:53:58 INFO - PROCESS | 28671 | Cycle 1(1): loaded http://localhost:41557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41557/tests/dromaeo/cssquery-mootools.html) 02:53:59 INFO - PROCESS | 28671 | RSS: Main: 219328512 02:53:59 INFO - PROCESS | 28671 | 02:57:01 INFO - PROCESS | 28671 | Cycle 1(1): loaded http://localhost:41557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41557/tests/dromaeo/cssquery-prototype.html) 02:57:02 INFO - PROCESS | 28671 | RSS: Main: 226922496 02:57:02 INFO - PROCESS | 28671 | 03:00:05 INFO - PROCESS | 28671 | Cycle 1(1): loaded http://localhost:41557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41557/tests/dromaeo/cssquery-yui.html) 03:00:05 INFO - PROCESS | 28671 | RSS: Main: 225959936 03:00:05 INFO - PROCESS | 28671 | 03:03:08 INFO - PROCESS | 28671 | Cycle 1(1): loaded http://localhost:41557/tests/dromaeo/cssquery-yui.html (next: http://localhost:41557/tests/dromaeo/cssquery-dojo.html) 03:03:09 INFO - PROCESS | 28671 | RSS: Main: 317399040 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | __start_tp_report 03:03:09 INFO - PROCESS | 28671 | _x_x_mozilla_page_load 03:03:09 INFO - PROCESS | 28671 | _x_x_mozilla_page_load_details 03:03:09 INFO - PROCESS | 28671 | |i|pagename|runs| 03:03:09 INFO - PROCESS | 28671 | |0;dojo.html;2584.27640260727;2620.908268210613;2627.343164208947;2646.642703235064;2655.6016597510384;4564.543545645433;4614.861554153373;4689.273162659784;4695.295705644151;4699.694519856212;4606.286025666027;4611.884702882421;4618.676692631517;4649.953500464994;4674.672772905898;4248.34150706641;4250.27745283301;4291.077418355053;4338.262495375778;4411.029573493826;4294.441722576061;4357.7603231822395;4371.934420983688;4382.364557139213;4437.534058923815;4225.070484493437;4257.169851878885;4314.956850431487;4366.08312254427;4403.955960440387;4253.702240843142;4286.39990401344;4290.528041915387;4311.719738217006;4370.2133615949115;4295.613394794453;4297.312430011183;4304.203722311382;4315.8057887394825;4354.629856462205;4639.979204575022;4676.812927482896;4678.415198100238;4682.8126874924965;4699.342092107107;4851.466338702739;4891.1195984722735;4891.1685013547785;4962.801487940478;5005.449400565934;5034.89930201394;5035.571976382012;5061.342025536656;5071.264666623319;5072.873178170538;4689.624830013625;4695.929561056587;4701.3888194535175;4704.29435584665;4738.763061846894;4922.827701030446;5144.2283657450935;5152.742362881841;5162.406323272871;5213.478652134832;4739.95260047402;4838.95161048385;4869.561739443467;4943.876403089952;4957.628177886673;5011.398632164163;5012.273220383097;5013.724245166551;5016.046951079284;5062.114130027304;4906.11689895815;4906.190478571068;4956.132676781549;5001.349824522788;5008.799648014112;4780.4741478437345;4807.423109226846;4808.447028591687;4870.586000189953;4950.975245123751;4139.648129908992;4141.834326626901;4142.1922725068325;4143.544210136883;4148.937765933513;3644.1982763791925;3665.248624032067;3672.485851980725;3677.42999835026;3683.594804571495;4308.332208507686;4314.741115533078;4341.131773645284;4352.630026447724;4362.934555981663;4960.131976904027;4968.354113965162;4968.850934471971;4971.552560269593;5001.0998020355955;4211.326187809936;4242.851500197478;4305.784710764449;4310.784460776948;4313.6980411370905;4461.107778444324;4466.7766611669285;4486.7083639563325;4515.300128480091;4557.703749256288;4734.976325118352;4739.739314337676;4742.5731684148595;4744.762761861962;4784.736839473862;4811.759412029314;5056.418511871182;5058.3929928408825;5067.113255180402;5095.082885080721;4610.585047345755;4651.232546629768;4671.906561868812;4682.22743247374;4748.8100475981955;4918.508149185196;4922.163232250455;4923.433805112315;4930.728809915489;4968.527989840959;5011.523905228997;5018.749062546931;5028.798848046037;5032.547070763649;5071.797128114834;4709.670323077352;4747.216709242936;4750.14497390473;4820.614350851994;4822.903541929212;4750.07373562152;4798.832040878552;4805.183118869871;4805.399325084364;4806.711597304173;4714.834980775657;4729.645276604338;4736.3842700450095;4737.360456338488;4814.325994360863;4866.878328041827;4872.975635121944;4877.829275975324;4882.048000639841;4925.261210818406;4719.126961512131;4720.244760838249;4770.642201834807;4775.498572649961;4817.132916075 03:03:09 INFO - PROCESS | 28671 | |1;ext.html;558.8379369982705;570.1390899741392;574.8649067469144;576.5243673968976;580.167459695337;27397.863010684945;30635.080947571554;30645;37620.81189594055;39143.804280978555;39751.40372894409;40337;40410.79794601023;40471.39292910601;40498.595014049926;7451.323452223233;7605.8478830423355;7608.12506561747;7608.505447145918;7610.467267291264;7327.194008659043;7469.141048779378;7474.32731054205;7580.393568514533;9455.196308313802;9394.718158455258;9732;9743.366681165737;9747.658831940884;9750.756231094243;9282.535873206312;9289.210417114553;9327.067293270618;9330.533473326306;9339.906600933971;9519.428834269896;9593.760155996086;9597;9597.752292202038;9598.280128990353;36250;36740.816295918616;36765.44851827225;36806.4479032812;37060;2647.094092253574;2655.495455863399;2728.7271272872554;2732.740389662979;2984.6418429788346;27550;27608.861955690292;27733.445331093266;27864.582031269547;28108.297292567644;3400.7619466637343;3470.722342212617;3473.6212226987236;3476.217850983534;3545.6808887200277;172306;173138;173405;173712.131439342;173792.131039344;51788.223176652384;51920.22119668208;52061.7396913013;52080.73959630178;52094.47905520972;46577.30134047992;46585.5341446588;46671.76664116658;46729;46747.76626116848;12997.935010324887;13394.397252123677;13395.397207125703;13396.263205523595;13401.530946417024;9831.950840245752;9854.11312981835;9854.852177217348;9857.014298570086;9858.359206651545;14109.153450792985;14337.713245735236;14372.568822935329;14998.550043498712;15007.874409419337;5189.662671926389;5906.527477801766;5920.733566989496;5989.55078369124;6110.969445152835;757.75373003774;844.6248433116393;856.8971723393108;908.7137551671202;946.3044662173297;25964.87017564938;27315.770790314087;27549.724502754714;27647.58528622072;27662.170134895987;990.2424645146468;991.1327588360185;993.7416271769392;1003.7139415266614;1009.0716540782498;14071.507497237752;14713.485028023968;14835.406583736745;15116.09303441797;15144;350453;352308;354233;354400;355236;41408;42439.57560424418;46254.53745462569;47507.524924751;47590.524094759305;1158.3050169898163;1167.772284404533;1175.1010476985114;1181.3502573584494;1183.7632473505505;26682;28206.294842629097;28285.717142829133;29038.854805725838;29150.27124321909;41602.1679566413;42143.57856421397;42172.789136054125;42175.7891210542;42226.36660450034;318182;320181;320287;321875;321954;34843;34964;35221.82389088038;35477.29045419129;35721.642783571835;40219.597804021585;40435.1912961745;40559;40948.79525602472;41123.1775364497;34009.65990340164;34084;34872.30255394929;37710.24579508449;38425.23149537049;31727.04818855438;31992.52011219787;31997.360052798347;32126.678733212368;32148.196295091875;31776.205594860312;32367.19082022874;32401.675983239867;32571.674283256863;32630.184245394055;29959.70040299569;32630.34739305248;32809.50785738263;32821.343573128885;32897.34205315928;24520.50958980775;24908.12821551237;24932.750672493043;25036.248912532654;25274.115405960703 03:03:09 INFO - PROCESS | 28671 | |2;jquery.html;332.69059774409817;350.1142110460536;363.9781613103214;370.9091272638204;386.9996060184423;12452.19060761051;13253.536126235584;13397.464101435942;16375.4268600599;16393.918030409863;15279.541613751606;15701.450449234251;16119.677606447864;16134.354625814982;16138.112403817786;4775.713457192571;4974.676646018015;4981.078500477405;4986.775595098229;4987.900241995158;3691.169486865461;3888.747231429962;5424.647397919142;5839.503642190419;5889.057750759879;5808.157817116516;5923.14114453404;5925.73334199962;5927.525797936176;5927.644341339534;6473.093766872642;6760.628165450874;6779.254282028973;6885.173779146535;6903.620300883449;6452.677366131675;6515.3484651534945;6540.247871494744;6584.835379115512;6641.601503909781;23085.422864428354;23295.417614559603;23631;23647.054117835265;24015;2026.8479864010258;2074.263636409068;2139.4544391180148;2446.7920226780743;2511.259178542316;13488.797668034988;14135.15189088658;14214.218217998006;15121.243937803067;15522.146281954489;1852.249838815282;1866.4493974277484;1906.4661894669514;1923.8172373624484;1928.9903550482159;83540.99999999939;83730;84747.5762621189;87138;88563.11436885613;15104.697906042038;16252.75620865688;16462.588435289214;16532.669346613002;16916.407925722542;29145.854270728512;29182.309449657536;29210.12369628872;29319.706802931698;29426.411471770873;8231.382646301552;8473.745787626382;8570.185832345916;8718.95640521806;8900.198982091642;6944.618046007518;7038;7190.496665233488;7223.241559636268;7233.529820561646;8221.465604735673;8500.489970601784;8535.487870727777;8576.957115214384;8639.740807775777;3144.402563512925;3333.150046738066;3337.4326364517606;3369.898903032913;3408.5398471206568;792.7304716396453;853.9487630742175;859.7721603775004;880.212210071982;897.4435849773182;15565.120452716284;16157.59606009859;16802.41191558314;16956.15219239033;17348.479545613398;802.9518228906285;834.6953362022819;837.5184269045324;845.1759534453859;864.2567392042838;8860.822783544292;8952.955235223912;9323.160915517636;9359.766005849771;9428.717138485856;364184.1188263384;367219;369151;370016;373368;46517.30224046642;46873.29690054652;52649.736751316;65920;66678.33321666722;876.1862943706593;876.4390789894472;901.2744740483973;902.1609902790468;903.5888670654837;15360.923195383952;15409;16013;16193.59516012109;16236.918815405847;37278.44082338713;37298.627013729514;37446.812765935996;37768.244635107694;38241.426378603785;50588;50710.74644626901;50782.49217507778;50786;51305.48694513156;4599.793009314656;4869.683470574401;5176.611754118381;6928.515003949675;7014;11289.20975531705;11524.539018439169;11601.419929003685;12335.938320308342;12404.56584019555;10234.130098941674;10301.330413523097;10326.690199294033;10346.22403319739;11040.061594764535;9781.315307928377;10224.744381390525;10267.435291059064;10552.472376381304;10591.417472038804;7492.812679683051;7752.844943100994;7836;8206.548639824867;10624.946875265574;10863.348199108079;10945.83581246298;10962.835557466486;11326.433678316216;11640;11246.606368777053;11390.772184556428;11551.018163455865;11672.70818229551;12020.33888136161 03:03:09 INFO - PROCESS | 28671 | |3;mootools.html;1287.8261434706312;1334.132813671114;1357.212816566391;1616.862566681832;1624.4964061141054;6591.802245932624;6846.726130954768;6847.075644787952;6850.177978642558;6860.82847928802;6116.541259405541;6136.386361363861;6261.686915654222;6321.367863213676;6881.311868813116;2030.187924830065;2073.2536286936765;2074.5643414882816;2074.9896250518727;2075.9065842037144;1933;1990.532224927141;1992.5217947692595;2034.4812072921384;2034.5625690476545;1779.7063484525038;1827.1503750755896;1977.71323158142;1986.2452268138159;2047.5904819036252;2071;2072.668373060303;2077.470245087493;2078.1687325069943;2078.532330225702;1960.1277431542826;2019.8889061101634;2056.321413933413;2056.95886082279;2057.68105943579;7056.964715176391;7098.148222213315;7099.680514376865;7108.969199466049;7109;4110.568390319003;4268.231718290706;4283.186194623043;4285.3786201000685;4287.785610719451;2628.106443809114;2779.8888044478194;2830.9433811323865;2886.321714397115;2896.3048868271676;849.9022612399591;863.952482613456;896.4307664633005;898.3980732908967;914.5335878701843;9285.396449230846;9327.486988215645;9338.813223735555;9347.158755711951;9381;3646.872359467406;3836;3867.9226415472094;3899.3176194166476;3909.179072394772;7981.2018798119725;8010.679572817138;8017.679292828221;8047.919520804717;8049.476784009138;4201.894952626209;4222.366645003212;4226.1336426032585;4228.175505776406;4228.788560571959;3680.4847321375028;3840.0975770693863;3843.3082045232127;3851.114243723903;3858.903527411781;3286.392017476727;3287.819169945676;3382.4080785862375;3398.150462384404;3411.5394421752744;1076.7738774857212;1097.8023955687893;1098.7253186703324;1099.1097211258746;1103.906167975731;758.0600055930606;777.1567848883911;801.3789313282252;813.983720325602;824.0646865807232;4701.764911754399;4733.171694953369;4766.261229509431;4813.278008298713;4960.181570040975;389.52867030892935;392.97052721045463;397.67589414626985;397.9880603581897;398.2175026073721;3052.664206937235;3095.24166579185;3117.6258848938273;3131.4989601663624;3265.346930613887;7863.84272314562;8229.95885020571;8323.1260717625;8334.708285209988;8348.833023339499;8074.757757267292;8252.33981281496;8283.130271321545;8312.750617481484;8334.749957501284;6390.137331460193;6532.8040158794365;6542.705578248991;6544.214694236722;6545.934540654628;4567.634589232787;4610.193216187221;4625.213713668617;4646.767661616973;4666.650001249987;7413;7480.850382992201;7525;7601.315881570686;7642.3504002158215;7838.412119091205;7859.877832984947;7867.842643146991;7900;7912.683492660229;5548.472895074961;5649.322081350264;5702.486776190163;5859.472647461749;5899.734511946886;6266.279377871603;6326.145970293951;6334.049892516159;6339.207599050119;6343.5876668016435;5812.73842677089;5929.881402372014;6040.546958978006;6074.42292982166;6124;5952.880942381042;5957.672328021827;5967.552433567413;5980.222571065734;6006.189164462741;5735.770569177186;5768.682722450306;5803.042497987784;5806.709664516673;5807.622504537191;3844.596317386634;3875.9224815504094;3951.3085210088693;3979.960200397959;4083.612056854594;3960.6039396061315;3963.3460479020637;3977.482927219443;3995.380715989026;4017.6384125428854 03:03:09 INFO - PROCESS | 28671 | |4;prototype.html;258.77745139180314;277.6903752316168;279.8125256078427;284.628559729553;287.08849403144995;4624.167649823031;4779.187538118519;4809.326694262806;4820.493848145938;4844.781984810683;4743.573078422941;4772.780656994497;4778.569928706415;4792.904141917168;4813.278008298748;3441.3633477806684;3707.647773461517;3738.55137383513;3761.605031471697;3766.5291838520184;3764.868229611964;3769.396896496561;3778.2254637799183;3782.432635104729;3783.8486460541544;3678.503402040717;3703.3704270273984;3703.7962912039825;3733.2346868891946;3738.47661327413;3634.436662317345;3737.5141231639986;3739.626037396266;3747.7376583639157;3751.9812400938094;3283.9343213135603;3290.0952238134464;3290.7696461247724;3301.108700650811;3329.667033296675;4640.118377508296;4641.907161856778;4644.396228490308;4658.743769092698;4675.5558221969195;4129.97935010326;4232.343986682069;4261.211675839949;4266.850660226877;4286.828526858922;4833.903321933577;4931.3835770528685;4954.455009948902;4954.851354459372;5069.721165335942;3570.214552798406;3574.696150827183;3575.964240357589;3579.49887015818;3583.5699716033982;5212;5219.43416974906;5244.81643142492;5253.212018197224;5276.208568714724;3383.3064221834466;3551.4672799080345;3704.9629503705155;3705.166337574024;3716.479692843004;3615.403458429382;3621.583517895423;3629.364861149288;3629.6914762245506;3641.308151451216;3932.3315036443873;4043.7978101094827;4162.458880345596;4171.435711608147;4173.99472379886;4918.409790825052;4994.675346102492;4997.100521906019;5000.2749601307605;5017.7491125443585;1204.7168915304896;1220.0605533738972;1222.113967373647;1224.7691070474295;1226.3868065967017;800.7117437722416;824.0976131136516;824.2869917521421;831.4055450353027;838.0781140745131;4326.199653064194;4342.741774277358;4349.304111342233;4360.735386737811;4362.258416069276;4977.975110124498;4984.159029353234;4998.975005125024;5031.622628302892;5040.823571174991;4318.78406079701;4323.63249123828;4334.674899382559;4375.387445757597;4384.539623339567;2521.7730404263702;2658.534756417619;2658.8138830282082;2665.6667916510437;2670.212287375229;4690.249560070372;4698.546568272385;4702.048649810359;4720.167899260485;4771.71369717818;4930.7288099154175;5068.391792984866;5113.71874546896;5161.690298582097;5179.61152913533;4589.5181005994555;4698.875247960068;4703.412073490814;4706.435227772621;4726.645501587326;4951.430585482715;4966.255061740623;4973.403191617029;4986.576141028053;5020.397552293602;4752.334673145693;4900.128898170406;4915.3855768029;4950.504949505021;4951.876203094951;4641.976790116028;4669.287916106771;4706.694064885772;4712.552307530779;4724.6456515760765;3490.1972546314996;3493.12671832042;3502.649735026477;3503.2292895563955;3535.15156362466;4978.979309241669;4996.825111121093;5051.898962020666;5065.164247899055;5088.745562721775;4660.883477913079;4979.651424400257;4984.252362145708;4992.425871024879;5012.87467813293;4964.865108003449;4984.850454486371;5022.447530771539;5033.748312584283;5036.722980235975;4750.698264705996;4891.5353041461;4907.306979092207;4915.188993816123;4930.778114984762;4977.651564390458;4996.300517927566;5001.57486613642;5024.572911302434;5026.296318515338;4897.46127925935;4906.6320025997475;4907.5828554571835;4908.361912951294;4909.288153217834 03:03:09 INFO - PROCESS | 28671 | |5;yui.html;516.961227907907;592.3277080513616;600.147790138004;611.6543604071044;676.435176627516;11522.711932201688;12545.18456300341;12613.999999999989;12752.872471275285;13350.265735384573;12603.180793248455;12775.680607984805;12819.487220511168;12826;12827.037972152102;736.6169591812254;755.4258763339847;756.4515726098562;756.5158298688843;756.7616200896728;593.7239183779542;611.60245840204;734.6069852628845;751.9172890981988;761.8400135971452;768.623374546471;769.7190525458224;770.0143815915609;770.218228498075;770.2297702297702;766.2950085920966;766.8734658781294;768.8347005393812;769.6536558548676;769.742136384312;464.80478199156437;472.21376408280514;561.2899681902396;577.8757567123047;580.8809194115196;12512.374381280899;12540.122191446602;12541.561045363369;12545.247285162919;12545.686357841036;11283.323000619988;11285.548578056867;11689.824652630217;11970.40147992597;12205.084618653636;9201;9240.815183696355;9472.95263523678;9804.411735295906;9840.65557705477;3144.3082521845386;3159.984200078985;3214.341060082701;3302.9174270643184;3383.390989621867;57001.71499142519;57426.42573574252;58653.12020319699;66859.3314066858;67202;10084.358680612311;10183.898161018295;10242;10250.692479225636;10391.792164156675;18651;18841.152148153367;18893.338733144275;18907.716384254247;19044.61910761777;6457.192850893638;6464.41820236181;6531.673416329259;6536.379043990813;6803.0135630333325;3508.4388396470717;3535.5403797506674;3537.8054207018345;3568.8750893718593;3616.5298511193378;2726.4001919577663;2830.433913217365;2838.0634390651035;2838.8012839101066;2839.716028397144;448.89450979019904;454.7476150736307;457.22728588685015;464.4937018649688;470.05988023952096;485.69401277195846;567.5970061256471;573.249043752677;581.9970900145472;588.153059594183;7871.957212634582;8055.516668999879;8171.79570510742;8320.70877519284;8506.914930850737;475.76449657419107;502.83406475862876;507.17077578159973;555.3335996803852;569.7806344557292;3860.8069596520063;3906.4726261954274;4041.373587094005;4072;4090.9181816363507;51305;52510.73744631329;52903.470965290624;62981.37018629847;69716;43489;44758.55241447544;44875.55124448779;46040;57069.42930570724;51064;51399.743001284754;51955;51991.740041300305;52441.21338179854;8633.784155396166;8755.474671519729;9098.272138229058;9123.498207598646;9290.767730806514;36350.8182459086;36548.81725591355;37028.44457333088;37094.62905370912;39237;44950.55049449464;45127.7743611293;49537.75231123965;51756.74121629518;52686;10705.143588513056;10833.566657333618;10842.241043126905;10985.560577576807;11179.385133817717;11368.431578420881;11780.234284771463;11780.764384712087;11840.940795296314;12216.87783122193;8612.65549378018;11007.669769906915;11087.44562771842;11256.155788315746;11468.885311146782;11093.5562577496;11300.09599232076;11345.659630211107;11636.36000020007;12032.458539365925;11463.369514676773;11553.768924621292;11740.765184696429;12195.451204695988;12376.257424554195;9507.477088760184;9934.354266972623;9971.650992215238;10138.49307534635;10671.146308295472;9962.750931226778;10329.225308101772;10384.221183411124;10519.421431821323;10801.621943231949 03:03:09 INFO - PROCESS | 28671 | __end_tp_report 03:03:09 INFO - PROCESS | 28671 | __start_cc_report 03:03:09 INFO - PROCESS | 28671 | _x_x_mozilla_cycle_collect,1498 03:03:09 INFO - PROCESS | 28671 | __end_cc_report 03:03:09 INFO - PROCESS | 28671 | __startTimestamp1480330989184__endTimestamp 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | ------- Summary: start ------- 03:03:09 INFO - PROCESS | 28671 | Number of tests: 6 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | [#0] dojo.html Cycles:165 Average:4604.35 Median:4729.65 stddev:477.65 (10.1%) stddev-sans-first:452.07 03:03:09 INFO - PROCESS | 28671 | Values: 2584.3 2620.9 2627.3 2646.6 2655.6 4564.5 4614.9 4689.3 4695.3 4699.7 4606.3 4611.9 4618.7 4650.0 4674.7 4248.3 4250.3 4291.1 4338.3 4411.0 4294.4 4357.8 4371.9 4382.4 4437.5 4225.1 4257.2 4315.0 4366.1 4404.0 4253.7 4286.4 4290.5 4311.7 4370.2 4295.6 4297.3 4304.2 4315.8 4354.6 4640.0 4676.8 4678.4 4682.8 4699.3 4851.5 4891.1 4891.2 4962.8 5005.4 5034.9 5035.6 5061.3 5071.3 5072.9 4689.6 4695.9 4701.4 4704.3 4738.8 4922.8 5144.2 5152.7 5162.4 5213.5 4740.0 4839.0 4869.6 4943.9 4957.6 5011.4 5012.3 5013.7 5016.0 5062.1 4906.1 4906.2 4956.1 5001.3 5008.8 4780.5 4807.4 4808.4 4870.6 4951.0 4139.6 4141.8 4142.2 4143.5 4148.9 3644.2 3665.2 3672.5 3677.4 3683.6 4308.3 4314.7 4341.1 4352.6 4362.9 4960.1 4968.4 4968.9 4971.6 5001.1 4211.3 4242.9 4305.8 4310.8 4313.7 4461.1 4466.8 4486.7 4515.3 4557.7 4735.0 4739.7 4742.6 4744.8 4784.7 4811.8 5056.4 5058.4 5067.1 5095.1 4610.6 4651.2 4671.9 4682.2 4748.8 4918.5 4922.2 4923.4 4930.7 4968.5 5011.5 5018.7 5028.8 5032.5 5071.8 4709.7 4747.2 4750.1 4820.6 4822.9 4750.1 4798.8 4805.2 4805.4 4806.7 4714.8 4729.6 4736.4 4737.4 4814.3 4866.9 4873.0 4877.8 4882.0 4925.3 4719.1 4720.2 4770.6 4775.5 4817.1 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | [#1] ext.html Cycles:180 Average:43656.29 Median:195356.65 stddev:77157.54 (39.5%) stddev-sans-first:77306.13 03:03:09 INFO - PROCESS | 28671 | Values: 558.8 570.1 574.9 576.5 580.2 27397.9 30635.1 30645.0 37620.8 39143.8 39751.4 40337.0 40410.8 40471.4 40498.6 7451.3 7605.8 7608.1 7608.5 7610.5 7327.2 7469.1 7474.3 7580.4 9455.2 9394.7 9732.0 9743.4 9747.7 9750.8 9282.5 9289.2 9327.1 9330.5 9339.9 9519.4 9593.8 9597.0 9597.8 9598.3 36250.0 36740.8 36765.4 36806.4 37060.0 2647.1 2655.5 2728.7 2732.7 2984.6 27550.0 27608.9 27733.4 27864.6 28108.3 3400.8 3470.7 3473.6 3476.2 3545.7 172306.0 173138.0 173405.0 173712.1 173792.1 51788.2 51920.2 52061.7 52080.7 52094.5 46577.3 46585.5 46671.8 46729.0 46747.8 12997.9 13394.4 13395.4 13396.3 13401.5 9832.0 9854.1 9854.9 9857.0 9858.4 14109.2 14337.7 14372.6 14998.6 15007.9 5189.7 5906.5 5920.7 5989.6 6111.0 757.8 844.6 856.9 908.7 946.3 25964.9 27315.8 27549.7 27647.6 27662.2 990.2 991.1 993.7 1003.7 1009.1 14071.5 14713.5 14835.4 15116.1 15144.0 350453.0 352308.0 354233.0 354400.0 355236.0 41408.0 42439.6 46254.5 47507.5 47590.5 1158.3 1167.8 1175.1 1181.4 1183.8 26682.0 28206.3 28285.7 29038.9 29150.3 41602.2 42143.6 42172.8 42175.8 42226.4 318182.0 320181.0 320287.0 321875.0 321954.0 34843.0 34964.0 35221.8 35477.3 35721.6 40219.6 40435.2 40559.0 40948.8 41123.2 34009.7 34084.0 34872.3 37710.2 38425.2 31727.0 31992.5 31997.4 32126.7 32148.2 31776.2 32367.2 32401.7 32571.7 32630.2 29959.7 32630.3 32809.5 32821.3 32897.3 24520.5 24908.1 24932.8 25036.2 25274.1 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | [#2] jquery.html Cycles:180 Average:24638.10 Median:205333.31 stddev:60890.41 (29.7%) stddev-sans-first:61033.87 03:03:09 INFO - PROCESS | 28671 | Values: 332.7 350.1 364.0 370.9 387.0 12452.2 13253.5 13397.5 16375.4 16393.9 15279.5 15701.5 16119.7 16134.4 16138.1 4775.7 4974.7 4981.1 4986.8 4987.9 3691.2 3888.7 5424.6 5839.5 5889.1 5808.2 5923.1 5925.7 5927.5 5927.6 6473.1 6760.6 6779.3 6885.2 6903.6 6452.7 6515.3 6540.2 6584.8 6641.6 23085.4 23295.4 23631.0 23647.1 24015.0 2026.8 2074.3 2139.5 2446.8 2511.3 13488.8 14135.2 14214.2 15121.2 15522.1 1852.2 1866.4 1906.5 1923.8 1929.0 83541.0 83730.0 84747.6 87138.0 88563.1 15104.7 16252.8 16462.6 16532.7 16916.4 29145.9 29182.3 29210.1 29319.7 29426.4 8231.4 8473.7 8570.2 8719.0 8900.2 6944.6 7038.0 7190.5 7223.2 7233.5 8221.5 8500.5 8535.5 8577.0 8639.7 3144.4 3333.2 3337.4 3369.9 3408.5 792.7 853.9 859.8 880.2 897.4 15565.1 16157.6 16802.4 16956.2 17348.5 803.0 834.7 837.5 845.2 864.3 8860.8 8953.0 9323.2 9359.8 9428.7 364184.1 367219.0 369151.0 370016.0 373368.0 46517.3 46873.3 52649.7 65920.0 66678.3 876.2 876.4 901.3 902.2 903.6 15360.9 15409.0 16013.0 16193.6 16236.9 37278.4 37298.6 37446.8 37768.2 38241.4 50588.0 50710.7 50782.5 50786.0 51305.5 4599.8 4869.7 5176.6 6928.5 7014.0 11289.2 11524.5 11601.4 12335.9 12404.6 10234.1 10301.3 10326.7 10346.2 11040.1 9781.3 10224.7 10267.4 10552.5 10591.4 7492.8 7752.8 7836.0 8206.5 10624.9 10863.3 10945.8 10962.8 11326.4 11640.0 11246.6 11390.8 11551.0 11672.7 12020.3 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | [#3] mootools.html Cycles:180 Average:4534.80 Median:4717.47 stddev:2467.93 (52.3%) stddev-sans-first:2462.79 03:03:09 INFO - PROCESS | 28671 | Values: 1287.8 1334.1 1357.2 1616.9 1624.5 6591.8 6846.7 6847.1 6850.2 6860.8 6116.5 6136.4 6261.7 6321.4 6881.3 2030.2 2073.3 2074.6 2075.0 2075.9 1933.0 1990.5 1992.5 2034.5 2034.6 1779.7 1827.2 1977.7 1986.2 2047.6 2071.0 2072.7 2077.5 2078.2 2078.5 1960.1 2019.9 2056.3 2057.0 2057.7 7057.0 7098.1 7099.7 7109.0 7109.0 4110.6 4268.2 4283.2 4285.4 4287.8 2628.1 2779.9 2830.9 2886.3 2896.3 849.9 864.0 896.4 898.4 914.5 9285.4 9327.5 9338.8 9347.2 9381.0 3646.9 3836.0 3867.9 3899.3 3909.2 7981.2 8010.7 8017.7 8047.9 8049.5 4201.9 4222.4 4226.1 4228.2 4228.8 3680.5 3840.1 3843.3 3851.1 3858.9 3286.4 3287.8 3382.4 3398.2 3411.5 1076.8 1097.8 1098.7 1099.1 1103.9 758.1 777.2 801.4 814.0 824.1 4701.8 4733.2 4766.3 4813.3 4960.2 389.5 393.0 397.7 398.0 398.2 3052.7 3095.2 3117.6 3131.5 3265.3 7863.8 8230.0 8323.1 8334.7 8348.8 8074.8 8252.3 8283.1 8312.8 8334.7 6390.1 6532.8 6542.7 6544.2 6545.9 4567.6 4610.2 4625.2 4646.8 4666.7 7413.0 7480.9 7525.0 7601.3 7642.4 7838.4 7859.9 7867.8 7900.0 7912.7 5548.5 5649.3 5702.5 5859.5 5899.7 6266.3 6326.1 6334.0 6339.2 6343.6 5812.7 5929.9 6040.5 6074.4 6124.0 5952.9 5957.7 5967.6 5980.2 6006.2 5735.8 5768.7 5803.0 5806.7 5807.6 3844.6 3875.9 3951.3 3980.0 4083.6 3960.6 3963.3 3977.5 3995.4 4017.6 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | [#4] prototype.html Cycles:180 Average:4102.93 Median:4694.40 stddev:1194.87 (25.5%) stddev-sans-first:1162.87 03:03:09 INFO - PROCESS | 28671 | Values: 258.8 277.7 279.8 284.6 287.1 4624.2 4779.2 4809.3 4820.5 4844.8 4743.6 4772.8 4778.6 4792.9 4813.3 3441.4 3707.6 3738.6 3761.6 3766.5 3764.9 3769.4 3778.2 3782.4 3783.8 3678.5 3703.4 3703.8 3733.2 3738.5 3634.4 3737.5 3739.6 3747.7 3752.0 3283.9 3290.1 3290.8 3301.1 3329.7 4640.1 4641.9 4644.4 4658.7 4675.6 4130.0 4232.3 4261.2 4266.9 4286.8 4833.9 4931.4 4954.5 4954.9 5069.7 3570.2 3574.7 3576.0 3579.5 3583.6 5212.0 5219.4 5244.8 5253.2 5276.2 3383.3 3551.5 3705.0 3705.2 3716.5 3615.4 3621.6 3629.4 3629.7 3641.3 3932.3 4043.8 4162.5 4171.4 4174.0 4918.4 4994.7 4997.1 5000.3 5017.7 1204.7 1220.1 1222.1 1224.8 1226.4 800.7 824.1 824.3 831.4 838.1 4326.2 4342.7 4349.3 4360.7 4362.3 4978.0 4984.2 4999.0 5031.6 5040.8 4318.8 4323.6 4334.7 4375.4 4384.5 2521.8 2658.5 2658.8 2665.7 2670.2 4690.2 4698.5 4702.0 4720.2 4771.7 4930.7 5068.4 5113.7 5161.7 5179.6 4589.5 4698.9 4703.4 4706.4 4726.6 4951.4 4966.3 4973.4 4986.6 5020.4 4752.3 4900.1 4915.4 4950.5 4951.9 4642.0 4669.3 4706.7 4712.6 4724.6 3490.2 3493.1 3502.6 3503.2 3535.2 4979.0 4996.8 5051.9 5065.2 5088.7 4660.9 4979.7 4984.3 4992.4 5012.9 4964.9 4984.9 5022.4 5033.7 5036.7 4750.7 4891.5 4907.3 4915.2 4930.8 4977.7 4996.3 5001.6 5024.6 5026.3 4897.5 4906.6 4907.6 4908.4 4909.3 03:03:09 INFO - PROCESS | 28671 | 03:03:09 INFO - PROCESS | 28671 | [#5] yui.html Cycles:180 Average:14242.19 Median:22791.26 stddev:17431.64 (76.5%) stddev-sans-first:17450.07 03:03:09 INFO - PROCESS | 28671 | Values: 517.0 592.3 600.1 611.7 676.4 11522.7 12545.2 12614.0 12752.9 13350.3 12603.2 12775.7 12819.5 12826.0 12827.0 736.6 755.4 756.5 756.5 756.8 593.7 611.6 734.6 751.9 761.8 768.6 769.7 770.0 770.2 770.2 766.3 766.9 768.8 769.7 769.7 464.8 472.2 561.3 577.9 580.9 12512.4 12540.1 12541.6 12545.2 12545.7 11283.3 11285.5 11689.8 11970.4 12205.1 9201.0 9240.8 9473.0 9804.4 9840.7 3144.3 3160.0 3214.3 3302.9 3383.4 57001.7 57426.4 58653.1 66859.3 67202.0 10084.4 10183.9 10242.0 10250.7 10391.8 18651.0 18841.2 18893.3 18907.7 19044.6 6457.2 6464.4 6531.7 6536.4 6803.0 3508.4 3535.5 3537.8 3568.9 3616.5 2726.4 2830.4 2838.1 2838.8 2839.7 448.9 454.7 457.2 464.5 470.1 485.7 567.6 573.2 582.0 588.2 7872.0 8055.5 8171.8 8320.7 8506.9 475.8 502.8 507.2 555.3 569.8 3860.8 3906.5 4041.4 4072.0 4090.9 51305.0 52510.7 52903.5 62981.4 69716.0 43489.0 44758.6 44875.6 46040.0 57069.4 51064.0 51399.7 51955.0 51991.7 52441.2 8633.8 8755.5 9098.3 9123.5 9290.8 36350.8 36548.8 37028.4 37094.6 39237.0 44950.6 45127.8 49537.8 51756.7 52686.0 10705.1 10833.6 10842.2 10985.6 11179.4 11368.4 11780.2 11780.8 11840.9 12216.9 8612.7 11007.7 11087.4 11256.2 11468.9 11093.6 11300.1 11345.7 11636.4 12032.5 11463.4 11553.8 11740.8 12195.5 12376.3 9507.5 9934.4 9971.7 10138.5 10671.1 9962.8 10329.2 10384.2 10519.4 10801.6 03:03:09 INFO - PROCESS | 28671 | -------- Summary: end -------- 03:03:09 INFO - PROCESS | 28671 | 03:03:10 INFO - TEST-INFO | 28671: exit 0 03:03:10 INFO - TEST-OK | dromaeo_css | took 1122928ms 03:03:10 INFO - TEST-START | kraken 03:03:10 INFO - operating with platform_type : linux_ 03:03:10 INFO - Initialising browser for kraken test... 03:03:10 INFO - TEST-INFO | started process 28986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFFvku7/profile http://localhost:41557/getInfo.html) 03:03:14 INFO - PROCESS | 28986 | __metrics Screen width/height:1600/1200 03:03:14 INFO - PROCESS | 28986 | colorDepth:24 03:03:14 INFO - PROCESS | 28986 | Browser inner width/height: 1024/697 03:03:14 INFO - PROCESS | 28986 | __metrics 03:03:15 INFO - PROCESS | 28986 | 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" 03:03:15 INFO - PROCESS | 28986 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:03:16 INFO - PROCESS | 28986 | console.error: PushService: 03:03:16 INFO - PROCESS | 28986 | stateChangeProcessEnqueue: Error transitioning state 03:03:16 INFO - PROCESS | 28986 | UnknownError 03:03:17 INFO - TEST-INFO | 28986: exit 0 03:03:17 INFO - Browser initialized. 03:03:17 INFO - Running cycle 1/1 for kraken test... 03:03:17 INFO - TEST-INFO | started process 29070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFFvku7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:29 INFO - PROCESS | 29070 | RSS: Main: 175136768 03:03:29 INFO - PROCESS | 29070 | 03:03:32 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41557/tests/kraken/driver.html?testName=audio-beat-detection) 03:03:33 INFO - PROCESS | 29070 | RSS: Main: 240418816 03:03:33 INFO - PROCESS | 29070 | 03:03:36 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41557/tests/kraken/driver.html?testName=audio-dft) 03:03:36 INFO - PROCESS | 29070 | RSS: Main: 218689536 03:03:36 INFO - PROCESS | 29070 | 03:03:39 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41557/tests/kraken/driver.html?testName=audio-fft) 03:03:40 INFO - PROCESS | 29070 | RSS: Main: 301535232 03:03:40 INFO - PROCESS | 29070 | 03:03:42 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41557/tests/kraken/driver.html?testName=audio-oscillator) 03:03:43 INFO - PROCESS | 29070 | RSS: Main: 212307968 03:03:43 INFO - PROCESS | 29070 | 03:03:45 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:03:45 INFO - PROCESS | 29070 | RSS: Main: 215433216 03:03:45 INFO - PROCESS | 29070 | 03:03:49 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41557/tests/kraken/driver.html?testName=imaging-darkroom) 03:03:49 INFO - PROCESS | 29070 | RSS: Main: 254689280 03:03:49 INFO - PROCESS | 29070 | 03:03:53 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41557/tests/kraken/driver.html?testName=imaging-desaturate) 03:03:53 INFO - PROCESS | 29070 | RSS: Main: 248942592 03:03:53 INFO - PROCESS | 29070 | 03:03:56 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41557/tests/kraken/driver.html?testName=json-parse-financial) 03:03:57 INFO - PROCESS | 29070 | RSS: Main: 249917440 03:03:57 INFO - PROCESS | 29070 | 03:03:59 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:03:59 INFO - PROCESS | 29070 | RSS: Main: 213700608 03:03:59 INFO - PROCESS | 29070 | 03:04:01 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:04:02 INFO - PROCESS | 29070 | RSS: Main: 220803072 03:04:02 INFO - PROCESS | 29070 | 03:04:04 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:04:05 INFO - PROCESS | 29070 | RSS: Main: 229822464 03:04:05 INFO - PROCESS | 29070 | 03:04:07 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:04:08 INFO - PROCESS | 29070 | RSS: Main: 239468544 03:04:08 INFO - PROCESS | 29070 | 03:04:11 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:04:12 INFO - PROCESS | 29070 | RSS: Main: 235577344 03:04:12 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | Cycle 1(1): loaded http://localhost:41557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41557/tests/kraken/driver.html?testName=ai-astar) 03:04:14 INFO - PROCESS | 29070 | RSS: Main: 287502336 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | __start_tp_report 03:04:14 INFO - PROCESS | 29070 | _x_x_mozilla_page_load 03:04:14 INFO - PROCESS | 29070 | _x_x_mozilla_page_load_details 03:04:14 INFO - PROCESS | 29070 | |i|pagename|runs| 03:04:14 INFO - PROCESS | 29070 | |0;ai-astar;107;117;117;117;117;117;118;116;117;116 03:04:14 INFO - PROCESS | 29070 | |1;audio-beat-detection;158;132;133;191;132;138;139;130;153;129 03:04:14 INFO - PROCESS | 29070 | |2;audio-dft;161;161;162;162;161;162;160;161;159;160 03:04:14 INFO - PROCESS | 29070 | |3;audio-fft;76;77;76;108;76;77;78;76;96;79 03:04:14 INFO - PROCESS | 29070 | |4;audio-oscillator;84;84;112;84;84;84;101;83;83;107 03:04:14 INFO - PROCESS | 29070 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;118;117 03:04:14 INFO - PROCESS | 29070 | |6;imaging-darkroom;148;148;148;149;148;148;148;149;148;147 03:04:14 INFO - PROCESS | 29070 | |7;imaging-desaturate;96;95;95;94;95;96;95;95;95;95 03:04:14 INFO - PROCESS | 29070 | |8;json-parse-financial;67;66;66;67;67;67;67;68;68;68 03:04:14 INFO - PROCESS | 29070 | |9;json-stringify-tinderbox;65;66;66;66;65;65;76;66;66;66 03:04:14 INFO - PROCESS | 29070 | |10;stanford-crypto-aes;85;85;85;96;88;85;88;85;84;84 03:04:14 INFO - PROCESS | 29070 | |11;stanford-crypto-ccm;146;141;143;148;155;159;156;143;199;141 03:04:14 INFO - PROCESS | 29070 | |12;stanford-crypto-pbkdf2;182;182;180;180;179;181;180;179;183;180 03:04:14 INFO - PROCESS | 29070 | |13;stanford-crypto-sha256-iterative;72;72;76;72;73;72;70;72;70;70 03:04:14 INFO - PROCESS | 29070 | __end_tp_report 03:04:14 INFO - PROCESS | 29070 | __start_cc_report 03:04:14 INFO - PROCESS | 29070 | _x_x_mozilla_cycle_collect,1936 03:04:14 INFO - PROCESS | 29070 | __end_cc_report 03:04:14 INFO - PROCESS | 29070 | __startTimestamp1480331054512__endTimestamp 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | ------- Summary: start ------- 03:04:14 INFO - PROCESS | 29070 | Number of tests: 14 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:3.18 (2.7%) stddev-sans-first:0.60 03:04:14 INFO - PROCESS | 29070 | Values: 107.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 116.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:138.50 stddev:19.36 (14.0%) stddev-sans-first:19.81 03:04:14 INFO - PROCESS | 29070 | Values: 158.0 132.0 133.0 191.0 132.0 138.0 139.0 130.0 153.0 129.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 03:04:14 INFO - PROCESS | 29070 | Values: 161.0 161.0 162.0 162.0 161.0 162.0 160.0 161.0 159.0 160.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.01 (14.3%) stddev-sans-first:11.47 03:04:14 INFO - PROCESS | 29070 | Values: 76.0 77.0 76.0 108.0 76.0 77.0 78.0 76.0 96.0 79.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:84.00 stddev:11.39 (13.6%) stddev-sans-first:11.83 03:04:14 INFO - PROCESS | 29070 | Values: 84.0 84.0 112.0 84.0 84.0 84.0 101.0 83.0 83.0 107.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:04:14 INFO - PROCESS | 29070 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:04:14 INFO - PROCESS | 29070 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 148.0 149.0 148.0 147.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 03:04:14 INFO - PROCESS | 29070 | Values: 96.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 03:04:14 INFO - PROCESS | 29070 | Values: 67.0 66.0 66.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:3.30 (5.0%) stddev-sans-first:3.44 03:04:14 INFO - PROCESS | 29070 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 76.0 66.0 66.0 66.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.00 stddev:3.63 (4.3%) stddev-sans-first:3.81 03:04:14 INFO - PROCESS | 29070 | Values: 85.0 85.0 85.0 96.0 88.0 85.0 88.0 85.0 84.0 84.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:151.50 stddev:17.41 (11.5%) stddev-sans-first:18.27 03:04:14 INFO - PROCESS | 29070 | Values: 146.0 141.0 143.0 148.0 155.0 159.0 156.0 143.0 199.0 141.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:180.50 stddev:1.35 (0.7%) stddev-sans-first:1.33 03:04:14 INFO - PROCESS | 29070 | Values: 182.0 182.0 180.0 180.0 179.0 181.0 180.0 179.0 183.0 180.0 03:04:14 INFO - PROCESS | 29070 | 03:04:14 INFO - PROCESS | 29070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.79 (2.5%) stddev-sans-first:1.90 03:04:14 INFO - PROCESS | 29070 | Values: 72.0 72.0 76.0 72.0 73.0 72.0 70.0 72.0 70.0 70.0 03:04:14 INFO - PROCESS | 29070 | -------- Summary: end -------- 03:04:14 INFO - PROCESS | 29070 | 03:04:15 INFO - TEST-INFO | 29070: exit 0 03:04:15 INFO - TEST-OK | kraken | took 65652ms 03:04:15 INFO - SUITE-END | took 1188s 03:04:16 INFO - Completed test suite (00:19:48) 03:04:16 INFO - javascript benchmark 03:04:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.27640260727, 2620.908268210613, 2627.343164208947, 2646.642703235064, 2655.6016597510384, 4564.543545645433, 4614.861554153373, 4689.273162659784, 4695.295705644151, 4699.694519856212, 4606.286025666027, 4611.884702882421, 4618.676692631517, 4649.953500464994, 4674.672772905898, 4248.34150706641, 4250.27745283301, 4291.077418355053, 4338.262495375778, 4411.029573493826, 4294.441722576061, 4357.7603231822395, 4371.934420983688, 4382.364557139213, 4437.534058923815, 4225.070484493437, 4257.169851878885, 4314.956850431487, 4366.08312254427, 4403.955960440387, 4253.702240843142, 4286.39990401344, 4290.528041915387, 4311.719738217006, 4370.2133615949115, 4295.613394794453, 4297.312430011183, 4304.203722311382, 4315.8057887394825, 4354.629856462205, 4639.979204575022, 4676.812927482896, 4678.415198100238, 4682.8126874924965, 4699.342092107107, 4851.466338702739, 4891.1195984722735, 4891.1685013547785, 4962.801487940478, 5005.449400565934, 5034.89930201394, 5035.571976382012, 5061.342025536656, 5071.264666623319, 5072.873178170538, 4689.624830013625, 4695.929561056587, 4701.3888194535175, 4704.29435584665, 4738.763061846894, 4922.827701030446, 5144.2283657450935, 5152.742362881841, 5162.406323272871, 5213.478652134832, 4739.95260047402, 4838.95161048385, 4869.561739443467, 4943.876403089952, 4957.628177886673, 5011.398632164163, 5012.273220383097, 5013.724245166551, 5016.046951079284, 5062.114130027304, 4906.11689895815, 4906.190478571068, 4956.132676781549, 5001.349824522788, 5008.799648014112, 4780.4741478437345, 4807.423109226846, 4808.447028591687, 4870.586000189953, 4950.975245123751, 4139.648129908992, 4141.834326626901, 4142.1922725068325, 4143.544210136883, 4148.937765933513, 3644.1982763791925, 3665.248624032067, 3672.485851980725, 3677.42999835026, 3683.594804571495, 4308.332208507686, 4314.741115533078, 4341.131773645284, 4352.630026447724, 4362.934555981663, 4960.131976904027, 4968.354113965162, 4968.850934471971, 4971.552560269593, 5001.0998020355955, 4211.326187809936, 4242.851500197478, 4305.784710764449, 4310.784460776948, 4313.6980411370905, 4461.107778444324, 4466.7766611669285, 4486.7083639563325, 4515.300128480091, 4557.703749256288, 4734.976325118352, 4739.739314337676, 4742.5731684148595, 4744.762761861962, 4784.736839473862, 4811.759412029314, 5056.418511871182, 5058.3929928408825, 5067.113255180402, 5095.082885080721, 4610.585047345755, 4651.232546629768, 4671.906561868812, 4682.22743247374, 4748.8100475981955, 4918.508149185196, 4922.163232250455, 4923.433805112315, 4930.728809915489, 4968.527989840959, 5011.523905228997, 5018.749062546931, 5028.798848046037, 5032.547070763649, 5071.797128114834, 4709.670323077352, 4747.216709242936, 4750.14497390473, 4820.614350851994, 4822.903541929212, 4750.07373562152, 4798.832040878552, 4805.183118869871, 4805.399325084364, 4806.711597304173, 4714.834980775657, 4729.645276604338, 4736.3842700450095, 4737.360456338488, 4814.325994360863, 4866.878328041827, 4872.975635121944, 4877.829275975324, 4882.048000639841, 4925.261210818406, 4719.126961512131, 4720.244760838249, 4770.642201834807, 4775.498572649961, 4817.132916075], "value": 4574.252535141239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8379369982705, 570.1390899741392, 574.8649067469144, 576.5243673968976, 580.167459695337, 27397.863010684945, 30635.080947571554, 30645.0, 37620.81189594055, 39143.804280978555, 39751.40372894409, 40337.0, 40410.79794601023, 40471.39292910601, 40498.595014049926, 7451.323452223233, 7605.8478830423355, 7608.12506561747, 7608.505447145918, 7610.467267291264, 7327.194008659043, 7469.141048779378, 7474.32731054205, 7580.393568514533, 9455.196308313802, 9394.718158455258, 9732.0, 9743.366681165737, 9747.658831940884, 9750.756231094243, 9282.535873206312, 9289.210417114553, 9327.067293270618, 9330.533473326306, 9339.906600933971, 9519.428834269896, 9593.760155996086, 9597.0, 9597.752292202038, 9598.280128990353, 36250.0, 36740.816295918616, 36765.44851827225, 36806.4479032812, 37060.0, 2647.094092253574, 2655.495455863399, 2728.7271272872554, 2732.740389662979, 2984.6418429788346, 27550.0, 27608.861955690292, 27733.445331093266, 27864.582031269547, 28108.297292567644, 3400.7619466637343, 3470.722342212617, 3473.6212226987236, 3476.217850983534, 3545.6808887200277, 172306.0, 173138.0, 173405.0, 173712.131439342, 173792.131039344, 51788.223176652384, 51920.22119668208, 52061.7396913013, 52080.73959630178, 52094.47905520972, 46577.30134047992, 46585.5341446588, 46671.76664116658, 46729.0, 46747.76626116848, 12997.935010324887, 13394.397252123677, 13395.397207125703, 13396.263205523595, 13401.530946417024, 9831.950840245752, 9854.11312981835, 9854.852177217348, 9857.014298570086, 9858.359206651545, 14109.153450792985, 14337.713245735236, 14372.568822935329, 14998.550043498712, 15007.874409419337, 5189.662671926389, 5906.527477801766, 5920.733566989496, 5989.55078369124, 6110.969445152835, 757.75373003774, 844.6248433116393, 856.8971723393108, 908.7137551671202, 946.3044662173297, 25964.87017564938, 27315.770790314087, 27549.724502754714, 27647.58528622072, 27662.170134895987, 990.2424645146468, 991.1327588360185, 993.7416271769392, 1003.7139415266614, 1009.0716540782498, 14071.507497237752, 14713.485028023968, 14835.406583736745, 15116.09303441797, 15144.0, 350453.0, 352308.0, 354233.0, 354400.0, 355236.0, 41408.0, 42439.57560424418, 46254.53745462569, 47507.524924751, 47590.524094759305, 1158.3050169898163, 1167.772284404533, 1175.1010476985114, 1181.3502573584494, 1183.7632473505505, 26682.0, 28206.294842629097, 28285.717142829133, 29038.854805725838, 29150.27124321909, 41602.1679566413, 42143.57856421397, 42172.789136054125, 42175.7891210542, 42226.36660450034, 318182.0, 320181.0, 320287.0, 321875.0, 321954.0, 34843.0, 34964.0, 35221.82389088038, 35477.29045419129, 35721.642783571835, 40219.597804021585, 40435.1912961745, 40559.0, 40948.79525602472, 41123.1775364497, 34009.65990340164, 34084.0, 34872.30255394929, 37710.24579508449, 38425.23149537049, 31727.04818855438, 31992.52011219787, 31997.360052798347, 32126.678733212368, 32148.196295091875, 31776.205594860312, 32367.19082022874, 32401.675983239867, 32571.674283256863, 32630.184245394055, 29959.70040299569, 32630.34739305248, 32809.50785738263, 32821.343573128885, 32897.34205315928, 24520.50958980775, 24908.12821551237, 24932.750672493043, 25036.248912532654, 25274.115405960703], "value": 16978.44290033426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.69059774409817, 350.1142110460536, 363.9781613103214, 370.9091272638204, 386.9996060184423, 12452.19060761051, 13253.536126235584, 13397.464101435942, 16375.4268600599, 16393.918030409863, 15279.541613751606, 15701.450449234251, 16119.677606447864, 16134.354625814982, 16138.112403817786, 4775.713457192571, 4974.676646018015, 4981.078500477405, 4986.775595098229, 4987.900241995158, 3691.169486865461, 3888.747231429962, 5424.647397919142, 5839.503642190419, 5889.057750759879, 5808.157817116516, 5923.14114453404, 5925.73334199962, 5927.525797936176, 5927.644341339534, 6473.093766872642, 6760.628165450874, 6779.254282028973, 6885.173779146535, 6903.620300883449, 6452.677366131675, 6515.3484651534945, 6540.247871494744, 6584.835379115512, 6641.601503909781, 23085.422864428354, 23295.417614559603, 23631.0, 23647.054117835265, 24015.0, 2026.8479864010258, 2074.263636409068, 2139.4544391180148, 2446.7920226780743, 2511.259178542316, 13488.797668034988, 14135.15189088658, 14214.218217998006, 15121.243937803067, 15522.146281954489, 1852.249838815282, 1866.4493974277484, 1906.4661894669514, 1923.8172373624484, 1928.9903550482159, 83540.99999999939, 83730.0, 84747.5762621189, 87138.0, 88563.11436885613, 15104.697906042038, 16252.75620865688, 16462.588435289214, 16532.669346613002, 16916.407925722542, 29145.854270728512, 29182.309449657536, 29210.12369628872, 29319.706802931698, 29426.411471770873, 8231.382646301552, 8473.745787626382, 8570.185832345916, 8718.95640521806, 8900.198982091642, 6944.618046007518, 7038.0, 7190.496665233488, 7223.241559636268, 7233.529820561646, 8221.465604735673, 8500.489970601784, 8535.487870727777, 8576.957115214384, 8639.740807775777, 3144.402563512925, 3333.150046738066, 3337.4326364517606, 3369.898903032913, 3408.5398471206568, 792.7304716396453, 853.9487630742175, 859.7721603775004, 880.212210071982, 897.4435849773182, 15565.120452716284, 16157.59606009859, 16802.41191558314, 16956.15219239033, 17348.479545613398, 802.9518228906285, 834.6953362022819, 837.5184269045324, 845.1759534453859, 864.2567392042838, 8860.822783544292, 8952.955235223912, 9323.160915517636, 9359.766005849771, 9428.717138485856, 364184.1188263384, 367219.0, 369151.0, 370016.0, 373368.0, 46517.30224046642, 46873.29690054652, 52649.736751316, 65920.0, 66678.33321666722, 876.1862943706593, 876.4390789894472, 901.2744740483973, 902.1609902790468, 903.5888670654837, 15360.923195383952, 15409.0, 16013.0, 16193.59516012109, 16236.918815405847, 37278.44082338713, 37298.627013729514, 37446.812765935996, 37768.244635107694, 38241.426378603785, 50588.0, 50710.74644626901, 50782.49217507778, 50786.0, 51305.48694513156, 4599.793009314656, 4869.683470574401, 5176.611754118381, 6928.515003949675, 7014.0, 11289.20975531705, 11524.539018439169, 11601.419929003685, 12335.938320308342, 12404.56584019555, 10234.130098941674, 10301.330413523097, 10326.690199294033, 10346.22403319739, 11040.061594764535, 9781.315307928377, 10224.744381390525, 10267.435291059064, 10552.472376381304, 10591.417472038804, 7492.812679683051, 7752.844943100994, 7836.0, 8206.548639824867, 10624.946875265574, 10863.348199108079, 10945.83581246298, 10962.835557466486, 11326.433678316216, 11640.0, 11246.606368777053, 11390.772184556428, 11551.018163455865, 11672.70818229551, 12020.33888136161], "value": 9031.992331391848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.8261434706312, 1334.132813671114, 1357.212816566391, 1616.862566681832, 1624.4964061141054, 6591.802245932624, 6846.726130954768, 6847.075644787952, 6850.177978642558, 6860.82847928802, 6116.541259405541, 6136.386361363861, 6261.686915654222, 6321.367863213676, 6881.311868813116, 2030.187924830065, 2073.2536286936765, 2074.5643414882816, 2074.9896250518727, 2075.9065842037144, 1933.0, 1990.532224927141, 1992.5217947692595, 2034.4812072921384, 2034.5625690476545, 1779.7063484525038, 1827.1503750755896, 1977.71323158142, 1986.2452268138159, 2047.5904819036252, 2071.0, 2072.668373060303, 2077.470245087493, 2078.1687325069943, 2078.532330225702, 1960.1277431542826, 2019.8889061101634, 2056.321413933413, 2056.95886082279, 2057.68105943579, 7056.964715176391, 7098.148222213315, 7099.680514376865, 7108.969199466049, 7109.0, 4110.568390319003, 4268.231718290706, 4283.186194623043, 4285.3786201000685, 4287.785610719451, 2628.106443809114, 2779.8888044478194, 2830.9433811323865, 2886.321714397115, 2896.3048868271676, 849.9022612399591, 863.952482613456, 896.4307664633005, 898.3980732908967, 914.5335878701843, 9285.396449230846, 9327.486988215645, 9338.813223735555, 9347.158755711951, 9381.0, 3646.872359467406, 3836.0, 3867.9226415472094, 3899.3176194166476, 3909.179072394772, 7981.2018798119725, 8010.679572817138, 8017.679292828221, 8047.919520804717, 8049.476784009138, 4201.894952626209, 4222.366645003212, 4226.1336426032585, 4228.175505776406, 4228.788560571959, 3680.4847321375028, 3840.0975770693863, 3843.3082045232127, 3851.114243723903, 3858.903527411781, 3286.392017476727, 3287.819169945676, 3382.4080785862375, 3398.150462384404, 3411.5394421752744, 1076.7738774857212, 1097.8023955687893, 1098.7253186703324, 1099.1097211258746, 1103.906167975731, 758.0600055930606, 777.1567848883911, 801.3789313282252, 813.983720325602, 824.0646865807232, 4701.764911754399, 4733.171694953369, 4766.261229509431, 4813.278008298713, 4960.181570040975, 389.52867030892935, 392.97052721045463, 397.67589414626985, 397.9880603581897, 398.2175026073721, 3052.664206937235, 3095.24166579185, 3117.6258848938273, 3131.4989601663624, 3265.346930613887, 7863.84272314562, 8229.95885020571, 8323.1260717625, 8334.708285209988, 8348.833023339499, 8074.757757267292, 8252.33981281496, 8283.130271321545, 8312.750617481484, 8334.749957501284, 6390.137331460193, 6532.8040158794365, 6542.705578248991, 6544.214694236722, 6545.934540654628, 4567.634589232787, 4610.193216187221, 4625.213713668617, 4646.767661616973, 4666.650001249987, 7413.0, 7480.850382992201, 7525.0, 7601.315881570686, 7642.3504002158215, 7838.412119091205, 7859.877832984947, 7867.842643146991, 7900.0, 7912.683492660229, 5548.472895074961, 5649.322081350264, 5702.486776190163, 5859.472647461749, 5899.734511946886, 6266.279377871603, 6326.145970293951, 6334.049892516159, 6339.207599050119, 6343.5876668016435, 5812.73842677089, 5929.881402372014, 6040.546958978006, 6074.42292982166, 6124.0, 5952.880942381042, 5957.672328021827, 5967.552433567413, 5980.222571065734, 6006.189164462741, 5735.770569177186, 5768.682722450306, 5803.042497987784, 5806.709664516673, 5807.622504537191, 3844.596317386634, 3875.9224815504094, 3951.3085210088693, 3979.960200397959, 4083.612056854594, 3960.6039396061315, 3963.3460479020637, 3977.482927219443, 3995.380715989026, 4017.6384125428854], "value": 3652.4266634755645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.77745139180314, 277.6903752316168, 279.8125256078427, 284.628559729553, 287.08849403144995, 4624.167649823031, 4779.187538118519, 4809.326694262806, 4820.493848145938, 4844.781984810683, 4743.573078422941, 4772.780656994497, 4778.569928706415, 4792.904141917168, 4813.278008298748, 3441.3633477806684, 3707.647773461517, 3738.55137383513, 3761.605031471697, 3766.5291838520184, 3764.868229611964, 3769.396896496561, 3778.2254637799183, 3782.432635104729, 3783.8486460541544, 3678.503402040717, 3703.3704270273984, 3703.7962912039825, 3733.2346868891946, 3738.47661327413, 3634.436662317345, 3737.5141231639986, 3739.626037396266, 3747.7376583639157, 3751.9812400938094, 3283.9343213135603, 3290.0952238134464, 3290.7696461247724, 3301.108700650811, 3329.667033296675, 4640.118377508296, 4641.907161856778, 4644.396228490308, 4658.743769092698, 4675.5558221969195, 4129.97935010326, 4232.343986682069, 4261.211675839949, 4266.850660226877, 4286.828526858922, 4833.903321933577, 4931.3835770528685, 4954.455009948902, 4954.851354459372, 5069.721165335942, 3570.214552798406, 3574.696150827183, 3575.964240357589, 3579.49887015818, 3583.5699716033982, 5212.0, 5219.43416974906, 5244.81643142492, 5253.212018197224, 5276.208568714724, 3383.3064221834466, 3551.4672799080345, 3704.9629503705155, 3705.166337574024, 3716.479692843004, 3615.403458429382, 3621.583517895423, 3629.364861149288, 3629.6914762245506, 3641.308151451216, 3932.3315036443873, 4043.7978101094827, 4162.458880345596, 4171.435711608147, 4173.99472379886, 4918.409790825052, 4994.675346102492, 4997.100521906019, 5000.2749601307605, 5017.7491125443585, 1204.7168915304896, 1220.0605533738972, 1222.113967373647, 1224.7691070474295, 1226.3868065967017, 800.7117437722416, 824.0976131136516, 824.2869917521421, 831.4055450353027, 838.0781140745131, 4326.199653064194, 4342.741774277358, 4349.304111342233, 4360.735386737811, 4362.258416069276, 4977.975110124498, 4984.159029353234, 4998.975005125024, 5031.622628302892, 5040.823571174991, 4318.78406079701, 4323.63249123828, 4334.674899382559, 4375.387445757597, 4384.539623339567, 2521.7730404263702, 2658.534756417619, 2658.8138830282082, 2665.6667916510437, 2670.212287375229, 4690.249560070372, 4698.546568272385, 4702.048649810359, 4720.167899260485, 4771.71369717818, 4930.7288099154175, 5068.391792984866, 5113.71874546896, 5161.690298582097, 5179.61152913533, 4589.5181005994555, 4698.875247960068, 4703.412073490814, 4706.435227772621, 4726.645501587326, 4951.430585482715, 4966.255061740623, 4973.403191617029, 4986.576141028053, 5020.397552293602, 4752.334673145693, 4900.128898170406, 4915.3855768029, 4950.504949505021, 4951.876203094951, 4641.976790116028, 4669.287916106771, 4706.694064885772, 4712.552307530779, 4724.6456515760765, 3490.1972546314996, 3493.12671832042, 3502.649735026477, 3503.2292895563955, 3535.15156362466, 4978.979309241669, 4996.825111121093, 5051.898962020666, 5065.164247899055, 5088.745562721775, 4660.883477913079, 4979.651424400257, 4984.252362145708, 4992.425871024879, 5012.87467813293, 4964.865108003449, 4984.850454486371, 5022.447530771539, 5033.748312584283, 5036.722980235975, 4750.698264705996, 4891.5353041461, 4907.306979092207, 4915.188993816123, 4930.778114984762, 4977.651564390458, 4996.300517927566, 5001.57486613642, 5024.572911302434, 5026.296318515338, 4897.46127925935, 4906.6320025997475, 4907.5828554571835, 4908.361912951294, 4909.288153217834], "value": 3715.4885835184264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.961227907907, 592.3277080513616, 600.147790138004, 611.6543604071044, 676.435176627516, 11522.711932201688, 12545.18456300341, 12613.999999999989, 12752.872471275285, 13350.265735384573, 12603.180793248455, 12775.680607984805, 12819.487220511168, 12826.0, 12827.037972152102, 736.6169591812254, 755.4258763339847, 756.4515726098562, 756.5158298688843, 756.7616200896728, 593.7239183779542, 611.60245840204, 734.6069852628845, 751.9172890981988, 761.8400135971452, 768.623374546471, 769.7190525458224, 770.0143815915609, 770.218228498075, 770.2297702297702, 766.2950085920966, 766.8734658781294, 768.8347005393812, 769.6536558548676, 769.742136384312, 464.80478199156437, 472.21376408280514, 561.2899681902396, 577.8757567123047, 580.8809194115196, 12512.374381280899, 12540.122191446602, 12541.561045363369, 12545.247285162919, 12545.686357841036, 11283.323000619988, 11285.548578056867, 11689.824652630217, 11970.40147992597, 12205.084618653636, 9201.0, 9240.815183696355, 9472.95263523678, 9804.411735295906, 9840.65557705477, 3144.3082521845386, 3159.984200078985, 3214.341060082701, 3302.9174270643184, 3383.390989621867, 57001.71499142519, 57426.42573574252, 58653.12020319699, 66859.3314066858, 67202.0, 10084.358680612311, 10183.898161018295, 10242.0, 10250.692479225636, 10391.792164156675, 18651.0, 18841.152148153367, 18893.338733144275, 18907.716384254247, 19044.61910761777, 6457.192850893638, 6464.41820236181, 6531.673416329259, 6536.379043990813, 6803.0135630333325, 3508.4388396470717, 3535.5403797506674, 3537.8054207018345, 3568.8750893718593, 3616.5298511193378, 2726.4001919577663, 2830.433913217365, 2838.0634390651035, 2838.8012839101066, 2839.716028397144, 448.89450979019904, 454.7476150736307, 457.22728588685015, 464.4937018649688, 470.05988023952096, 485.69401277195846, 567.5970061256471, 573.249043752677, 581.9970900145472, 588.153059594183, 7871.957212634582, 8055.516668999879, 8171.79570510742, 8320.70877519284, 8506.914930850737, 475.76449657419107, 502.83406475862876, 507.17077578159973, 555.3335996803852, 569.7806344557292, 3860.8069596520063, 3906.4726261954274, 4041.373587094005, 4072.0, 4090.9181816363507, 51305.0, 52510.73744631329, 52903.470965290624, 62981.37018629847, 69716.0, 43489.0, 44758.55241447544, 44875.55124448779, 46040.0, 57069.42930570724, 51064.0, 51399.743001284754, 51955.0, 51991.740041300305, 52441.21338179854, 8633.784155396166, 8755.474671519729, 9098.272138229058, 9123.498207598646, 9290.767730806514, 36350.8182459086, 36548.81725591355, 37028.44457333088, 37094.62905370912, 39237.0, 44950.55049449464, 45127.7743611293, 49537.75231123965, 51756.74121629518, 52686.0, 10705.143588513056, 10833.566657333618, 10842.241043126905, 10985.560577576807, 11179.385133817717, 11368.431578420881, 11780.234284771463, 11780.764384712087, 11840.940795296314, 12216.87783122193, 8612.65549378018, 11007.669769906915, 11087.44562771842, 11256.155788315746, 11468.885311146782, 11093.5562577496, 11300.09599232076, 11345.659630211107, 11636.36000020007, 12032.458539365925, 11463.369514676773, 11553.768924621292, 11740.765184696429, 12195.451204695988, 12376.257424554195, 9507.477088760184, 9934.354266972623, 9971.650992215238, 10138.49307534635, 10671.146308295472, 9962.750931226778, 10329.225308101772, 10384.221183411124, 10519.421431821323, 10801.621943231949], "value": 6011.825094190178, "unit": "score"}], "name": "dromaeo_css", "value": 6207.885526099308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 133.0, 191.0, 132.0, 138.0, 139.0, 130.0, 153.0, 129.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 160.0, 161.0, 159.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 108.0, 76.0, 77.0, 78.0, 76.0, 96.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 84.0, 84.0, 101.0, 83.0, 83.0, 107.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 76.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 96.0, 88.0, 85.0, 88.0, 85.0, 84.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 143.0, 148.0, 155.0, 159.0, 156.0, 143.0, 199.0, 141.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 180.0, 180.0, 179.0, 181.0, 180.0, 179.0, 183.0, 180.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 76.0, 72.0, 73.0, 72.0, 70.0, 72.0, 70.0, 70.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1579.1999999999998, "alertThreshold": 2.0}]} 03:04:16 INFO - Return code: 0 03:04:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:04:16 INFO - # TBPL SUCCESS # 03:04:16 INFO - Running post-action listener: _resource_record_post_action 03:04:16 INFO - [mozharness: 2016-11-28 11:04:16.327758Z] Finished run-tests step (success) 03:04:16 INFO - Running post-run listener: _resource_record_post_run 03:04:16 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297373696; Read time: 12; Write time: 289444 03:04:16 INFO - TinderboxPrint: CPU usage
13.1% 03:04:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:04:16 INFO - TinderboxPrint: I/O write bytes / time
297,373,696 / 289,444 03:04:16 INFO - TinderboxPrint: CPU idle
8,352.6 (86.9%) 03:04:16 INFO - TinderboxPrint: CPU user
1,211.1 (12.6%) 03:04:16 INFO - TinderboxPrint: Swap in / out
0 / 0 03:04:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8642560; Read time: 0; Write time: 5996 03:04:16 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 288731136; Read time: 0; Write time: 283448 03:04:16 INFO - Running post-run listener: _upload_blobber_files 03:04:16 INFO - Blob upload gear active. 03:04:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:04:16 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 03:04:16 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'] 03:04:16 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 03:04:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:04:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:04:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:04:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:18 INFO - (blobuploader) - INFO - Done attempting. 03:04:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:04:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:04:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:19 INFO - (blobuploader) - INFO - Done attempting. 03:04:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:04:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:04:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:22 INFO - (blobuploader) - INFO - Done attempting. 03:04:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:04:22 INFO - Return code: 0 03:04:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:04:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:04:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f1dba4f6437178f5e8a7042759c45aad21906b37bb45375ee8a956ea0c361a43eb8476c6f171d2b019c64465839ae5bf635595ae5c8d125e704dbe72ac5317ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14989a3951170531efaaa488168fdc9ec792a92632589ce8b53c00eea7ca3e689b5b61281fc77b272e60a7211e36df90e801befd0322b5c74386c8693fb221b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c0cd0fb5151f71475def6abe00efc8f246c829cc6fec37c80e62b1fe69400ea07d978283a6a4f13f13be8d7a6f1e572ab753c1490212f354011bb1dedf3a12c"} 03:04:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:04:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:04:22 INFO - Contents: 03:04:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f1dba4f6437178f5e8a7042759c45aad21906b37bb45375ee8a956ea0c361a43eb8476c6f171d2b019c64465839ae5bf635595ae5c8d125e704dbe72ac5317ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14989a3951170531efaaa488168fdc9ec792a92632589ce8b53c00eea7ca3e689b5b61281fc77b272e60a7211e36df90e801befd0322b5c74386c8693fb221b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c0cd0fb5151f71475def6abe00efc8f246c829cc6fec37c80e62b1fe69400ea07d978283a6a4f13f13be8d7a6f1e572ab753c1490212f354011bb1dedf3a12c"} 03:04:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:04:22 INFO - Copying logs to upload dir... 03:04:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:04:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.971959 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-28 03:04:21.571834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 03:04:21.576703) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922 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/f1dba4f6437178f5e8a7042759c45aad21906b37bb45375ee8a956ea0c361a43eb8476c6f171d2b019c64465839ae5bf635595ae5c8d125e704dbe72ac5317ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14989a3951170531efaaa488168fdc9ec792a92632589ce8b53c00eea7ca3e689b5b61281fc77b272e60a7211e36df90e801befd0322b5c74386c8693fb221b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c0cd0fb5151f71475def6abe00efc8f246c829cc6fec37c80e62b1fe69400ea07d978283a6a4f13f13be8d7a6f1e572ab753c1490212f354011bb1dedf3a12c"} build_url:https://queue.taskcluster.net/v1/task/F5g7bqeFRWGkfjFzEqQYHg/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/F5g7bqeFRWGkfjFzEqQYHg/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/f1dba4f6437178f5e8a7042759c45aad21906b37bb45375ee8a956ea0c361a43eb8476c6f171d2b019c64465839ae5bf635595ae5c8d125e704dbe72ac5317ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14989a3951170531efaaa488168fdc9ec792a92632589ce8b53c00eea7ca3e689b5b61281fc77b272e60a7211e36df90e801befd0322b5c74386c8693fb221b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c0cd0fb5151f71475def6abe00efc8f246c829cc6fec37c80e62b1fe69400ea07d978283a6a4f13f13be8d7a6f1e572ab753c1490212f354011bb1dedf3a12c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 03:04:21.614456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:04:21.615048) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480329009.466684-352043922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:04:21.693305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 03:04:21.693647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 03:04:21.693954) ========= ========= Total master_lag: 0.19 =========