builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1475856666.19 results: success (0) buildid: 20161007074400 builduid: 3334b5df92a541c2a9071274a29d4eff revision: 7e8ddcf9716aea87e598333e2970437c94173334 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.194578) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.195103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.195400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.207201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.207726) ========= 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=523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 09:11:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-10-07 09:11:07 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105750 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.325944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.326298) ========= 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=523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020681 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.376368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:06.376861) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7e8ddcf9716aea87e598333e2970437c94173334 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 7e8ddcf9716aea87e598333e2970437c94173334 --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=523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 09:11:07,587 truncating revision to first 12 chars 2016-10-07 09:11:07,588 Setting DEBUG logging. 2016-10-07 09:11:07,588 attempt 1/10 2016-10-07 09:11:07,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7e8ddcf9716a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 09:11:08,049 unpacking tar archive at: autoland-7e8ddcf9716a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800498 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:07.191691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:07.192014) ========= script_repo_revision: 7e8ddcf9716aea87e598333e2970437c94173334 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:07.192479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:07.192753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 09:11:07.202571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-07 09:11:07.203205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:11:08 INFO - MultiFileLogger online at 20161007 09:11:08 in /builds/slave/test 09:11:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:11:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:11:08 INFO - {'append_to_log': False, 09:11:08 INFO - 'base_work_dir': '/builds/slave/test', 09:11:08 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:11:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:11:08 INFO - 'branch': 'Autoland-Non-PGO', 09:11:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:08 INFO - 'config_files': ('talos/linux_config.py',), 09:11:08 INFO - 'default_actions': ('clobber', 09:11:08 INFO - 'read-buildbot-config', 09:11:08 INFO - 'download-and-extract', 09:11:08 INFO - 'populate-webroot', 09:11:08 INFO - 'create-virtualenv', 09:11:08 INFO - 'install', 09:11:08 INFO - 'run-tests'), 09:11:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:08 INFO - 'download_minidump_stackwalk': True, 09:11:08 INFO - 'download_symbols': 'ondemand', 09:11:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:08 INFO - 'installer_path': 'installer.exe', 09:11:08 INFO - 'log_level': 'info', 09:11:08 INFO - 'log_name': 'talos', 09:11:08 INFO - 'log_to_console': True, 09:11:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:11:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:11:08 INFO - 'opt_config_files': (), 09:11:08 INFO - 'pip_index': False, 09:11:08 INFO - 'sps_profile': False, 09:11:08 INFO - 'sps_profile_interval': 0, 09:11:08 INFO - 'suite': 'dromaeojs', 09:11:08 INFO - 'system_bits': '32', 09:11:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:08 INFO - 'title': 'talos-linux64-ix-065', 09:11:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:08 INFO - 'use_talos_json': True, 09:11:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:11:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:08 INFO - 'work_dir': 'build'} 09:11:08 INFO - [mozharness: 2016-10-07 16:11:08.515977Z] Running clobber step. 09:11:08 INFO - Running pre-action listener: _resource_record_pre_action 09:11:08 INFO - Running main action method: clobber 09:11:08 INFO - rmtree: /builds/slave/test/build 09:11:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:11:09 INFO - Running post-action listener: _resource_record_post_action 09:11:09 INFO - [mozharness: 2016-10-07 16:11:09.500277Z] Finished clobber step (success) 09:11:09 INFO - [mozharness: 2016-10-07 16:11:09.500376Z] Running read-buildbot-config step. 09:11:09 INFO - Running pre-action listener: _resource_record_pre_action 09:11:09 INFO - Running main action method: read_buildbot_config 09:11:09 INFO - Using buildbot properties: 09:11:09 INFO - { 09:11:09 INFO - "project": "", 09:11:09 INFO - "product": "firefox", 09:11:09 INFO - "script_repo_revision": "production", 09:11:09 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:11:09 INFO - "repository": "", 09:11:09 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:11:09 INFO - "buildid": "20161007074400", 09:11:09 INFO - "pgo_build": "False", 09:11:09 INFO - "basedir": "/builds/slave/test", 09:11:09 INFO - "buildnumber": 668, 09:11:09 INFO - "slavename": "talos-linux64-ix-065", 09:11:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:11:09 INFO - "platform": "ubuntu64_hw", 09:11:09 INFO - "scheduler": "tests-autoland-linux64-talos", 09:11:09 INFO - "branch": "autoland", 09:11:09 INFO - "repo_path": "integration/autoland", 09:11:09 INFO - "revision": "7e8ddcf9716aea87e598333e2970437c94173334", 09:11:09 INFO - "stage_platform": "linux64", 09:11:09 INFO - "builduid": "3334b5df92a541c2a9071274a29d4eff", 09:11:09 INFO - "slavebuilddir": "test" 09:11:09 INFO - } 09:11:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:11:09 INFO - Running post-action listener: _resource_record_post_action 09:11:09 INFO - [mozharness: 2016-10-07 16:11:09.502860Z] Finished read-buildbot-config step (success) 09:11:09 INFO - [mozharness: 2016-10-07 16:11:09.502949Z] Running download-and-extract step. 09:11:09 INFO - Running pre-action listener: _resource_record_pre_action 09:11:09 INFO - Running main action method: download_and_extract 09:11:09 INFO - mkdir: /builds/slave/test/build/tests 09:11: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')]} 09:11:09 INFO - trying https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:11:09 INFO - Downloading https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:11:10 INFO - Downloaded 1361 bytes. 09:11:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:11:10 INFO - Using the following test package requirements: 09:11:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:11:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:11:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:11:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'jsshell-linux-x86_64.zip'], 09:11:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:11:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:11:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:11:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:11:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:11:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:11:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:11:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:11:10 INFO - Http code: 200 09:11:10 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:11:10 INFO - x-amz-cf-id: 8oIqOnzpvw9n2yVYU_lAH5R0g6qzruRM5edpzR9QH7AC5tHp1c7S2w== 09:11:10 INFO - x-amz-version-id: lP1B5n7DaZwwez4R5TgpfMmi0LC4A8jl 09:11:10 INFO - Expected file size: 20462086 09:11:10 INFO - Obtained file size: 20462086 09:11:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:11:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:11:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:11:14 INFO - Fetch https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:11:15 INFO - Http code: 200 09:11:15 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 09:11:15 INFO - x-amz-cf-id: h9Fgr7uXOEavxZkdwWxvV1c-FoxtHghJjd97eqMTGNFIfvRcs78a4w== 09:11:15 INFO - x-amz-version-id: lP1B5n7DaZwwez4R5TgpfMmi0LC4A8jl 09:11:15 INFO - Expected file size: 20462086 09:11:15 INFO - Obtained file size: 20462086 09:11:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:11:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:11:20 INFO - Fetch https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:11:20 INFO - Http code: 200 09:11:20 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:11:20 INFO - x-amz-cf-id: 3nJh3zqO5owjH8pbbPbfXpneNmoZ3rpQXLWWn32tQGpe5lO8cmHUSA== 09:11:20 INFO - x-amz-version-id: G0H7aWul0QvUdiu7pbn03o_ysoOmaOCn 09:11:20 INFO - Expected file size: 14409006 09:11:20 INFO - Obtained file size: 14409006 09:11:21 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')]} 09:11:21 INFO - trying https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:11:21 INFO - Downloading https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:11:22 INFO - Downloaded 55881692 bytes. 09:11:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:11:22 INFO - mkdir: /builds/slave/test/properties 09:11:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:22 INFO - Contents: 09:11:22 INFO - build_url:https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:11:23 INFO - Running post-action listener: _resource_record_post_action 09:11:23 INFO - Running post-action listener: set_extra_try_arguments 09:11:23 INFO - [mozharness: 2016-10-07 16:11:23.430012Z] Finished download-and-extract step (success) 09:11:23 INFO - [mozharness: 2016-10-07 16:11:23.430238Z] Running populate-webroot step. 09:11:23 INFO - Running pre-action listener: _resource_record_pre_action 09:11:23 INFO - Running main action method: populate_webroot 09:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:23 INFO - '--tppagecycles', 09:11:23 INFO - '7'], 09:11:23 INFO - 'tests': ['tsvgm']}}, 09:11:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['damp', 'tps']}, 09:11:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'tests': ['damp', 'tps']}, 09:11:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['dromaeo_dom']}, 09:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['basic_compositor_video']}, 09:11:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:11:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['a11yr', 09:11:23 INFO - 'ts_paint', 09:11:23 INFO - 'tpaint', 09:11:23 INFO - 'sessionrestore', 09:11:23 INFO - 'sessionrestore_no_auto_restore', 09:11:23 INFO - 'tabpaint']}, 09:11:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:23 INFO - 'ts_paint', 09:11:23 INFO - 'tpaint', 09:11:23 INFO - 'sessionrestore', 09:11:23 INFO - 'sessionrestore_no_auto_restore', 09:11:23 INFO - 'tabpaint']}, 09:11:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:11:23 INFO - 'ts_paint', 09:11:23 INFO - 'tpaint', 09:11:23 INFO - 'sessionrestore', 09:11:23 INFO - 'sessionrestore_no_auto_restore', 09:11:23 INFO - 'tabpaint']}, 09:11:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:11:23 INFO - 'ts_paint', 09:11:23 INFO - 'tpaint', 09:11:23 INFO - 'sessionrestore', 09:11:23 INFO - 'sessionrestore_no_auto_restore', 09:11:23 INFO - 'tabpaint']}, 09:11:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['a11yr', 09:11:23 INFO - 'ts_paint', 09:11:23 INFO - 'tpaint', 09:11:23 INFO - 'sessionrestore', 09:11:23 INFO - 'sessionrestore_no_auto_restore', 09:11:23 INFO - 'tabpaint']}, 09:11:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['a11yr', 09:11:23 INFO - 'ts_paint', 09:11:23 INFO - 'tpaint', 09:11:23 INFO - 'sessionrestore', 09:11:23 INFO - 'sessionrestore_no_auto_restore', 09:11:23 INFO - 'tabpaint']}, 09:11:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['tsvgx', 09:11:23 INFO - 'tsvgr_opacity', 09:11:23 INFO - 'tart', 09:11:23 INFO - 'tscrollx', 09:11:23 INFO - 'cart']}, 09:11:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:23 INFO - 'tsvgr_opacity', 09:11:23 INFO - 'tart', 09:11:23 INFO - 'tscrollx', 09:11:23 INFO - 'cart']}, 09:11:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'talos_options': ['--disable-e10s'], 09:11:23 INFO - 'tests': ['tp5o']}, 09:11:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'tests': ['tp5o']}, 09:11:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'talos_options': ['--disable-e10s', 09:11:23 INFO - '--xperf_path', 09:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:23 INFO - 'tests': ['tp5n']}, 09:11:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:23 INFO - 'talos_options': ['--xperf_path', 09:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:23 INFO - 'tests': ['tp5n']}}, 09:11:23 INFO - 'talos.zip': {'path': '', 09:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:23 INFO - Running post-action listener: _resource_record_post_action 09:11:23 INFO - [mozharness: 2016-10-07 16:11:23.450009Z] Finished populate-webroot step (success) 09:11:23 INFO - [mozharness: 2016-10-07 16:11:23.450097Z] Running create-virtualenv step. 09:11:23 INFO - Running pre-action listener: _resource_record_pre_action 09:11:23 INFO - Running main action method: create_virtualenv 09:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:23 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 09:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:23 INFO - Using real prefix '/usr' 09:11:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:26 INFO - Installing pip.................done. 09:11:26 INFO - Return code: 0 09:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:11:26 INFO - Reading from file tmpfile_stdout 09:11:26 INFO - Output received: 09:11:26 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) 09:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:26 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 09:11:26 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 09:11:26 INFO - Using env: {'DISPLAY': ':0', 09:11:26 INFO - 'HOME': '/home/cltbld', 09:11:26 INFO - 'LANG': 'en_US.UTF-8', 09:11:26 INFO - 'LANGUAGE': 'en_US:en', 09:11:26 INFO - 'LOGNAME': 'cltbld', 09:11:26 INFO - 'MAIL': '/var/mail/cltbld', 09:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:26 INFO - 'MOZ_NO_REMOTE': '1', 09:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:26 INFO - 'NO_EM_RESTART': '1', 09:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:26 INFO - 'PWD': '/builds/slave/test', 09:11:26 INFO - 'SHELL': '/bin/bash', 09:11:26 INFO - 'SHLVL': '1', 09:11:26 INFO - 'TERM': 'linux', 09:11:26 INFO - 'TMOUT': '86400', 09:11:26 INFO - 'USER': 'cltbld', 09:11:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:26 INFO - '_': '/tools/buildbot/bin/python'} 09:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:26 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 09:11:26 INFO - Cleaning up... 09:11:26 INFO - Return code: 0 09:11:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:26 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 09:11:26 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 09:11:26 INFO - Using env: {'DISPLAY': ':0', 09:11:26 INFO - 'HOME': '/home/cltbld', 09:11:26 INFO - 'LANG': 'en_US.UTF-8', 09:11:26 INFO - 'LANGUAGE': 'en_US:en', 09:11:26 INFO - 'LOGNAME': 'cltbld', 09:11:26 INFO - 'MAIL': '/var/mail/cltbld', 09:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:26 INFO - 'MOZ_NO_REMOTE': '1', 09:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:26 INFO - 'NO_EM_RESTART': '1', 09:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:26 INFO - 'PWD': '/builds/slave/test', 09:11:26 INFO - 'SHELL': '/bin/bash', 09:11:26 INFO - 'SHLVL': '1', 09:11:26 INFO - 'TERM': 'linux', 09:11:26 INFO - 'TMOUT': '86400', 09:11:26 INFO - 'USER': 'cltbld', 09:11:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:26 INFO - '_': '/tools/buildbot/bin/python'} 09:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:26 INFO - Downloading/unpacking psutil>=3.1.1 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:28 INFO - Installing collected packages: psutil 09:11:28 INFO - Running setup.py install for psutil 09:11:28 INFO - building 'psutil._psutil_linux' extension 09:11:28 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 09:11:28 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 09:11:28 INFO - building 'psutil._psutil_posix' extension 09:11:28 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 09:11:29 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 09:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:29 INFO - Successfully installed psutil 09:11:29 INFO - Cleaning up... 09:11:29 INFO - Return code: 0 09:11:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:29 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')]} 09:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:29 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')]} 09:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:29 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:29 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 09:11:29 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 09:11:29 INFO - Using env: {'DISPLAY': ':0', 09:11:29 INFO - 'HOME': '/home/cltbld', 09:11:29 INFO - 'LANG': 'en_US.UTF-8', 09:11:29 INFO - 'LANGUAGE': 'en_US:en', 09:11:29 INFO - 'LOGNAME': 'cltbld', 09:11:29 INFO - 'MAIL': '/var/mail/cltbld', 09:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:29 INFO - 'MOZ_NO_REMOTE': '1', 09:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:29 INFO - 'NO_EM_RESTART': '1', 09:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:29 INFO - 'PWD': '/builds/slave/test', 09:11:29 INFO - 'SHELL': '/bin/bash', 09:11:29 INFO - 'SHLVL': '1', 09:11:29 INFO - 'TERM': 'linux', 09:11:29 INFO - 'TMOUT': '86400', 09:11:29 INFO - 'USER': 'cltbld', 09:11:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:29 INFO - '_': '/tools/buildbot/bin/python'} 09:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:29 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 09:11:29 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 09:11:29 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 09:11:29 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 09:11:29 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 09:11:29 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 09:11:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:31 INFO - Installing collected packages: mozsystemmonitor 09:11:31 INFO - Running setup.py install for mozsystemmonitor 09:11:31 INFO - Successfully installed mozsystemmonitor 09:11:31 INFO - Cleaning up... 09:11:31 INFO - Return code: 0 09:11:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11:31 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')]} 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:31 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')]} 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:31 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:31 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 09:11:31 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 09:11:31 INFO - Using env: {'DISPLAY': ':0', 09:11:31 INFO - 'HOME': '/home/cltbld', 09:11:31 INFO - 'LANG': 'en_US.UTF-8', 09:11:31 INFO - 'LANGUAGE': 'en_US:en', 09:11:31 INFO - 'LOGNAME': 'cltbld', 09:11:31 INFO - 'MAIL': '/var/mail/cltbld', 09:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:31 INFO - 'MOZ_NO_REMOTE': '1', 09:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:31 INFO - 'NO_EM_RESTART': '1', 09:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:31 INFO - 'PWD': '/builds/slave/test', 09:11:31 INFO - 'SHELL': '/bin/bash', 09:11:31 INFO - 'SHLVL': '1', 09:11:31 INFO - 'TERM': 'linux', 09:11:31 INFO - 'TMOUT': '86400', 09:11:31 INFO - 'USER': 'cltbld', 09:11:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:31 INFO - '_': '/tools/buildbot/bin/python'} 09:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:31 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 09:11:31 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 09:11:31 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 09:11:31 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 09:11:31 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 09:11:31 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 09:11:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:33 INFO - warning: no files found matching '*.txt' 09:11:33 INFO - no previously-included directories found matching 'build' 09:11:33 INFO - no previously-included directories found matching 'dist' 09:11:33 INFO - no previously-included directories found matching '.git*' 09:11:33 INFO - Installing collected packages: jsonschema, functools32 09:11:34 INFO - Running setup.py install for functools32 09:11:34 INFO - warning: no files found matching '*.txt' 09:11:34 INFO - no previously-included directories found matching 'build' 09:11:34 INFO - no previously-included directories found matching 'dist' 09:11:34 INFO - no previously-included directories found matching '.git*' 09:11:34 INFO - Successfully installed jsonschema functools32 09:11:34 INFO - Cleaning up... 09:11:34 INFO - Return code: 0 09:11:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:11:34 INFO - Using env: {'DISPLAY': ':0', 09:11:34 INFO - 'HOME': '/home/cltbld', 09:11:34 INFO - 'LANG': 'en_US.UTF-8', 09:11:34 INFO - 'LANGUAGE': 'en_US:en', 09:11:34 INFO - 'LOGNAME': 'cltbld', 09:11:34 INFO - 'MAIL': '/var/mail/cltbld', 09:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:34 INFO - 'MOZ_NO_REMOTE': '1', 09:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:34 INFO - 'NO_EM_RESTART': '1', 09:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:34 INFO - 'PWD': '/builds/slave/test', 09:11:34 INFO - 'SHELL': '/bin/bash', 09:11:34 INFO - 'SHLVL': '1', 09:11:34 INFO - 'TERM': 'linux', 09:11:34 INFO - 'TMOUT': '86400', 09:11:34 INFO - 'USER': 'cltbld', 09:11:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:34 INFO - '_': '/tools/buildbot/bin/python'} 09:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:34 INFO - Cleaning up... 09:11:34 INFO - Return code: 0 09:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:11:34 INFO - Using env: {'DISPLAY': ':0', 09:11:34 INFO - 'HOME': '/home/cltbld', 09:11:34 INFO - 'LANG': 'en_US.UTF-8', 09:11:34 INFO - 'LANGUAGE': 'en_US:en', 09:11:34 INFO - 'LOGNAME': 'cltbld', 09:11:34 INFO - 'MAIL': '/var/mail/cltbld', 09:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:34 INFO - 'MOZ_NO_REMOTE': '1', 09:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:34 INFO - 'NO_EM_RESTART': '1', 09:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:34 INFO - 'PWD': '/builds/slave/test', 09:11:34 INFO - 'SHELL': '/bin/bash', 09:11:34 INFO - 'SHLVL': '1', 09:11:34 INFO - 'TERM': 'linux', 09:11:34 INFO - 'TMOUT': '86400', 09:11:34 INFO - 'USER': 'cltbld', 09:11:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:34 INFO - '_': '/tools/buildbot/bin/python'} 09:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:34 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 09:11:34 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 09:11:34 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 09:11:34 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 09:11:34 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 09:11:34 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 09:11:36 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:37 INFO - Downloading docopt-0.6.1.tar.gz 09:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:37 INFO - Running setup.py install for blobuploader 09:11:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:37 INFO - Running setup.py install for requests 09:11:37 INFO - Running setup.py install for docopt 09:11:37 INFO - Successfully installed blobuploader requests docopt 09:11:37 INFO - Cleaning up... 09:11:37 INFO - Return code: 0 09:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:37 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:37 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 09:11:37 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 09:11:37 INFO - Using env: {'DISPLAY': ':0', 09:11:37 INFO - 'HOME': '/home/cltbld', 09:11:37 INFO - 'LANG': 'en_US.UTF-8', 09:11:37 INFO - 'LANGUAGE': 'en_US:en', 09:11:37 INFO - 'LOGNAME': 'cltbld', 09:11:37 INFO - 'MAIL': '/var/mail/cltbld', 09:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:37 INFO - 'MOZ_NO_REMOTE': '1', 09:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:37 INFO - 'NO_EM_RESTART': '1', 09:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:37 INFO - 'PWD': '/builds/slave/test', 09:11:37 INFO - 'SHELL': '/bin/bash', 09:11:37 INFO - 'SHLVL': '1', 09:11:37 INFO - 'TERM': 'linux', 09:11:37 INFO - 'TMOUT': '86400', 09:11:37 INFO - 'USER': 'cltbld', 09:11:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:37 INFO - '_': '/tools/buildbot/bin/python'} 09:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:38 INFO - Running setup.py (path:/tmp/pip-Omhhcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:38 INFO - Running setup.py (path:/tmp/pip-pzhyZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:38 INFO - Running setup.py (path:/tmp/pip-YC1OkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:38 INFO - Running setup.py (path:/tmp/pip-UmYG7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:38 INFO - Running setup.py (path:/tmp/pip-6foT3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:38 INFO - Running setup.py (path:/tmp/pip-Y1Ljis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:38 INFO - Running setup.py (path:/tmp/pip-rPLhyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:38 INFO - Running setup.py (path:/tmp/pip-FAgl51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:38 INFO - Running setup.py (path:/tmp/pip-sU7sfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:38 INFO - Running setup.py (path:/tmp/pip-z8sl2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:38 INFO - Running setup.py (path:/tmp/pip-YNqj0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:38 INFO - Running setup.py (path:/tmp/pip-afneYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:38 INFO - Running setup.py (path:/tmp/pip-MbfmLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:39 INFO - Running setup.py (path:/tmp/pip-HvMi9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:39 INFO - Running setup.py (path:/tmp/pip-pgiwh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:39 INFO - Running setup.py (path:/tmp/pip-APDSYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:39 INFO - Running setup.py (path:/tmp/pip-OKjuaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:39 INFO - Running setup.py install for manifestparser 09:11:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:39 INFO - Running setup.py install for mozcrash 09:11:39 INFO - Running setup.py install for mozdebug 09:11:39 INFO - Running setup.py install for mozdevice 09:11:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:11:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:39 INFO - Running setup.py install for mozfile 09:11:39 INFO - Running setup.py install for mozhttpd 09:11:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:39 INFO - Running setup.py install for mozinfo 09:11:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Running setup.py install for mozInstall 09:11:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Running setup.py install for mozleak 09:11:40 INFO - Running setup.py install for mozlog 09:11:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Running setup.py install for moznetwork 09:11:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Running setup.py install for mozprocess 09:11:40 INFO - Running setup.py install for mozprofile 09:11:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Running setup.py install for mozrunner 09:11:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:40 INFO - Running setup.py install for mozscreenshot 09:11:40 INFO - Running setup.py install for moztest 09:11:40 INFO - Running setup.py install for mozversion 09:11:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:41 INFO - Cleaning up... 09:11:41 INFO - Return code: 0 09:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:41 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:41 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 09:11:41 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 09:11:41 INFO - Using env: {'DISPLAY': ':0', 09:11:41 INFO - 'HOME': '/home/cltbld', 09:11:41 INFO - 'LANG': 'en_US.UTF-8', 09:11:41 INFO - 'LANGUAGE': 'en_US:en', 09:11:41 INFO - 'LOGNAME': 'cltbld', 09:11:41 INFO - 'MAIL': '/var/mail/cltbld', 09:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:41 INFO - 'MOZ_NO_REMOTE': '1', 09:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:41 INFO - 'NO_EM_RESTART': '1', 09:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:41 INFO - 'PWD': '/builds/slave/test', 09:11:41 INFO - 'SHELL': '/bin/bash', 09:11:41 INFO - 'SHLVL': '1', 09:11:41 INFO - 'TERM': 'linux', 09:11:41 INFO - 'TMOUT': '86400', 09:11:41 INFO - 'USER': 'cltbld', 09:11:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:41 INFO - '_': '/tools/buildbot/bin/python'} 09:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:41 INFO - Running setup.py (path:/tmp/pip-8ADMz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:41 INFO - Running setup.py (path:/tmp/pip-stdaJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:41 INFO - Running setup.py (path:/tmp/pip-t4EmwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:41 INFO - Running setup.py (path:/tmp/pip-yekePe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:41 INFO - Running setup.py (path:/tmp/pip-qdrt4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:41 INFO - Running setup.py (path:/tmp/pip-sBGw7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:41 INFO - Running setup.py (path:/tmp/pip-LPkqqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:41 INFO - Running setup.py (path:/tmp/pip-qXmOIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:41 INFO - Running setup.py (path:/tmp/pip-yJXQ1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:41 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)) 09:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:41 INFO - Running setup.py (path:/tmp/pip-KD2FVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:42 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)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:42 INFO - Running setup.py (path:/tmp/pip-akKuh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:42 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)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:42 INFO - Running setup.py (path:/tmp/pip-XnEQ1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:42 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)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:42 INFO - Running setup.py (path:/tmp/pip-BGNYPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:42 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)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:42 INFO - Running setup.py (path:/tmp/pip-nRHR6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:42 INFO - Running setup.py (path:/tmp/pip-F9OTPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:42 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)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:42 INFO - Running setup.py (path:/tmp/pip-ieOM2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:42 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)) 09:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:42 INFO - Running setup.py (path:/tmp/pip-cALgsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:42 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)) 09:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:11:42 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)) 09:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:11:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:44 INFO - Downloading blessings-1.6.tar.gz 09:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:44 INFO - Installing collected packages: blessings 09:11:44 INFO - Running setup.py install for blessings 09:11:44 INFO - Successfully installed blessings 09:11:44 INFO - Cleaning up... 09:11:44 INFO - Return code: 0 09:11:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:44 INFO - Reading from file tmpfile_stdout 09:11:44 INFO - Current package versions: 09:11:44 INFO - argparse == 1.2.1 09:11:44 INFO - blessings == 1.6 09:11:44 INFO - blobuploader == 1.2.4 09:11:44 INFO - docopt == 0.6.1 09:11:44 INFO - functools32 == 3.2.3-2 09:11:44 INFO - jsonschema == 2.5.1 09:11:44 INFO - manifestparser == 1.1 09:11:44 INFO - mozInstall == 1.12 09:11:44 INFO - mozcrash == 0.17 09:11:44 INFO - mozdebug == 0.1 09:11:44 INFO - mozdevice == 0.48 09:11:44 INFO - mozfile == 1.2 09:11:44 INFO - mozhttpd == 0.7 09:11:44 INFO - mozinfo == 0.9 09:11:44 INFO - mozleak == 0.1 09:11:44 INFO - mozlog == 3.4 09:11:44 INFO - moznetwork == 0.27 09:11:44 INFO - mozprocess == 0.23 09:11:44 INFO - mozprofile == 0.28 09:11:44 INFO - mozrunner == 6.12 09:11:44 INFO - mozscreenshot == 0.1 09:11:44 INFO - mozsystemmonitor == 0.3 09:11:44 INFO - moztest == 0.7 09:11:44 INFO - mozversion == 1.4 09:11:44 INFO - psutil == 3.1.1 09:11:44 INFO - requests == 1.2.3 09:11:44 INFO - wsgiref == 0.1.2 09:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:44 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:44 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 09:11:44 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 09:11:44 INFO - Using env: {'DISPLAY': ':0', 09:11:44 INFO - 'HOME': '/home/cltbld', 09:11:44 INFO - 'LANG': 'en_US.UTF-8', 09:11:44 INFO - 'LANGUAGE': 'en_US:en', 09:11:44 INFO - 'LOGNAME': 'cltbld', 09:11:44 INFO - 'MAIL': '/var/mail/cltbld', 09:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:44 INFO - 'MOZ_NO_REMOTE': '1', 09:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:44 INFO - 'NO_EM_RESTART': '1', 09:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:44 INFO - 'PWD': '/builds/slave/test', 09:11:44 INFO - 'SHELL': '/bin/bash', 09:11:44 INFO - 'SHLVL': '1', 09:11:44 INFO - 'TERM': 'linux', 09:11:44 INFO - 'TMOUT': '86400', 09:11:44 INFO - 'USER': 'cltbld', 09:11:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:44 INFO - '_': '/tools/buildbot/bin/python'} 09:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 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)) 09:11:45 INFO - Cleaning up... 09:11:45 INFO - Return code: 0 09:11:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:45 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 0x7ff5157d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', '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 09:11:45 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 09:11:45 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 09:11:45 INFO - Using env: {'DISPLAY': ':0', 09:11:45 INFO - 'HOME': '/home/cltbld', 09:11:45 INFO - 'LANG': 'en_US.UTF-8', 09:11:45 INFO - 'LANGUAGE': 'en_US:en', 09:11:45 INFO - 'LOGNAME': 'cltbld', 09:11:45 INFO - 'MAIL': '/var/mail/cltbld', 09:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:45 INFO - 'MOZ_NO_REMOTE': '1', 09:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:45 INFO - 'NO_EM_RESTART': '1', 09:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:45 INFO - 'PWD': '/builds/slave/test', 09:11:45 INFO - 'SHELL': '/bin/bash', 09:11:45 INFO - 'SHLVL': '1', 09:11:45 INFO - 'TERM': 'linux', 09:11:45 INFO - 'TMOUT': '86400', 09:11:45 INFO - 'USER': 'cltbld', 09:11:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:45 INFO - '_': '/tools/buildbot/bin/python'} 09:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:45 INFO - Cleaning up... 09:11:45 INFO - Return code: 0 09:11:45 INFO - Running post-action listener: _resource_record_post_action 09:11:45 INFO - Running post-action listener: _start_resource_monitoring 09:11:45 INFO - Starting resource monitoring. 09:11:45 INFO - [mozharness: 2016-10-07 16:11:45.450033Z] Finished create-virtualenv step (success) 09:11:45 INFO - [mozharness: 2016-10-07 16:11:45.450537Z] Running install step. 09:11:45 INFO - Running pre-action listener: _resource_record_pre_action 09:11:45 INFO - Running main action method: install 09:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:45 INFO - Reading from file tmpfile_stdout 09:11:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:45 INFO - Reading from file tmpfile_stdout 09:11:45 INFO - Output received: 09:11:45 INFO - Usage: mozinstall [options] installer 09:11:45 INFO - Options: 09:11:45 INFO - -h, --help show this help message and exit 09:11:45 INFO - -d DEST, --destination=DEST 09:11:45 INFO - Directory to install application into. [default: 09:11:45 INFO - "/builds/slave/test"] 09:11:45 INFO - --app=APP Application being installed. [default: firefox] 09:11:45 INFO - mkdir: /builds/slave/test/build/application 09:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:12:01 INFO - Reading from file tmpfile_stdout 09:12:01 INFO - Output received: 09:12:01 INFO - /builds/slave/test/build/application/firefox/firefox 09:12:01 INFO - Running post-action listener: _resource_record_post_action 09:12:01 INFO - [mozharness: 2016-10-07 16:12:01.897089Z] Finished install step (success) 09:12:01 INFO - [mozharness: 2016-10-07 16:12:01.897334Z] Running run-tests step. 09:12:01 INFO - Running pre-action listener: _resource_record_pre_action 09:12:01 INFO - Running main action method: run_tests 09:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:12:01 INFO - Python 2.7.3 09:12:01 INFO - Return code: 0 09:12:01 INFO - grabbing minidump binary from tooltool 09:12:01 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')]} 09:12:01 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 0x153af60>, '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 0x153bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:12:01 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 09:12:01 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 09:12:01 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 09:12:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:12:01 INFO - Return code: 0 09:12:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:12:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:12:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:12:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:12:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 09:12:01 INFO - Using env: {'DISPLAY': ':0', 09:12:01 INFO - 'HOME': '/home/cltbld', 09:12:01 INFO - 'LANG': 'en_US.UTF-8', 09:12:01 INFO - 'LANGUAGE': 'en_US:en', 09:12:01 INFO - 'LOGNAME': 'cltbld', 09:12:01 INFO - 'MAIL': '/var/mail/cltbld', 09:12:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:01 INFO - 'MOZ_NO_REMOTE': '1', 09:12:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:01 INFO - 'NO_EM_RESTART': '1', 09:12:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:01 INFO - 'PWD': '/builds/slave/test', 09:12:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:01 INFO - 'SHELL': '/bin/bash', 09:12:01 INFO - 'SHLVL': '1', 09:12:01 INFO - 'TERM': 'linux', 09:12:01 INFO - 'TMOUT': '86400', 09:12:01 INFO - 'USER': 'cltbld', 09:12:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131', 09:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:01 INFO - '_': '/tools/buildbot/bin/python'} 09:12:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:12:02 INFO - mozversion application_buildid: 20161007074400 09:12:02 INFO - mozversion application_changeset: 7e8ddcf9716aea87e598333e2970437c94173334 09:12:02 INFO - mozversion application_display_name: Nightly 09:12:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:12:02 INFO - mozversion application_name: Firefox 09:12:02 INFO - mozversion application_remotingname: firefox 09:12:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:12:02 INFO - mozversion application_vendor: Mozilla 09:12:02 INFO - mozversion application_version: 52.0a1 09:12:02 INFO - mozversion platform_buildid: 20161007074400 09:12:02 INFO - mozversion platform_changeset: 7e8ddcf9716aea87e598333e2970437c94173334 09:12:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:12:02 INFO - mozversion platform_version: 52.0a1 09:12:02 INFO - using testdate: 1475856722 09:12:02 INFO - actual date: 1475856722 09:12:02 INFO - starting webserver on 'localhost:52902' 09:12:02 INFO - SUITE-START | Running 2 tests 09:12:02 INFO - TEST-START | dromaeo_css 09:12:02 INFO - operating with platform_type : linux_ 09:12:02 INFO - Initialising browser for dromaeo_css test... 09:12:02 INFO - TEST-INFO | started process 12566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8NPUwW/profile http://localhost:52902/getInfo.html) 09:12:06 INFO - PROCESS | 12566 | __metrics Screen width/height:1600/1200 09:12:06 INFO - PROCESS | 12566 | colorDepth:24 09:12:06 INFO - PROCESS | 12566 | Browser inner width/height: 1024/697 09:12:06 INFO - PROCESS | 12566 | __metrics 09:12:07 INFO - PROCESS | 12566 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:12:07 INFO - PROCESS | 12566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:07 INFO - PROCESS | 12566 | console.error: PushService: 09:12:07 INFO - PROCESS | 12566 | stateChangeProcessEnqueue: Error transitioning state 09:12:07 INFO - PROCESS | 12566 | UnknownError 09:12:08 INFO - TEST-INFO | 12566: exit 0 09:12:08 INFO - Browser initialized. 09:12:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:08 INFO - TEST-INFO | started process 12648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8NPUwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:20 INFO - PROCESS | 12648 | RSS: Main: 173760512 09:12:20 INFO - PROCESS | 12648 | 09:13:11 INFO - PROCESS | 12648 | 1475856791254 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] 09:15:24 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52902/tests/dromaeo/cssquery-ext.html) 09:15:26 INFO - PROCESS | 12648 | RSS: Main: 329031680 09:15:26 INFO - PROCESS | 12648 | 09:18:29 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-ext.html (next: http://localhost:52902/tests/dromaeo/cssquery-jquery.html) 09:18:29 INFO - PROCESS | 12648 | RSS: Main: 283811840 09:18:29 INFO - PROCESS | 12648 | 09:21:31 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52902/tests/dromaeo/cssquery-mootools.html) 09:21:32 INFO - PROCESS | 12648 | RSS: Main: 219803648 09:21:32 INFO - PROCESS | 12648 | 09:24:34 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52902/tests/dromaeo/cssquery-prototype.html) 09:24:35 INFO - PROCESS | 12648 | RSS: Main: 218566656 09:24:35 INFO - PROCESS | 12648 | 09:27:38 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52902/tests/dromaeo/cssquery-yui.html) 09:27:39 INFO - PROCESS | 12648 | RSS: Main: 220954624 09:27:39 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:52902/tests/dromaeo/cssquery-yui.html (next: http://localhost:52902/tests/dromaeo/cssquery-dojo.html) 09:30:42 INFO - PROCESS | 12648 | RSS: Main: 311816192 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | __start_tp_report 09:30:42 INFO - PROCESS | 12648 | _x_x_mozilla_page_load 09:30:42 INFO - PROCESS | 12648 | _x_x_mozilla_page_load_details 09:30:42 INFO - PROCESS | 12648 | |i|pagename|runs| 09:30:42 INFO - PROCESS | 12648 | |0;dojo.html;2547.4522977559823;2560.361368724016;2592.209376140277;2600.4669042846217;2607.34816295926;4574.062317224969;4639;4647.558481944214;4659.394278743763;4670.626349892009;4657.743824089674;4680.929786053203;4682.765861706918;4716.646251531131;4773.546513081252;4288;4308.418363520916;4354.368616550598;4356.237658409781;4358.259095953679;4372;4374.234508960935;4379.474463064436;4393.648508119359;4394.296912494002;4197.391378250137;4362.192994296065;4368;4379;4466.665000124987;4244.511881133647;4264.104538047014;4287.292596721537;4290.570942905684;4325.9134817303475;4289.742615443052;4293.270144075484;4298.935515967263;4342.326939324378;4345.044090300129;4664.300354946751;4676.766161691902;4687.250039993584;4691.061787642451;4707.435107787053;4776.164171270014;4816.903661926777;4822.42130944289;4895.094407534618;4993.076280888047;4916.041371932474;4935.728534930578;4992.176290912032;4993.600511959071;5115.079285728568;4691.460482044608;4693.671442999025;4698.647601429906;4745.715257084586;4751.192297309466;5136.43499215086;5144.022635699205;5145;5149;5158;4779.95220047802;4823.614110871192;4826.469088400273;4880.853574392774;4977.651564390458;4994.725290109006;5028.5977121830165;5033.949660503421;5092.388913330424;5100.566451851634;4936.481669424658;4982.476839931827;4992.475790041994;5003.674761140514;5050.77271522775;4809.639277054235;4860.295257187759;4977.278294647256;4979.4771548987555;4985.975070124626;4132.297509423405;4157.937630935538;4170.562090980464;4175.54069052404;4228.450301460852;3641.7450778445786;3653.397189463762;3659.0486473516544;3697.1681371691693;3700.4264339027495;4290.785460726951;4296.613304802583;4297.205017071852;4297.290946993711;4346;4885.9755701221975;4934.753262336869;4939.678920870132;4966.304717339575;5008.724520151354;4287.957120428819;4292.871213863589;4315.611594956406;4339.869803905888;4347.152305300499;4521.163584736834;4521.796519156645;4521.819127234874;4567.246404343313;4578.725276483355;4623.283391074388;4670.649701272486;4727.763611819395;4736.952630473651;4742.383490146259;4923.138450771173;4937.876553086202;4974.154393752999;4976.402831660079;5030.798768049383;4658.04510075427;4670.252759558454;4678.906421871611;4680.789364478538;4737.170995075779;4807.18277892766;4854.73298968546;4855.150348689036;4862.805487780449;4921.31101645777;4907.4847141051105;4961.801527938842;4979.103761322996;4981.726005069756;5002.149634562206;4886.3403440536495;4891.584215341736;4894.951050489592;4912.287718280901;4944.134776414041;4883.536064073907;4886.144924638245;4889.2910527972535;4890.731009794353;4950.034743225036;4697.248440249544;4711.8350857719815;4730.6215502759005;4766.022965292037;4812.230043193073;4903.705777653352;4908.337374454546;4910.975445122752;4953.504649535018;4971.353724015855;4661.067786442793;4701.553352431513;4779.139754844162;4812.205986012269;4833.323334733211 09:30:42 INFO - PROCESS | 12648 | |1;ext.html;555.5999680230234;568.3520786303612;569.7749388991349;571.782722565425;574.2620732358919;28053.859730701344;38314;39518.80240598793;39586.60413395865;43050.35424468636;40111;40709.18581628366;40778.38832417509;40794.38808417876;40795.38806917891;7607.695692172307;7744.651490682904;7751.263629955173;7783.41624378171;7863.449558530905;7674.769756907302;7750.883736743954;7763.961180194119;7767.728129515468;7772.067351917778;7768.805779855521;7807.531548107132;7808.375329973617;7811.140774514799;7819.6481158348015;7654.770356889302;7692.4615276930635;7721.691132354756;7747.806304842367;7760.301572858441;7533.736319228856;7608.809779755495;7623.961880190619;7629.427792915498;7629.6948122075055;36469.81765091157;36797.264054719024;37141.386015866956;37204.62795372066;37247.62752372469;3009.5335223040465;3012.5932999045067;3083.5528848316867;3104.5498402731478;3132.3891841090995;28805.56791648127;28876.42247155045;28916.566251506243;29411;30758.69241307603;3347.41420251455;3388.440907250301;3410.1133705236816;3422.058933793202;3436.8004477134655;174381.99999999872;174813;175432.12283938625;175438;175829;28951;30206;50948.74525627348;51133.48866511362;51576.22635660468;33134.83432582822;33331.16672083169;33332.50001249983;33336.33327333488;33366.66633333684;12423.75152496945;12640.367981600883;12641.494340226289;12644;12645.873541264653;9784.902150978542;9785.315027947976;9790.363626364264;9790.95104524487;9800.411975281506;7990.240927112031;8010.359171266285;8027.39794515402;8108.8378232435025;8109.7161599343735;3111.9533207001914;3132.9686703133134;3160.7313378362637;3189.3142974260645;3190.122716253049;858.1418581418582;868.2186032570737;914.2457472585144;968.1673760565908;997.3168379659957;26979.86510067437;27464;27603;28193.79736457976;28227.57658635122;896.4845214001975;906.3972458315278;946.3895787217207;949.0414681172066;970.8786401699788;14113.576592702235;14903.727169232377;14937;15107.169105699073;15219.934604577573;359888;362620;363991;364107;364798;48462.75768621134;48827.75586122047;48853.26720099201;48865.511344886094;48873.266900995804;1111.366521082991;1122.618309774664;1181.7459246262094;1183.9940800296115;1191.5829459689212;26357.868210658824;27149;27487.17538473849;28160.577591336558;28211.43577128405;42445.57554424416;42502.78748606361;42737;42840.571594284906;42861;303282;306196;306677;307439;308081;25362.873185633955;25482.235532934043;25885;25928.22215333543;25972.610410843474;41406.585934140276;41616.79191604022;42611.573884262;42867;42957.57042429536;34934.30131397307;35224.647753522135;35619.28761424705;35995.1001224961;36536.26927461383;35164.47253291152;35304.293914122085;35653.82173089118;35875.461868072525;35918.461223081154;34882.825585871906;35294;35474.467882982295;35641.46537801883;36193.63806361903;29892.85053574718;32278.677213227566;32592.34815303728;32615.347693046482;32716.345673086882;24321.391965200302;25025.624615631143;25071;25192.622110667988;25482.872585636953 09:30:42 INFO - PROCESS | 12648 | |2;jquery.html;336.78614080059185;343.9518467414564;357.15710922223553;357.8497031246876;369.80954808273725;12267.202631828935;13321.866781332184;15691.999999999985;16153.676926461463;16174.35302587898;15980.600484987881;16427.342906283764;16602.418915337967;16759.16204189792;16765;4452.398926144978;4936.2842387853825;5158.613104017214;5159.819406320779;5160.974195129038;5921.496672782819;6082.422169893853;6082.878342433149;6085.726142323606;6091.756329746827;5820.883582328351;6032.366601506845;6033.849153771147;6045.697715114248;6089.78685745999;6037.547183961198;6044.818655440344;6052.9697351513405;6062.42406971337;6076.088586711984;4747.35910652061;5042.218456139268;5058.418281897555;5136.332276804029;5282.788688452496;12208.145429819917;12232.266064036186;12279;12459.190152640049;12475.438605262785;1948.7758907725652;1957.5106223444138;2002.349236498144;2139.379579921821;2261.163369553259;8674.219320261207;9038.322125840523;9421.104995025462;9544.856827147598;9557.044295570457;1687.131127469342;1711.2470512974376;1725.8187890271593;1735.609487865233;1783.6700210461106;64542.67728661373;68205;68732.6563367185;68840;73931;9772.9022709772;9884.406935583887;10009.69970900874;10064.69805905824;10109.898901010896;13815.171089734647;13833.377498012613;13836.446542138201;13844.377003034888;13847.376868040963;6523.217213934264;6540.411362977355;6674.199096108498;6719.092922455504;7067.646617669199;5913.674747888821;5917.349091599921;6123.4795042421;6129.785457508966;6141.048137538689;4163.458750362494;4221.197972385237;4230.196262710076;4347.739135651871;4366.956330436718;1780.8753387263027;1828.9451316460527;1843.4746097362188;1859.8884066956025;1879.4643526595128;751.7406494759299;803.9437239393186;889.5329951775241;901.1394118616705;958.7363475044418;15829.208539572975;16504.42234521786;17021.40425085116;17266.740998885027;17294.567635808955;829.9336053115736;869.365363284793;873.3362644390309;890.7684002159485;908.7191150212881;9321.161095501437;9460.385074970105;9478.668246611336;9505.5722492488;9625.614975401046;349292;357351;358039;358056;358954;72299.51657009704;72813;74189;75802;76774.23225767782;859.4241857955185;868.5006121480175;876.333986170515;897.0536084430988;901.6934242357498;14530.709385812013;14885.255737213312;15092.471763488225;15133.54599362021;15220.467283645019;35050.298994020486;35113.824430877685;35718;36145.096372590895;36276.63723362733;48205;48792.512074878796;49218;49353.75323123361;49594;7365.631718414165;7443.404527637885;7507.324340809353;7567.356774673995;7936.880946785918;8244.949368733367;11346;11447.484863181011;11464.197506174822;11514.94242528782;9246.167844893722;9747;9830.115289623967;10045.49772511386;10357.326773759682;9232.353735238468;9518;9732.41605503672;9787.559559819967;10131.44277064739;9893;9919.752006199902;10099.44453055089;10202.540885660015;10552.261341706007;7420.220876807857;7567;7684.500507466997;8045.879311810445;8253.174682531699;9887.209023278265;9894.356866803635;10008.799824003334;10192.08271255561;10616.044555989998 09:30:42 INFO - PROCESS | 12648 | |3;mootools.html;1203.3922868951179;1340.3298350824584;1365.98234315435;1417.7589809732344;1670.8830381873258;6651.534392592514;7502.887456688154;7746.34156096731;7779.416543759226;7874.527528348303;7811.726589569366;7818.413618978571;7823.491473054248;7844.294013538781;7865.92134078659;2162.308061420346;2169.6420090685056;2174.2607513445423;2182.138055468089;2196.802287794098;2149.5163588192686;2187.4312678703573;2213.9335819925427;2215.6122678531274;2217.4456385903522;2149.8280137588954;2168.338656709711;2170.967435488469;2179.030331502482;2191.068795761803;2106.2101711858054;2107.5047363869553;2107.599556084339;2108.9261875834427;2112.26070875194;2064.3910046536307;2127.7340332458443;2129.1164166870885;2132.1364847236737;2132.829373650104;7458.552486850806;7642.541447513111;7711.228877112244;7750.341220996165;7778.144404115543;4276.080642661843;4343.1747967886;4351.6953813233085;4354.8258069677495;4358.346248062784;2698.8515631640253;2814.1838866728626;2858.542633178702;2869.253993961564;2872.224499385154;962.1052421248237;966.1304825656965;970.3692599810109;979.1139019187647;984.0897170117684;10056;10080.495975201284;10088.646897358558;10105.545250463672;10144.695659130239;3899.3566061599518;3959.0696186396176;4026.5168179818024;4037.535683396447;4054.8175332110127;8070.354371650254;8141.470804397695;8148.470349427387;8192.959035204905;8212.794680133044;4437.378766972626;4438.866833994985;4440.178566965122;4451.043025749479;4451.933221001687;3602.6397360264286;3741.102135487518;4143.150654115899;4144.046869220036;4146.79266036703;3222.8871989480253;3258.5926759155104;3357.84889679965;3366.495025746158;3386.475096360068;1024.9538770755335;1036.9896301036893;1046.6859942017363;1047.8218702820539;1051;683.5181197256022;712.9251428600026;715.4777012780595;736.7089999450187;843.5402705525503;4994.600431965434;5023.8756468402025;5137.948620513747;5184.948150518522;5319.308489896289;398.2095540352456;398.5735263268333;403.3566461493912;407.7471967380184;412.78741448154227;3539.876104336336;3602.9819850900576;3684.2263124743567;3684.9263014739554;3722.813859307024;9102.453852768855;9494.192993595621;9537;9564.13922746956;9615.375000625078;9383.155516003593;9422.670206542738;9462.101100395452;9471.052894710612;9492.430454172634;6969.407600354027;7014.859702805916;7107.466939979522;7135.250798666169;7172.641367931583;5107.442230119849;5149.922751158811;5218.765155568084;5230.398504172069;5348.545373643284;8234.258916697527;8522.616482258438;8667;8686.565671716262;8774.429662071945;8683.435576687496;8797.516136612549;8810.911890881009;8889.955550222208;8896.288296936358;5488.506034456758;6272.905906411316;6317.210348706411;6347.96826015867;6349.460295874902;6527;6771.796846094625;7103.786886393416;7115.85768284621;7192.065031545865;6394.680265986589;6484.837879053061;6662.666866656745;6685.364890335411;6716.3955244028275;6505.73977040932;6527.771527996498;6620.5034622402545;6652.534322597372;6734.898976515258;6028.306744724413;6110.755569777337;6115.541334400027;6119.969400152971;6125.050617154348;4377.627901628397;4406.647468202472;4429.117625009422;4509.729416235036;4544.409226800495;4449.199144153954;4502.3471596618965;4508.9098218036115;4590.196715574694;4651.2557990721325 09:30:42 INFO - PROCESS | 12648 | |4;prototype.html;271.4760512211432;285.63724070430555;294.72590490843515;300.514668809872;301.421271159374;4600.757795395241;4739.952600473995;4806.279058141276;4810.807567697292;4827.348307978422;4577.954220457795;4670.229412146991;4689.202835517962;4705.670603057779;4732.290156476531;3515.874920025593;3631.512413996421;3726.142987112966;3733.9253214935684;3742.6818720408796;3627.7460577759566;3725.2735716535285;3738.626137386253;3739.9626003740022;3751.799424184262;3691.926161476769;3694.5197124373926;3709.7588656737225;3711.498947642074;3711.498947642074;3713.7214708896804;3723.2181241939224;3724.3854763963914;3732.8241603894685;3777.527809023872;3258.185453636591;3306.7354611631013;3321.820753632474;3324.8670053197843;3348.564686590752;4603.7698115094445;4628.236341003731;4632.536746325374;4642.582167604932;4648.302754586805;4263.91472170558;4264.296391095466;4267.466566679165;4275.743455392686;4277.572242775697;4804.25534042224;4965.875853103701;4989.750512474362;4990.50094990498;4995.625328100407;3623.3115708015657;3629.872954446582;3632.745707800455;3638.381475149231;3641.035125691694;5203.089459344599;5239.476052394768;5248.527632513092;5249.868753281198;5251.188340022686;3473.583170019614;3634.6547078027547;3662.5421822272215;3699.408094704834;3736.4021756518828;3730.7948062856804;3730.981345093257;3737.906552336159;3745.700343972476;3747.9063023424087;4214.578542145761;4216.578342165759;4221.155768846243;4226.344916537942;4230.1539692061715;4765.973606759732;4865.391826021747;4882.926756098661;4913.778879950411;4958.8760280993265;1261.6341261034381;1288.5747703257903;1294.779887419141;1295.33290355467;1297.7606385901443;812.6830536090929;846.1411667157716;851.3997631669658;857.2284943550729;857.8241460500583;3910.7849068301516;3939.9015024624614;3946.348852439373;3955.20895820837;3959.8812035638975;4528.7509186994375;4557.69836232707;4571.497135315112;4574.473935497461;4580.5036255240975;3960.2475529649273;3960.405939109157;3962.643362097425;3962.8612998544913;3963.742356746802;2317.953640927206;2416.6196296647786;2428.599281118631;2431.3556907419547;2438.097903775614;4309.1381723655395;4320.762358070274;4333.133373325348;4334.092999080394;4336.631386332134;4639.907201855944;4643.558861908114;4645.605123564467;4659.790309436084;4660.650451216173;4130.876073717794;4293.549177336335;4341.587549182823;4348.391225228471;4357.760323182255;4534.682572219913;4552.817887284472;4553.268039176468;4563.53966730643;4579.404677391918;4435.33674871923;4458.197524445502;4460.7323560586465;4467.932981005222;4476.328550717419;4145.2952997991015;4327.004788898634;4334.266293482632;4339.544347843557;4356.956430435655;3408.4376077946863;3439.1917899294144;3527.506149139174;3550.1716615942296;3681.650243226889;5042.344495215745;5050.191969284897;5060.898782024413;5061.4179369373;5064.392272927273;4926.704397736147;4931.939632978927;4934.753262336797;4940.209566469348;4950.405951285725;4742.822309053012;4901.289313049517;4905.926411103765;4931.9753401232765;4962.3052772611145;4852.587530059844;4855.927161092516;4858.78135483897;4865.294532292727;4871.488493708252;4947.727874966911;4949.455559888337;4957.876053098701;4969.776360063734;4970.776315065758;4656.8137274508645;4788.41982145898;4819.421669399694;4834.323194752667;4868.367112275381 09:30:42 INFO - PROCESS | 12648 | |5;yui.html;649.7888186339441;651.7490766055068;670.5306285600082;733.6441825714525;741.9406447484201;13512.797308040388;14366.20985845778;14408.207548584824;14412.27052753671;14555.563333099997;12262.81605775914;12283.815742763865;12299.38503074845;12300.753984920297;12320.938395308034;624.0607885132869;642.0305338938214;756.7124492692769;758.4349659503678;779.9766007019798;745.6346390268784;759.2407592407592;760.6881178716727;761.0030859573948;761.4213197969527;833.3083540661237;834.3575446905879;834.7245409015011;834.7787836223406;835.2900034970287;630.4578062865932;663.7278715726529;783.1307248953657;821.5235163605095;821.5399376349234;586.6656006076538;591.7751254523297;591.9763209471616;592.2005292854611;592.3720855892724;13771.036027478081;13810.723785524233;13814.309284535733;13818;13818.516351927734;12580.685482863002;12840.486380544768;13130.540431084866;13293.202407855462;13514.797278040838;12043.819342709867;12048.457819398149;12063.939680301542;12093.213941093802;12461.563845265373;4156.459660244149;4168.124693814302;4203.47456567929;4209.74741515507;4368.956310436918;59392.10911836326;60035;60631.69684151595;60894;61613.38386616121;9658.565364558612;9799.902000980042;9825.705228843146;10080.09279164864;10090.747731306776;19602;19602.607947840963;19626.901865490865;19741.703874441893;19809.900950495154;6746;6800.625965571842;6895.138107736533;6909.827254318581;6915.757948471779;3598.9100272493397;3626.2747450510005;3719.814009299524;3751.2685026419585;3779.6787273081545;2787.6236708044153;2878.1797187801376;3097.969020309813;3234.4016356974034;3274.672532746706;537.7042626555457;546.9343678758574;547.6905548365161;550.1005855426326;555.3585608622049;572.9083346664513;586.9970650146807;592.6796591344922;601.7863658401204;605.3522730678133;8166;8338.332933365316;8368.707095251637;8413.411061225655;8681.913180868236;544.6922488793819;559.2478116932718;560.927079479665;591.4499515450672;605.2948315212816;3644.671979521856;3915.158240978203;3989.8204580793936;4088.3867419887256;4157.584241575879;72713.6364318175;72872;73540;101993.49003254937;102402;45727.542724572995;45765.542344576126;66168.00747988783;77444;77985.61007194928;65875.67062164658;67459;68682;69620.6518967402;73311.63344183245;8153.826944687227;8291.709790157316;8361.916380836114;8638.7486584251;8791.560421979004;42401.36397954095;42505.57494425016;43081.784591076845;43179;43201.3519797197;38087.238255235294;46843.531564683915;49953.50046499634;51677.22484162665;53981;11642.24325418845;11704.824427633423;11710.88289117132;11872.287662740264;12440.502379904703;13105.820476157192;13308.667283317607;13342;13729.313534323444;14182.290885455892;11983.940080299542;12223.205491643015;12878.484860605471;13148.276844773629;13264.071514993857;11301.208915375844;12773.425195866022;12911.22532648044;13090.14914030585;13316.86683133195;12188.2887305436;12212.328321942023;12438.88811286481;12545;13249.271290079138;9683.041063064991;9891.109800118023;10024.348417352849;10285.228607854591;10287.84568231492;9017.774555636162;9183.816323673356;9512.191463725661;9817.361871478332;10081.495925203857 09:30:42 INFO - PROCESS | 12648 | __end_tp_report 09:30:42 INFO - PROCESS | 12648 | __start_cc_report 09:30:42 INFO - PROCESS | 12648 | _x_x_mozilla_cycle_collect,1559 09:30:42 INFO - PROCESS | 12648 | __end_cc_report 09:30:42 INFO - PROCESS | 12648 | __startTimestamp1475857842559__endTimestamp 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | ------- Summary: start ------- 09:30:42 INFO - PROCESS | 12648 | Number of tests: 6 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | [#0] dojo.html Cycles:165 Average:4611.61 Median:4727.76 stddev:481.28 (10.2%) stddev-sans-first:454.70 09:30:42 INFO - PROCESS | 12648 | Values: 2547.5 2560.4 2592.2 2600.5 2607.3 4574.1 4639.0 4647.6 4659.4 4670.6 4657.7 4680.9 4682.8 4716.6 4773.5 4288.0 4308.4 4354.4 4356.2 4358.3 4372.0 4374.2 4379.5 4393.6 4394.3 4197.4 4362.2 4368.0 4379.0 4466.7 4244.5 4264.1 4287.3 4290.6 4325.9 4289.7 4293.3 4298.9 4342.3 4345.0 4664.3 4676.8 4687.3 4691.1 4707.4 4776.2 4816.9 4822.4 4895.1 4993.1 4916.0 4935.7 4992.2 4993.6 5115.1 4691.5 4693.7 4698.6 4745.7 4751.2 5136.4 5144.0 5145.0 5149.0 5158.0 4780.0 4823.6 4826.5 4880.9 4977.7 4994.7 5028.6 5033.9 5092.4 5100.6 4936.5 4982.5 4992.5 5003.7 5050.8 4809.6 4860.3 4977.3 4979.5 4986.0 4132.3 4157.9 4170.6 4175.5 4228.5 3641.7 3653.4 3659.0 3697.2 3700.4 4290.8 4296.6 4297.2 4297.3 4346.0 4886.0 4934.8 4939.7 4966.3 5008.7 4288.0 4292.9 4315.6 4339.9 4347.2 4521.2 4521.8 4521.8 4567.2 4578.7 4623.3 4670.6 4727.8 4737.0 4742.4 4923.1 4937.9 4974.2 4976.4 5030.8 4658.0 4670.3 4678.9 4680.8 4737.2 4807.2 4854.7 4855.2 4862.8 4921.3 4907.5 4961.8 4979.1 4981.7 5002.1 4886.3 4891.6 4895.0 4912.3 4944.1 4883.5 4886.1 4889.3 4890.7 4950.0 4697.2 4711.8 4730.6 4766.0 4812.2 4903.7 4908.3 4911.0 4953.5 4971.4 4661.1 4701.6 4779.1 4812.2 4833.3 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | [#1] ext.html Cycles:180 Average:42796.33 Median:197941.55 stddev:77186.32 (39.0%) stddev-sans-first:77337.69 09:30:42 INFO - PROCESS | 12648 | Values: 555.6 568.4 569.8 571.8 574.3 28053.9 38314.0 39518.8 39586.6 43050.4 40111.0 40709.2 40778.4 40794.4 40795.4 7607.7 7744.7 7751.3 7783.4 7863.4 7674.8 7750.9 7764.0 7767.7 7772.1 7768.8 7807.5 7808.4 7811.1 7819.6 7654.8 7692.5 7721.7 7747.8 7760.3 7533.7 7608.8 7624.0 7629.4 7629.7 36469.8 36797.3 37141.4 37204.6 37247.6 3009.5 3012.6 3083.6 3104.5 3132.4 28805.6 28876.4 28916.6 29411.0 30758.7 3347.4 3388.4 3410.1 3422.1 3436.8 174382.0 174813.0 175432.1 175438.0 175829.0 28951.0 30206.0 50948.7 51133.5 51576.2 33134.8 33331.2 33332.5 33336.3 33366.7 12423.8 12640.4 12641.5 12644.0 12645.9 9784.9 9785.3 9790.4 9791.0 9800.4 7990.2 8010.4 8027.4 8108.8 8109.7 3112.0 3133.0 3160.7 3189.3 3190.1 858.1 868.2 914.2 968.2 997.3 26979.9 27464.0 27603.0 28193.8 28227.6 896.5 906.4 946.4 949.0 970.9 14113.6 14903.7 14937.0 15107.2 15219.9 359888.0 362620.0 363991.0 364107.0 364798.0 48462.8 48827.8 48853.3 48865.5 48873.3 1111.4 1122.6 1181.7 1184.0 1191.6 26357.9 27149.0 27487.2 28160.6 28211.4 42445.6 42502.8 42737.0 42840.6 42861.0 303282.0 306196.0 306677.0 307439.0 308081.0 25362.9 25482.2 25885.0 25928.2 25972.6 41406.6 41616.8 42611.6 42867.0 42957.6 34934.3 35224.6 35619.3 35995.1 36536.3 35164.5 35304.3 35653.8 35875.5 35918.5 34882.8 35294.0 35474.5 35641.5 36193.6 29892.9 32278.7 32592.3 32615.3 32716.3 24321.4 25025.6 25071.0 25192.6 25482.9 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | [#2] jquery.html Cycles:180 Average:22827.66 Median:5097.38 stddev:59021.81 (1157.9%) stddev-sans-first:59163.22 09:30:42 INFO - PROCESS | 12648 | Values: 336.8 344.0 357.2 357.8 369.8 12267.2 13321.9 15692.0 16153.7 16174.4 15980.6 16427.3 16602.4 16759.2 16765.0 4452.4 4936.3 5158.6 5159.8 5161.0 5921.5 6082.4 6082.9 6085.7 6091.8 5820.9 6032.4 6033.8 6045.7 6089.8 6037.5 6044.8 6053.0 6062.4 6076.1 4747.4 5042.2 5058.4 5136.3 5282.8 12208.1 12232.3 12279.0 12459.2 12475.4 1948.8 1957.5 2002.3 2139.4 2261.2 8674.2 9038.3 9421.1 9544.9 9557.0 1687.1 1711.2 1725.8 1735.6 1783.7 64542.7 68205.0 68732.7 68840.0 73931.0 9772.9 9884.4 10009.7 10064.7 10109.9 13815.2 13833.4 13836.4 13844.4 13847.4 6523.2 6540.4 6674.2 6719.1 7067.6 5913.7 5917.3 6123.5 6129.8 6141.0 4163.5 4221.2 4230.2 4347.7 4367.0 1780.9 1828.9 1843.5 1859.9 1879.5 751.7 803.9 889.5 901.1 958.7 15829.2 16504.4 17021.4 17266.7 17294.6 829.9 869.4 873.3 890.8 908.7 9321.2 9460.4 9478.7 9505.6 9625.6 349292.0 357351.0 358039.0 358056.0 358954.0 72299.5 72813.0 74189.0 75802.0 76774.2 859.4 868.5 876.3 897.1 901.7 14530.7 14885.3 15092.5 15133.5 15220.5 35050.3 35113.8 35718.0 36145.1 36276.6 48205.0 48792.5 49218.0 49353.8 49594.0 7365.6 7443.4 7507.3 7567.4 7936.9 8244.9 11346.0 11447.5 11464.2 11514.9 9246.2 9747.0 9830.1 10045.5 10357.3 9232.4 9518.0 9732.4 9787.6 10131.4 9893.0 9919.8 10099.4 10202.5 10552.3 7420.2 7567.0 7684.5 8045.9 8253.2 9887.2 9894.4 10008.8 10192.1 10616.0 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | [#3] mootools.html Cycles:180 Average:4950.56 Median:5009.24 stddev:2787.33 (55.6%) stddev-sans-first:2780.93 09:30:42 INFO - PROCESS | 12648 | Values: 1203.4 1340.3 1366.0 1417.8 1670.9 6651.5 7502.9 7746.3 7779.4 7874.5 7811.7 7818.4 7823.5 7844.3 7865.9 2162.3 2169.6 2174.3 2182.1 2196.8 2149.5 2187.4 2213.9 2215.6 2217.4 2149.8 2168.3 2171.0 2179.0 2191.1 2106.2 2107.5 2107.6 2108.9 2112.3 2064.4 2127.7 2129.1 2132.1 2132.8 7458.6 7642.5 7711.2 7750.3 7778.1 4276.1 4343.2 4351.7 4354.8 4358.3 2698.9 2814.2 2858.5 2869.3 2872.2 962.1 966.1 970.4 979.1 984.1 10056.0 10080.5 10088.6 10105.5 10144.7 3899.4 3959.1 4026.5 4037.5 4054.8 8070.4 8141.5 8148.5 8193.0 8212.8 4437.4 4438.9 4440.2 4451.0 4451.9 3602.6 3741.1 4143.2 4144.0 4146.8 3222.9 3258.6 3357.8 3366.5 3386.5 1025.0 1037.0 1046.7 1047.8 1051.0 683.5 712.9 715.5 736.7 843.5 4994.6 5023.9 5137.9 5184.9 5319.3 398.2 398.6 403.4 407.7 412.8 3539.9 3603.0 3684.2 3684.9 3722.8 9102.5 9494.2 9537.0 9564.1 9615.4 9383.2 9422.7 9462.1 9471.1 9492.4 6969.4 7014.9 7107.5 7135.3 7172.6 5107.4 5149.9 5218.8 5230.4 5348.5 8234.3 8522.6 8667.0 8686.6 8774.4 8683.4 8797.5 8810.9 8890.0 8896.3 5488.5 6272.9 6317.2 6348.0 6349.5 6527.0 6771.8 7103.8 7115.9 7192.1 6394.7 6484.8 6662.7 6685.4 6716.4 6505.7 6527.8 6620.5 6652.5 6734.9 6028.3 6110.8 6115.5 6120.0 6125.1 4377.6 4406.6 4429.1 4509.7 4544.4 4449.2 4502.3 4508.9 4590.2 4651.3 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | [#4] prototype.html Cycles:180 Average:3990.86 Median:4340.57 stddev:1138.94 (26.2%) stddev-sans-first:1107.39 09:30:42 INFO - PROCESS | 12648 | Values: 271.5 285.6 294.7 300.5 301.4 4600.8 4740.0 4806.3 4810.8 4827.3 4578.0 4670.2 4689.2 4705.7 4732.3 3515.9 3631.5 3726.1 3733.9 3742.7 3627.7 3725.3 3738.6 3740.0 3751.8 3691.9 3694.5 3709.8 3711.5 3711.5 3713.7 3723.2 3724.4 3732.8 3777.5 3258.2 3306.7 3321.8 3324.9 3348.6 4603.8 4628.2 4632.5 4642.6 4648.3 4263.9 4264.3 4267.5 4275.7 4277.6 4804.3 4965.9 4989.8 4990.5 4995.6 3623.3 3629.9 3632.7 3638.4 3641.0 5203.1 5239.5 5248.5 5249.9 5251.2 3473.6 3634.7 3662.5 3699.4 3736.4 3730.8 3731.0 3737.9 3745.7 3747.9 4214.6 4216.6 4221.2 4226.3 4230.2 4766.0 4865.4 4882.9 4913.8 4958.9 1261.6 1288.6 1294.8 1295.3 1297.8 812.7 846.1 851.4 857.2 857.8 3910.8 3939.9 3946.3 3955.2 3959.9 4528.8 4557.7 4571.5 4574.5 4580.5 3960.2 3960.4 3962.6 3962.9 3963.7 2318.0 2416.6 2428.6 2431.4 2438.1 4309.1 4320.8 4333.1 4334.1 4336.6 4639.9 4643.6 4645.6 4659.8 4660.7 4130.9 4293.5 4341.6 4348.4 4357.8 4534.7 4552.8 4553.3 4563.5 4579.4 4435.3 4458.2 4460.7 4467.9 4476.3 4145.3 4327.0 4334.3 4339.5 4357.0 3408.4 3439.2 3527.5 3550.2 3681.7 5042.3 5050.2 5060.9 5061.4 5064.4 4926.7 4931.9 4934.8 4940.2 4950.4 4742.8 4901.3 4905.9 4932.0 4962.3 4852.6 4855.9 4858.8 4865.3 4871.5 4947.7 4949.5 4957.9 4969.8 4970.8 4656.8 4788.4 4819.4 4834.3 4868.4 09:30:42 INFO - PROCESS | 12648 | 09:30:42 INFO - PROCESS | 12648 | [#5] yui.html Cycles:180 Average:16402.10 Median:46304.54 stddev:21809.12 (47.1%) stddev-sans-first:21838.23 09:30:42 INFO - PROCESS | 12648 | Values: 649.8 651.7 670.5 733.6 741.9 13512.8 14366.2 14408.2 14412.3 14555.6 12262.8 12283.8 12299.4 12300.8 12320.9 624.1 642.0 756.7 758.4 780.0 745.6 759.2 760.7 761.0 761.4 833.3 834.4 834.7 834.8 835.3 630.5 663.7 783.1 821.5 821.5 586.7 591.8 592.0 592.2 592.4 13771.0 13810.7 13814.3 13818.0 13818.5 12580.7 12840.5 13130.5 13293.2 13514.8 12043.8 12048.5 12063.9 12093.2 12461.6 4156.5 4168.1 4203.5 4209.7 4369.0 59392.1 60035.0 60631.7 60894.0 61613.4 9658.6 9799.9 9825.7 10080.1 10090.7 19602.0 19602.6 19626.9 19741.7 19809.9 6746.0 6800.6 6895.1 6909.8 6915.8 3598.9 3626.3 3719.8 3751.3 3779.7 2787.6 2878.2 3098.0 3234.4 3274.7 537.7 546.9 547.7 550.1 555.4 572.9 587.0 592.7 601.8 605.4 8166.0 8338.3 8368.7 8413.4 8681.9 544.7 559.2 560.9 591.4 605.3 3644.7 3915.2 3989.8 4088.4 4157.6 72713.6 72872.0 73540.0 101993.5 102402.0 45727.5 45765.5 66168.0 77444.0 77985.6 65875.7 67459.0 68682.0 69620.7 73311.6 8153.8 8291.7 8361.9 8638.7 8791.6 42401.4 42505.6 43081.8 43179.0 43201.4 38087.2 46843.5 49953.5 51677.2 53981.0 11642.2 11704.8 11710.9 11872.3 12440.5 13105.8 13308.7 13342.0 13729.3 14182.3 11983.9 12223.2 12878.5 13148.3 13264.1 11301.2 12773.4 12911.2 13090.1 13316.9 12188.3 12212.3 12438.9 12545.0 13249.3 9683.0 9891.1 10024.3 10285.2 10287.8 9017.8 9183.8 9512.2 9817.4 10081.5 09:30:42 INFO - PROCESS | 12648 | -------- Summary: end -------- 09:30:42 INFO - PROCESS | 12648 | 09:30:43 INFO - TEST-INFO | 12648: exit 0 09:30:43 INFO - TEST-OK | dromaeo_css | took 1121432ms 09:30:43 INFO - TEST-START | kraken 09:30:43 INFO - operating with platform_type : linux_ 09:30:43 INFO - Initialising browser for kraken test... 09:30:43 INFO - TEST-INFO | started process 12957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBfzy3d/profile http://localhost:52902/getInfo.html) 09:30:47 INFO - PROCESS | 12957 | __metrics Screen width/height:1600/1200 09:30:47 INFO - PROCESS | 12957 | colorDepth:24 09:30:47 INFO - PROCESS | 12957 | Browser inner width/height: 1024/697 09:30:47 INFO - PROCESS | 12957 | __metrics 09:30:48 INFO - PROCESS | 12957 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:30:48 INFO - PROCESS | 12957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:49 INFO - PROCESS | 12957 | console.error: PushService: 09:30:49 INFO - PROCESS | 12957 | stateChangeProcessEnqueue: Error transitioning state 09:30:49 INFO - PROCESS | 12957 | UnknownError 09:30:49 INFO - TEST-INFO | 12957: exit 0 09:30:49 INFO - Browser initialized. 09:30:49 INFO - Running cycle 1/1 for kraken test... 09:30:49 INFO - TEST-INFO | started process 13040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBfzy3d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:02 INFO - PROCESS | 13040 | RSS: Main: 174571520 09:31:02 INFO - PROCESS | 13040 | 09:31:04 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-beat-detection) 09:31:05 INFO - PROCESS | 13040 | RSS: Main: 237662208 09:31:05 INFO - PROCESS | 13040 | 09:31:08 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-dft) 09:31:09 INFO - PROCESS | 13040 | RSS: Main: 217665536 09:31:09 INFO - PROCESS | 13040 | 09:31:12 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-fft) 09:31:13 INFO - PROCESS | 13040 | RSS: Main: 300015616 09:31:13 INFO - PROCESS | 13040 | 09:31:15 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52902/tests/kraken/driver.html?testName=audio-oscillator) 09:31:15 INFO - PROCESS | 13040 | RSS: Main: 208994304 09:31:15 INFO - PROCESS | 13040 | 09:31:18 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:18 INFO - PROCESS | 13040 | RSS: Main: 213667840 09:31:18 INFO - PROCESS | 13040 | 09:31:21 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52902/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:22 INFO - PROCESS | 13040 | RSS: Main: 250335232 09:31:22 INFO - PROCESS | 13040 | 09:31:25 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52902/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:26 INFO - PROCESS | 13040 | RSS: Main: 243892224 09:31:26 INFO - PROCESS | 13040 | 09:31:29 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52902/tests/kraken/driver.html?testName=json-parse-financial) 09:31:30 INFO - PROCESS | 13040 | RSS: Main: 246820864 09:31:30 INFO - PROCESS | 13040 | 09:31:31 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:32 INFO - PROCESS | 13040 | RSS: Main: 210194432 09:31:32 INFO - PROCESS | 13040 | 09:31:34 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:34 INFO - PROCESS | 13040 | RSS: Main: 218218496 09:31:34 INFO - PROCESS | 13040 | 09:31:37 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:37 INFO - PROCESS | 13040 | RSS: Main: 226856960 09:31:37 INFO - PROCESS | 13040 | 09:31:40 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:41 INFO - PROCESS | 13040 | RSS: Main: 229826560 09:31:41 INFO - PROCESS | 13040 | 09:31:44 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:44 INFO - PROCESS | 13040 | RSS: Main: 231723008 09:31:44 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | Cycle 1(1): loaded http://localhost:52902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52902/tests/kraken/driver.html?testName=ai-astar) 09:31:46 INFO - PROCESS | 13040 | RSS: Main: 282345472 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | __start_tp_report 09:31:46 INFO - PROCESS | 13040 | _x_x_mozilla_page_load 09:31:46 INFO - PROCESS | 13040 | _x_x_mozilla_page_load_details 09:31:46 INFO - PROCESS | 13040 | |i|pagename|runs| 09:31:46 INFO - PROCESS | 13040 | |0;ai-astar;110;115;114;114;116;115;114;115;114;112 09:31:46 INFO - PROCESS | 13040 | |1;audio-beat-detection;156;125;125;175;126;135;127;124;159;125 09:31:46 INFO - PROCESS | 13040 | |2;audio-dft;163;163;161;161;160;161;161;162;161;161 09:31:46 INFO - PROCESS | 13040 | |3;audio-fft;76;75;77;109;76;79;77;78;107;76 09:31:46 INFO - PROCESS | 13040 | |4;audio-oscillator;84;82;118;84;83;83;110;84;84;110 09:31:46 INFO - PROCESS | 13040 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;118;118 09:31:46 INFO - PROCESS | 13040 | |6;imaging-darkroom;147;147;145;147;146;147;145;147;146;145 09:31:46 INFO - PROCESS | 13040 | |7;imaging-desaturate;95;94;95;95;94;96;95;96;94;95 09:31:46 INFO - PROCESS | 13040 | |8;json-parse-financial;64;63;62;63;64;63;64;63;64;63 09:31:46 INFO - PROCESS | 13040 | |9;json-stringify-tinderbox;65;66;66;66;66;66;64;66;67;66 09:31:46 INFO - PROCESS | 13040 | |10;stanford-crypto-aes;84;84;84;83;82;84;83;82;83;86 09:31:46 INFO - PROCESS | 13040 | |11;stanford-crypto-ccm;151;141;147;139;144;139;138;138;185;141 09:31:46 INFO - PROCESS | 13040 | |12;stanford-crypto-pbkdf2;179;179;181;181;179;178;183;175;174;174 09:31:46 INFO - PROCESS | 13040 | |13;stanford-crypto-sha256-iterative;70;71;70;69;70;70;71;68;69;68 09:31:46 INFO - PROCESS | 13040 | __end_tp_report 09:31:46 INFO - PROCESS | 13040 | __start_cc_report 09:31:46 INFO - PROCESS | 13040 | _x_x_mozilla_cycle_collect,1900 09:31:46 INFO - PROCESS | 13040 | __end_cc_report 09:31:46 INFO - PROCESS | 13040 | __startTimestamp1475857906956__endTimestamp 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | ------- Summary: start ------- 09:31:46 INFO - PROCESS | 13040 | Number of tests: 14 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.73 (1.5%) stddev-sans-first:1.12 09:31:46 INFO - PROCESS | 13040 | Values: 110.0 115.0 114.0 114.0 116.0 115.0 114.0 115.0 114.0 112.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:131.00 stddev:18.59 (14.2%) stddev-sans-first:18.50 09:31:46 INFO - PROCESS | 13040 | Values: 156.0 125.0 125.0 175.0 126.0 135.0 127.0 124.0 159.0 125.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 09:31:46 INFO - PROCESS | 13040 | Values: 163.0 163.0 161.0 161.0 160.0 161.0 161.0 162.0 161.0 161.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.23 (17.3%) stddev-sans-first:13.79 09:31:46 INFO - PROCESS | 13040 | Values: 76.0 75.0 77.0 109.0 76.0 79.0 77.0 78.0 107.0 76.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.50 stddev:14.30 (17.1%) stddev-sans-first:14.86 09:31:46 INFO - PROCESS | 13040 | Values: 84.0 82.0 118.0 84.0 83.0 83.0 110.0 84.0 84.0 110.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:31:46 INFO - PROCESS | 13040 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 09:31:46 INFO - PROCESS | 13040 | Values: 147.0 147.0 145.0 147.0 146.0 147.0 145.0 147.0 146.0 145.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:31:46 INFO - PROCESS | 13040 | Values: 95.0 94.0 95.0 95.0 94.0 96.0 95.0 96.0 94.0 95.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 09:31:46 INFO - PROCESS | 13040 | Values: 64.0 63.0 62.0 63.0 64.0 63.0 64.0 63.0 64.0 63.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 09:31:46 INFO - PROCESS | 13040 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 64.0 66.0 67.0 66.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 09:31:46 INFO - PROCESS | 13040 | Values: 84.0 84.0 84.0 83.0 82.0 84.0 83.0 82.0 83.0 86.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:142.50 stddev:14.24 (10.0%) stddev-sans-first:15.01 09:31:46 INFO - PROCESS | 13040 | Values: 151.0 141.0 147.0 139.0 144.0 139.0 138.0 138.0 185.0 141.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:179.00 stddev:3.09 (1.7%) stddev-sans-first:3.27 09:31:46 INFO - PROCESS | 13040 | Values: 179.0 179.0 181.0 181.0 179.0 178.0 183.0 175.0 174.0 174.0 09:31:46 INFO - PROCESS | 13040 | 09:31:46 INFO - PROCESS | 13040 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 09:31:46 INFO - PROCESS | 13040 | Values: 70.0 71.0 70.0 69.0 70.0 70.0 71.0 68.0 69.0 68.0 09:31:46 INFO - PROCESS | 13040 | -------- Summary: end -------- 09:31:46 INFO - PROCESS | 13040 | 09:31:48 INFO - TEST-INFO | 13040: exit 0 09:31:48 INFO - TEST-OK | kraken | took 64789ms 09:31:48 INFO - SUITE-END | took 1186s 09:31:48 INFO - Completed test suite (00:19:46) 09:31:48 INFO - javascript benchmark 09:31:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2547.4522977559823, 2560.361368724016, 2592.209376140277, 2600.4669042846217, 2607.34816295926, 4574.062317224969, 4639.0, 4647.558481944214, 4659.394278743763, 4670.626349892009, 4657.743824089674, 4680.929786053203, 4682.765861706918, 4716.646251531131, 4773.546513081252, 4288.0, 4308.418363520916, 4354.368616550598, 4356.237658409781, 4358.259095953679, 4372.0, 4374.234508960935, 4379.474463064436, 4393.648508119359, 4394.296912494002, 4197.391378250137, 4362.192994296065, 4368.0, 4379.0, 4466.665000124987, 4244.511881133647, 4264.104538047014, 4287.292596721537, 4290.570942905684, 4325.9134817303475, 4289.742615443052, 4293.270144075484, 4298.935515967263, 4342.326939324378, 4345.044090300129, 4664.300354946751, 4676.766161691902, 4687.250039993584, 4691.061787642451, 4707.435107787053, 4776.164171270014, 4816.903661926777, 4822.42130944289, 4895.094407534618, 4993.076280888047, 4916.041371932474, 4935.728534930578, 4992.176290912032, 4993.600511959071, 5115.079285728568, 4691.460482044608, 4693.671442999025, 4698.647601429906, 4745.715257084586, 4751.192297309466, 5136.43499215086, 5144.022635699205, 5145.0, 5149.0, 5158.0, 4779.95220047802, 4823.614110871192, 4826.469088400273, 4880.853574392774, 4977.651564390458, 4994.725290109006, 5028.5977121830165, 5033.949660503421, 5092.388913330424, 5100.566451851634, 4936.481669424658, 4982.476839931827, 4992.475790041994, 5003.674761140514, 5050.77271522775, 4809.639277054235, 4860.295257187759, 4977.278294647256, 4979.4771548987555, 4985.975070124626, 4132.297509423405, 4157.937630935538, 4170.562090980464, 4175.54069052404, 4228.450301460852, 3641.7450778445786, 3653.397189463762, 3659.0486473516544, 3697.1681371691693, 3700.4264339027495, 4290.785460726951, 4296.613304802583, 4297.205017071852, 4297.290946993711, 4346.0, 4885.9755701221975, 4934.753262336869, 4939.678920870132, 4966.304717339575, 5008.724520151354, 4287.957120428819, 4292.871213863589, 4315.611594956406, 4339.869803905888, 4347.152305300499, 4521.163584736834, 4521.796519156645, 4521.819127234874, 4567.246404343313, 4578.725276483355, 4623.283391074388, 4670.649701272486, 4727.763611819395, 4736.952630473651, 4742.383490146259, 4923.138450771173, 4937.876553086202, 4974.154393752999, 4976.402831660079, 5030.798768049383, 4658.04510075427, 4670.252759558454, 4678.906421871611, 4680.789364478538, 4737.170995075779, 4807.18277892766, 4854.73298968546, 4855.150348689036, 4862.805487780449, 4921.31101645777, 4907.4847141051105, 4961.801527938842, 4979.103761322996, 4981.726005069756, 5002.149634562206, 4886.3403440536495, 4891.584215341736, 4894.951050489592, 4912.287718280901, 4944.134776414041, 4883.536064073907, 4886.144924638245, 4889.2910527972535, 4890.731009794353, 4950.034743225036, 4697.248440249544, 4711.8350857719815, 4730.6215502759005, 4766.022965292037, 4812.230043193073, 4903.705777653352, 4908.337374454546, 4910.975445122752, 4953.504649535018, 4971.353724015855, 4661.067786442793, 4701.553352431513, 4779.139754844162, 4812.205986012269, 4833.323334733211], "value": 4580.620512018995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5999680230234, 568.3520786303612, 569.7749388991349, 571.782722565425, 574.2620732358919, 28053.859730701344, 38314.0, 39518.80240598793, 39586.60413395865, 43050.35424468636, 40111.0, 40709.18581628366, 40778.38832417509, 40794.38808417876, 40795.38806917891, 7607.695692172307, 7744.651490682904, 7751.263629955173, 7783.41624378171, 7863.449558530905, 7674.769756907302, 7750.883736743954, 7763.961180194119, 7767.728129515468, 7772.067351917778, 7768.805779855521, 7807.531548107132, 7808.375329973617, 7811.140774514799, 7819.6481158348015, 7654.770356889302, 7692.4615276930635, 7721.691132354756, 7747.806304842367, 7760.301572858441, 7533.736319228856, 7608.809779755495, 7623.961880190619, 7629.427792915498, 7629.6948122075055, 36469.81765091157, 36797.264054719024, 37141.386015866956, 37204.62795372066, 37247.62752372469, 3009.5335223040465, 3012.5932999045067, 3083.5528848316867, 3104.5498402731478, 3132.3891841090995, 28805.56791648127, 28876.42247155045, 28916.566251506243, 29411.0, 30758.69241307603, 3347.41420251455, 3388.440907250301, 3410.1133705236816, 3422.058933793202, 3436.8004477134655, 174381.99999999872, 174813.0, 175432.12283938625, 175438.0, 175829.0, 28951.0, 30206.0, 50948.74525627348, 51133.48866511362, 51576.22635660468, 33134.83432582822, 33331.16672083169, 33332.50001249983, 33336.33327333488, 33366.66633333684, 12423.75152496945, 12640.367981600883, 12641.494340226289, 12644.0, 12645.873541264653, 9784.902150978542, 9785.315027947976, 9790.363626364264, 9790.95104524487, 9800.411975281506, 7990.240927112031, 8010.359171266285, 8027.39794515402, 8108.8378232435025, 8109.7161599343735, 3111.9533207001914, 3132.9686703133134, 3160.7313378362637, 3189.3142974260645, 3190.122716253049, 858.1418581418582, 868.2186032570737, 914.2457472585144, 968.1673760565908, 997.3168379659957, 26979.86510067437, 27464.0, 27603.0, 28193.79736457976, 28227.57658635122, 896.4845214001975, 906.3972458315278, 946.3895787217207, 949.0414681172066, 970.8786401699788, 14113.576592702235, 14903.727169232377, 14937.0, 15107.169105699073, 15219.934604577573, 359888.0, 362620.0, 363991.0, 364107.0, 364798.0, 48462.75768621134, 48827.75586122047, 48853.26720099201, 48865.511344886094, 48873.266900995804, 1111.366521082991, 1122.618309774664, 1181.7459246262094, 1183.9940800296115, 1191.5829459689212, 26357.868210658824, 27149.0, 27487.17538473849, 28160.577591336558, 28211.43577128405, 42445.57554424416, 42502.78748606361, 42737.0, 42840.571594284906, 42861.0, 303282.0, 306196.0, 306677.0, 307439.0, 308081.0, 25362.873185633955, 25482.235532934043, 25885.0, 25928.22215333543, 25972.610410843474, 41406.585934140276, 41616.79191604022, 42611.573884262, 42867.0, 42957.57042429536, 34934.30131397307, 35224.647753522135, 35619.28761424705, 35995.1001224961, 36536.26927461383, 35164.47253291152, 35304.293914122085, 35653.82173089118, 35875.461868072525, 35918.461223081154, 34882.825585871906, 35294.0, 35474.467882982295, 35641.46537801883, 36193.63806361903, 29892.85053574718, 32278.677213227566, 32592.34815303728, 32615.347693046482, 32716.345673086882, 24321.391965200302, 25025.624615631143, 25071.0, 25192.622110667988, 25482.872585636953], "value": 15987.73076795671, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.78614080059185, 343.9518467414564, 357.15710922223553, 357.8497031246876, 369.80954808273725, 12267.202631828935, 13321.866781332184, 15691.999999999985, 16153.676926461463, 16174.35302587898, 15980.600484987881, 16427.342906283764, 16602.418915337967, 16759.16204189792, 16765.0, 4452.398926144978, 4936.2842387853825, 5158.613104017214, 5159.819406320779, 5160.974195129038, 5921.496672782819, 6082.422169893853, 6082.878342433149, 6085.726142323606, 6091.756329746827, 5820.883582328351, 6032.366601506845, 6033.849153771147, 6045.697715114248, 6089.78685745999, 6037.547183961198, 6044.818655440344, 6052.9697351513405, 6062.42406971337, 6076.088586711984, 4747.35910652061, 5042.218456139268, 5058.418281897555, 5136.332276804029, 5282.788688452496, 12208.145429819917, 12232.266064036186, 12279.0, 12459.190152640049, 12475.438605262785, 1948.7758907725652, 1957.5106223444138, 2002.349236498144, 2139.379579921821, 2261.163369553259, 8674.219320261207, 9038.322125840523, 9421.104995025462, 9544.856827147598, 9557.044295570457, 1687.131127469342, 1711.2470512974376, 1725.8187890271593, 1735.609487865233, 1783.6700210461106, 64542.67728661373, 68205.0, 68732.6563367185, 68840.0, 73931.0, 9772.9022709772, 9884.406935583887, 10009.69970900874, 10064.69805905824, 10109.898901010896, 13815.171089734647, 13833.377498012613, 13836.446542138201, 13844.377003034888, 13847.376868040963, 6523.217213934264, 6540.411362977355, 6674.199096108498, 6719.092922455504, 7067.646617669199, 5913.674747888821, 5917.349091599921, 6123.4795042421, 6129.785457508966, 6141.048137538689, 4163.458750362494, 4221.197972385237, 4230.196262710076, 4347.739135651871, 4366.956330436718, 1780.8753387263027, 1828.9451316460527, 1843.4746097362188, 1859.8884066956025, 1879.4643526595128, 751.7406494759299, 803.9437239393186, 889.5329951775241, 901.1394118616705, 958.7363475044418, 15829.208539572975, 16504.42234521786, 17021.40425085116, 17266.740998885027, 17294.567635808955, 829.9336053115736, 869.365363284793, 873.3362644390309, 890.7684002159485, 908.7191150212881, 9321.161095501437, 9460.385074970105, 9478.668246611336, 9505.5722492488, 9625.614975401046, 349292.0, 357351.0, 358039.0, 358056.0, 358954.0, 72299.51657009704, 72813.0, 74189.0, 75802.0, 76774.23225767782, 859.4241857955185, 868.5006121480175, 876.333986170515, 897.0536084430988, 901.6934242357498, 14530.709385812013, 14885.255737213312, 15092.471763488225, 15133.54599362021, 15220.467283645019, 35050.298994020486, 35113.824430877685, 35718.0, 36145.096372590895, 36276.63723362733, 48205.0, 48792.512074878796, 49218.0, 49353.75323123361, 49594.0, 7365.631718414165, 7443.404527637885, 7507.324340809353, 7567.356774673995, 7936.880946785918, 8244.949368733367, 11346.0, 11447.484863181011, 11464.197506174822, 11514.94242528782, 9246.167844893722, 9747.0, 9830.115289623967, 10045.49772511386, 10357.326773759682, 9232.353735238468, 9518.0, 9732.41605503672, 9787.559559819967, 10131.44277064739, 9893.0, 9919.752006199902, 10099.44453055089, 10202.540885660015, 10552.261341706007, 7420.220876807857, 7567.0, 7684.500507466997, 8045.879311810445, 8253.174682531699, 9887.209023278265, 9894.356866803635, 10008.799824003334, 10192.08271255561, 10616.044555989998], "value": 7956.691230557526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1203.3922868951179, 1340.3298350824584, 1365.98234315435, 1417.7589809732344, 1670.8830381873258, 6651.534392592514, 7502.887456688154, 7746.34156096731, 7779.416543759226, 7874.527528348303, 7811.726589569366, 7818.413618978571, 7823.491473054248, 7844.294013538781, 7865.92134078659, 2162.308061420346, 2169.6420090685056, 2174.2607513445423, 2182.138055468089, 2196.802287794098, 2149.5163588192686, 2187.4312678703573, 2213.9335819925427, 2215.6122678531274, 2217.4456385903522, 2149.8280137588954, 2168.338656709711, 2170.967435488469, 2179.030331502482, 2191.068795761803, 2106.2101711858054, 2107.5047363869553, 2107.599556084339, 2108.9261875834427, 2112.26070875194, 2064.3910046536307, 2127.7340332458443, 2129.1164166870885, 2132.1364847236737, 2132.829373650104, 7458.552486850806, 7642.541447513111, 7711.228877112244, 7750.341220996165, 7778.144404115543, 4276.080642661843, 4343.1747967886, 4351.6953813233085, 4354.8258069677495, 4358.346248062784, 2698.8515631640253, 2814.1838866728626, 2858.542633178702, 2869.253993961564, 2872.224499385154, 962.1052421248237, 966.1304825656965, 970.3692599810109, 979.1139019187647, 984.0897170117684, 10056.0, 10080.495975201284, 10088.646897358558, 10105.545250463672, 10144.695659130239, 3899.3566061599518, 3959.0696186396176, 4026.5168179818024, 4037.535683396447, 4054.8175332110127, 8070.354371650254, 8141.470804397695, 8148.470349427387, 8192.959035204905, 8212.794680133044, 4437.378766972626, 4438.866833994985, 4440.178566965122, 4451.043025749479, 4451.933221001687, 3602.6397360264286, 3741.102135487518, 4143.150654115899, 4144.046869220036, 4146.79266036703, 3222.8871989480253, 3258.5926759155104, 3357.84889679965, 3366.495025746158, 3386.475096360068, 1024.9538770755335, 1036.9896301036893, 1046.6859942017363, 1047.8218702820539, 1051.0, 683.5181197256022, 712.9251428600026, 715.4777012780595, 736.7089999450187, 843.5402705525503, 4994.600431965434, 5023.8756468402025, 5137.948620513747, 5184.948150518522, 5319.308489896289, 398.2095540352456, 398.5735263268333, 403.3566461493912, 407.7471967380184, 412.78741448154227, 3539.876104336336, 3602.9819850900576, 3684.2263124743567, 3684.9263014739554, 3722.813859307024, 9102.453852768855, 9494.192993595621, 9537.0, 9564.13922746956, 9615.375000625078, 9383.155516003593, 9422.670206542738, 9462.101100395452, 9471.052894710612, 9492.430454172634, 6969.407600354027, 7014.859702805916, 7107.466939979522, 7135.250798666169, 7172.641367931583, 5107.442230119849, 5149.922751158811, 5218.765155568084, 5230.398504172069, 5348.545373643284, 8234.258916697527, 8522.616482258438, 8667.0, 8686.565671716262, 8774.429662071945, 8683.435576687496, 8797.516136612549, 8810.911890881009, 8889.955550222208, 8896.288296936358, 5488.506034456758, 6272.905906411316, 6317.210348706411, 6347.96826015867, 6349.460295874902, 6527.0, 6771.796846094625, 7103.786886393416, 7115.85768284621, 7192.065031545865, 6394.680265986589, 6484.837879053061, 6662.666866656745, 6685.364890335411, 6716.3955244028275, 6505.73977040932, 6527.771527996498, 6620.5034622402545, 6652.534322597372, 6734.898976515258, 6028.306744724413, 6110.755569777337, 6115.541334400027, 6119.969400152971, 6125.050617154348, 4377.627901628397, 4406.647468202472, 4429.117625009422, 4509.729416235036, 4544.409226800495, 4449.199144153954, 4502.3471596618965, 4508.9098218036115, 4590.196715574694, 4651.2557990721325], "value": 3917.740303999226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.4760512211432, 285.63724070430555, 294.72590490843515, 300.514668809872, 301.421271159374, 4600.757795395241, 4739.952600473995, 4806.279058141276, 4810.807567697292, 4827.348307978422, 4577.954220457795, 4670.229412146991, 4689.202835517962, 4705.670603057779, 4732.290156476531, 3515.874920025593, 3631.512413996421, 3726.142987112966, 3733.9253214935684, 3742.6818720408796, 3627.7460577759566, 3725.2735716535285, 3738.626137386253, 3739.9626003740022, 3751.799424184262, 3691.926161476769, 3694.5197124373926, 3709.7588656737225, 3711.498947642074, 3711.498947642074, 3713.7214708896804, 3723.2181241939224, 3724.3854763963914, 3732.8241603894685, 3777.527809023872, 3258.185453636591, 3306.7354611631013, 3321.820753632474, 3324.8670053197843, 3348.564686590752, 4603.7698115094445, 4628.236341003731, 4632.536746325374, 4642.582167604932, 4648.302754586805, 4263.91472170558, 4264.296391095466, 4267.466566679165, 4275.743455392686, 4277.572242775697, 4804.25534042224, 4965.875853103701, 4989.750512474362, 4990.50094990498, 4995.625328100407, 3623.3115708015657, 3629.872954446582, 3632.745707800455, 3638.381475149231, 3641.035125691694, 5203.089459344599, 5239.476052394768, 5248.527632513092, 5249.868753281198, 5251.188340022686, 3473.583170019614, 3634.6547078027547, 3662.5421822272215, 3699.408094704834, 3736.4021756518828, 3730.7948062856804, 3730.981345093257, 3737.906552336159, 3745.700343972476, 3747.9063023424087, 4214.578542145761, 4216.578342165759, 4221.155768846243, 4226.344916537942, 4230.1539692061715, 4765.973606759732, 4865.391826021747, 4882.926756098661, 4913.778879950411, 4958.8760280993265, 1261.6341261034381, 1288.5747703257903, 1294.779887419141, 1295.33290355467, 1297.7606385901443, 812.6830536090929, 846.1411667157716, 851.3997631669658, 857.2284943550729, 857.8241460500583, 3910.7849068301516, 3939.9015024624614, 3946.348852439373, 3955.20895820837, 3959.8812035638975, 4528.7509186994375, 4557.69836232707, 4571.497135315112, 4574.473935497461, 4580.5036255240975, 3960.2475529649273, 3960.405939109157, 3962.643362097425, 3962.8612998544913, 3963.742356746802, 2317.953640927206, 2416.6196296647786, 2428.599281118631, 2431.3556907419547, 2438.097903775614, 4309.1381723655395, 4320.762358070274, 4333.133373325348, 4334.092999080394, 4336.631386332134, 4639.907201855944, 4643.558861908114, 4645.605123564467, 4659.790309436084, 4660.650451216173, 4130.876073717794, 4293.549177336335, 4341.587549182823, 4348.391225228471, 4357.760323182255, 4534.682572219913, 4552.817887284472, 4553.268039176468, 4563.53966730643, 4579.404677391918, 4435.33674871923, 4458.197524445502, 4460.7323560586465, 4467.932981005222, 4476.328550717419, 4145.2952997991015, 4327.004788898634, 4334.266293482632, 4339.544347843557, 4356.956430435655, 3408.4376077946863, 3439.1917899294144, 3527.506149139174, 3550.1716615942296, 3681.650243226889, 5042.344495215745, 5050.191969284897, 5060.898782024413, 5061.4179369373, 5064.392272927273, 4926.704397736147, 4931.939632978927, 4934.753262336797, 4940.209566469348, 4950.405951285725, 4742.822309053012, 4901.289313049517, 4905.926411103765, 4931.9753401232765, 4962.3052772611145, 4852.587530059844, 4855.927161092516, 4858.78135483897, 4865.294532292727, 4871.488493708252, 4947.727874966911, 4949.455559888337, 4957.876053098701, 4969.776360063734, 4970.776315065758, 4656.8137274508645, 4788.41982145898, 4819.421669399694, 4834.323194752667, 4868.367112275381], "value": 3633.229743044518, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.7888186339441, 651.7490766055068, 670.5306285600082, 733.6441825714525, 741.9406447484201, 13512.797308040388, 14366.20985845778, 14408.207548584824, 14412.27052753671, 14555.563333099997, 12262.81605775914, 12283.815742763865, 12299.38503074845, 12300.753984920297, 12320.938395308034, 624.0607885132869, 642.0305338938214, 756.7124492692769, 758.4349659503678, 779.9766007019798, 745.6346390268784, 759.2407592407592, 760.6881178716727, 761.0030859573948, 761.4213197969527, 833.3083540661237, 834.3575446905879, 834.7245409015011, 834.7787836223406, 835.2900034970287, 630.4578062865932, 663.7278715726529, 783.1307248953657, 821.5235163605095, 821.5399376349234, 586.6656006076538, 591.7751254523297, 591.9763209471616, 592.2005292854611, 592.3720855892724, 13771.036027478081, 13810.723785524233, 13814.309284535733, 13818.0, 13818.516351927734, 12580.685482863002, 12840.486380544768, 13130.540431084866, 13293.202407855462, 13514.797278040838, 12043.819342709867, 12048.457819398149, 12063.939680301542, 12093.213941093802, 12461.563845265373, 4156.459660244149, 4168.124693814302, 4203.47456567929, 4209.74741515507, 4368.956310436918, 59392.10911836326, 60035.0, 60631.69684151595, 60894.0, 61613.38386616121, 9658.565364558612, 9799.902000980042, 9825.705228843146, 10080.09279164864, 10090.747731306776, 19602.0, 19602.607947840963, 19626.901865490865, 19741.703874441893, 19809.900950495154, 6746.0, 6800.625965571842, 6895.138107736533, 6909.827254318581, 6915.757948471779, 3598.9100272493397, 3626.2747450510005, 3719.814009299524, 3751.2685026419585, 3779.6787273081545, 2787.6236708044153, 2878.1797187801376, 3097.969020309813, 3234.4016356974034, 3274.672532746706, 537.7042626555457, 546.9343678758574, 547.6905548365161, 550.1005855426326, 555.3585608622049, 572.9083346664513, 586.9970650146807, 592.6796591344922, 601.7863658401204, 605.3522730678133, 8166.0, 8338.332933365316, 8368.707095251637, 8413.411061225655, 8681.913180868236, 544.6922488793819, 559.2478116932718, 560.927079479665, 591.4499515450672, 605.2948315212816, 3644.671979521856, 3915.158240978203, 3989.8204580793936, 4088.3867419887256, 4157.584241575879, 72713.6364318175, 72872.0, 73540.0, 101993.49003254937, 102402.0, 45727.542724572995, 45765.542344576126, 66168.00747988783, 77444.0, 77985.61007194928, 65875.67062164658, 67459.0, 68682.0, 69620.6518967402, 73311.63344183245, 8153.826944687227, 8291.709790157316, 8361.916380836114, 8638.7486584251, 8791.560421979004, 42401.36397954095, 42505.57494425016, 43081.784591076845, 43179.0, 43201.3519797197, 38087.238255235294, 46843.531564683915, 49953.50046499634, 51677.22484162665, 53981.0, 11642.24325418845, 11704.824427633423, 11710.88289117132, 11872.287662740264, 12440.502379904703, 13105.820476157192, 13308.667283317607, 13342.0, 13729.313534323444, 14182.290885455892, 11983.940080299542, 12223.205491643015, 12878.484860605471, 13148.276844773629, 13264.071514993857, 11301.208915375844, 12773.425195866022, 12911.22532648044, 13090.14914030585, 13316.86683133195, 12188.2887305436, 12212.328321942023, 12438.88811286481, 12545.0, 13249.271290079138, 9683.041063064991, 9891.109800118023, 10024.348417352849, 10285.228607854591, 10287.84568231492, 9017.774555636162, 9183.816323673356, 9512.191463725661, 9817.361871478332, 10081.495925203857], "value": 6554.153167389283, "unit": "score"}], "name": "dromaeo_css", "value": 6154.929662672815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 114.0, 114.0, 116.0, 115.0, 114.0, 115.0, 114.0, 112.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 125.0, 175.0, 126.0, 135.0, 127.0, 124.0, 159.0, 125.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 109.0, 76.0, 79.0, 77.0, 78.0, 107.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 118.0, 84.0, 83.0, 83.0, 110.0, 84.0, 84.0, 110.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 64.0, 66.0, 67.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 83.0, 82.0, 84.0, 83.0, 82.0, 83.0, 86.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 141.0, 147.0, 139.0, 144.0, 139.0, 138.0, 138.0, 185.0, 141.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 181.0, 181.0, 179.0, 178.0, 183.0, 175.0, 174.0, 174.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 69.0, 70.0, 70.0, 71.0, 68.0, 69.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1553.1999999999998, "alertThreshold": 2.0}]} 09:31:48 INFO - Return code: 0 09:31:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:48 INFO - # TBPL SUCCESS # 09:31:48 INFO - Running post-action listener: _resource_record_post_action 09:31:48 INFO - [mozharness: 2016-10-07 16:31:48.753518Z] Finished run-tests step (success) 09:31:48 INFO - Running post-run listener: _resource_record_post_run 09:31:48 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 393404416; Read time: 0; Write time: 220252 09:31:48 INFO - TinderboxPrint: CPU usage
13.1% 09:31:48 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:31:48 INFO - TinderboxPrint: I/O write bytes / time
393,404,416 / 220,252 09:31:48 INFO - TinderboxPrint: CPU idle
8,340.6 (86.9%) 09:31:48 INFO - TinderboxPrint: CPU user
1,208.3 (12.6%) 09:31:48 INFO - TinderboxPrint: Swap in / out
0 / 0 09:31:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99856384; Read time: 0; Write time: 66612 09:31:48 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293548032; Read time: 0; Write time: 153640 09:31:49 INFO - Running post-run listener: _upload_blobber_files 09:31:49 INFO - Blob upload gear active. 09:31:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:49 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 09:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:31:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:53 INFO - (blobuploader) - INFO - Done attempting. 09:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:53 INFO - (blobuploader) - INFO - Done attempting. 09:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:54 INFO - (blobuploader) - INFO - Done attempting. 09:31:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:54 INFO - Return code: 0 09:31:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18c5d291598fabe2fd40cf80d51006c95eba3c158adfcc9974793b80b70682be07899cff9c0c1f9ed5b12bbcb249531ce82a6ad34099d07c04f1f3374073781b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce6128124f0767cdda8a4088e2b4289cf289d73719e91205281b3791535ddfb72bed52cba73f9e08c93f3b7c30bc5c1d20d332be4c106cc705d5114fdfd585f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c646c7df77139eafa9c9d089b2d25e1c8503cd4a5576785ba731ddb6d33ffa4cc98f6e76a38b12a6d973e5612d2635cee9e75acc0896efe78f170edc4196399"} 09:31:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:54 INFO - Contents: 09:31:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18c5d291598fabe2fd40cf80d51006c95eba3c158adfcc9974793b80b70682be07899cff9c0c1f9ed5b12bbcb249531ce82a6ad34099d07c04f1f3374073781b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce6128124f0767cdda8a4088e2b4289cf289d73719e91205281b3791535ddfb72bed52cba73f9e08c93f3b7c30bc5c1d20d332be4c106cc705d5114fdfd585f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c646c7df77139eafa9c9d089b2d25e1c8503cd4a5576785ba731ddb6d33ffa4cc98f6e76a38b12a6d973e5612d2635cee9e75acc0896efe78f170edc4196399"} 09:31:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:54 INFO - Copying logs to upload dir... 09:31:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.518233 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-07 09:31:53.724567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 09:31:53.728584) ========= 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=523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18c5d291598fabe2fd40cf80d51006c95eba3c158adfcc9974793b80b70682be07899cff9c0c1f9ed5b12bbcb249531ce82a6ad34099d07c04f1f3374073781b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce6128124f0767cdda8a4088e2b4289cf289d73719e91205281b3791535ddfb72bed52cba73f9e08c93f3b7c30bc5c1d20d332be4c106cc705d5114fdfd585f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c646c7df77139eafa9c9d089b2d25e1c8503cd4a5576785ba731ddb6d33ffa4cc98f6e76a38b12a6d973e5612d2635cee9e75acc0896efe78f170edc4196399"} build_url:https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/A4UcU1SuQXiuv4ujGUETdg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18c5d291598fabe2fd40cf80d51006c95eba3c158adfcc9974793b80b70682be07899cff9c0c1f9ed5b12bbcb249531ce82a6ad34099d07c04f1f3374073781b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce6128124f0767cdda8a4088e2b4289cf289d73719e91205281b3791535ddfb72bed52cba73f9e08c93f3b7c30bc5c1d20d332be4c106cc705d5114fdfd585f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c646c7df77139eafa9c9d089b2d25e1c8503cd4a5576785ba731ddb6d33ffa4cc98f6e76a38b12a6d973e5612d2635cee9e75acc0896efe78f170edc4196399"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 09:31:53.754361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:31:53.754694) ========= 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=523ca41ca1e0623de333ad52000001bf-1475856666.636303-431013131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 09:31:53.841341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 09:31:53.841820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 09:31:53.842305) ========= ========= Total master_lag: 0.16 =========