builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1475511488.07 results: success (0) buildid: 20161003063000 builduid: 4b0069ace3ce4f2fa869e2f9bb344b82 revision: 73e1dac8253d1c57cef65bd88f923738b7b84de0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.069133) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.069568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.069905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.086189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.086486) ========= 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=826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 09:18:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-03 09:18:11 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.184325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.184859) ========= 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=826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014728 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.237885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:08.238281) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 73e1dac8253d1c57cef65bd88f923738b7b84de0 --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 73e1dac8253d1c57cef65bd88f923738b7b84de0 --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=826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 09:18:11,449 truncating revision to first 12 chars 2016-10-03 09:18:11,450 Setting DEBUG logging. 2016-10-03 09:18:11,450 attempt 1/10 2016-10-03 09:18:11,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/73e1dac8253d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 09:18:12,032 unpacking tar archive at: autoland-73e1dac8253d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965322 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:09.217800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:09.218152) ========= script_repo_revision: 73e1dac8253d1c57cef65bd88f923738b7b84de0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:09.218659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:09.218990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 09:18:09.229260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-03 09:18:09.230080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:18:12 INFO - MultiFileLogger online at 20161003 09:18:12 in /builds/slave/test 09:18:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:18:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:12 INFO - {'append_to_log': False, 09:18:12 INFO - 'base_work_dir': '/builds/slave/test', 09:18:12 INFO - 'blob_upload_branch': 'Autoland', 09:18:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:12 INFO - 'branch': 'Autoland', 09:18:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:12 INFO - 'config_files': ('talos/linux_config.py',), 09:18:12 INFO - 'default_actions': ('clobber', 09:18:12 INFO - 'read-buildbot-config', 09:18:12 INFO - 'download-and-extract', 09:18:12 INFO - 'populate-webroot', 09:18:12 INFO - 'create-virtualenv', 09:18:12 INFO - 'install', 09:18:12 INFO - 'run-tests'), 09:18:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:12 INFO - 'download_minidump_stackwalk': True, 09:18:12 INFO - 'download_symbols': 'ondemand', 09:18:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:12 INFO - 'installer_path': 'installer.exe', 09:18:12 INFO - 'log_level': 'info', 09:18:12 INFO - 'log_name': 'talos', 09:18:12 INFO - 'log_to_console': True, 09:18:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:18:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:18:12 INFO - 'opt_config_files': (), 09:18:12 INFO - 'pip_index': False, 09:18:12 INFO - 'sps_profile': False, 09:18:12 INFO - 'sps_profile_interval': 0, 09:18:12 INFO - 'suite': 'dromaeojs-e10s', 09:18:12 INFO - 'system_bits': '32', 09:18:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:12 INFO - 'title': 'talos-linux64-ix-052', 09:18:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:12 INFO - 'use_talos_json': True, 09:18:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:12 INFO - 'work_dir': 'build'} 09:18:12 INFO - [mozharness: 2016-10-03 16:18:12.545619Z] Running clobber step. 09:18:12 INFO - Running pre-action listener: _resource_record_pre_action 09:18:12 INFO - Running main action method: clobber 09:18:12 INFO - rmtree: /builds/slave/test/build 09:18:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:13 INFO - Running post-action listener: _resource_record_post_action 09:18:13 INFO - [mozharness: 2016-10-03 16:18:13.005738Z] Finished clobber step (success) 09:18:13 INFO - [mozharness: 2016-10-03 16:18:13.005838Z] Running read-buildbot-config step. 09:18:13 INFO - Running pre-action listener: _resource_record_pre_action 09:18:13 INFO - Running main action method: read_buildbot_config 09:18:13 INFO - Using buildbot properties: 09:18:13 INFO - { 09:18:13 INFO - "project": "", 09:18:13 INFO - "product": "firefox", 09:18:13 INFO - "script_repo_revision": "production", 09:18:13 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:18:13 INFO - "repository": "", 09:18:13 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 09:18:13 INFO - "buildid": "20161003063000", 09:18:13 INFO - "pgo_build": "True", 09:18:13 INFO - "basedir": "/builds/slave/test", 09:18:13 INFO - "buildnumber": 268, 09:18:13 INFO - "slavename": "talos-linux64-ix-052", 09:18:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:18:13 INFO - "platform": "ubuntu64_hw", 09:18:13 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 09:18:13 INFO - "branch": "autoland", 09:18:13 INFO - "repo_path": "integration/autoland", 09:18:13 INFO - "revision": "73e1dac8253d1c57cef65bd88f923738b7b84de0", 09:18:13 INFO - "stage_platform": "linux64-pgo", 09:18:13 INFO - "builduid": "4b0069ace3ce4f2fa869e2f9bb344b82", 09:18:13 INFO - "slavebuilddir": "test" 09:18:13 INFO - } 09:18:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:18:13 INFO - Running post-action listener: _resource_record_post_action 09:18:13 INFO - [mozharness: 2016-10-03 16:18:13.008287Z] Finished read-buildbot-config step (success) 09:18:13 INFO - [mozharness: 2016-10-03 16:18:13.008376Z] Running download-and-extract step. 09:18:13 INFO - Running pre-action listener: _resource_record_pre_action 09:18:13 INFO - Running main action method: download_and_extract 09:18:13 INFO - mkdir: /builds/slave/test/build/tests 09:18:13 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:18:13 INFO - trying https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:18:13 INFO - Downloading https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/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:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/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:18:13 INFO - Downloaded 1361 bytes. 09:18:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:18:13 INFO - Using the following test package requirements: 09:18:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:18:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:18:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'jsshell-linux-x86_64.zip'], 09:18:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:18:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:18:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:18:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:18:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:18:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:18:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:13 INFO - Fetch https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:14 INFO - Http code: 200 09:18:14 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 09:18:14 INFO - x-amz-cf-id: -cb8EPBLw0MnWiRV8LwXkB7jKa3yyrrpNQ0riv8IvEq5cimBxb-TcQ== 09:18:14 INFO - x-amz-version-id: UeU.ZG.xeUq2GF6T3NIKSPABz_l2mJ.i 09:18:14 INFO - Expected file size: 21991971 09:18:14 INFO - Obtained file size: 21991971 09:18:18 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:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:19 INFO - Http code: 200 09:18:19 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 09:18:19 INFO - x-amz-cf-id: O9bnO3HAJWWWhJFi1_FL6xQblvBlvqkdsKRWg5iu-EXodLw1iRSkPg== 09:18:19 INFO - x-amz-version-id: UeU.ZG.xeUq2GF6T3NIKSPABz_l2mJ.i 09:18:19 INFO - Expected file size: 21991971 09:18:19 INFO - Obtained file size: 21991971 09:18:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:18:23 INFO - Fetch https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:18:24 INFO - Http code: 200 09:18:24 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:18:24 INFO - x-amz-cf-id: 3jAdJTT9WHq7e3UqQcvmXxnyODyAtRVT6_JXb1PsGd9vVQ0TDFzaMw== 09:18:24 INFO - x-amz-version-id: WrMbWTRCRznsKSt1BoGh28HnrPVG897C 09:18:24 INFO - Expected file size: 14408522 09:18:24 INFO - Obtained file size: 14408522 09:18:24 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:18:24 INFO - trying https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:24 INFO - Downloading https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/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:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/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:18:27 INFO - Downloaded 59679585 bytes. 09:18:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:27 INFO - mkdir: /builds/slave/test/properties 09:18:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:27 INFO - Contents: 09:18:27 INFO - build_url:https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:27 INFO - Running post-action listener: _resource_record_post_action 09:18:27 INFO - Running post-action listener: set_extra_try_arguments 09:18:27 INFO - [mozharness: 2016-10-03 16:18:27.668254Z] Finished download-and-extract step (success) 09:18:27 INFO - [mozharness: 2016-10-03 16:18:27.668481Z] Running populate-webroot step. 09:18:27 INFO - Running pre-action listener: _resource_record_pre_action 09:18:27 INFO - Running main action method: populate_webroot 09:18:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:27 INFO - '--tppagecycles', 09:18:27 INFO - '7'], 09:18:27 INFO - 'tests': ['tsvgm']}}, 09:18:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['damp', 'tps']}, 09:18:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'tests': ['damp', 'tps']}, 09:18:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['dromaeo_dom']}, 09:18:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['basic_compositor_video']}, 09:18:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['a11yr', 09:18:27 INFO - 'ts_paint', 09:18:27 INFO - 'tpaint', 09:18:27 INFO - 'sessionrestore', 09:18:27 INFO - 'sessionrestore_no_auto_restore', 09:18:27 INFO - 'tabpaint']}, 09:18:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:27 INFO - 'ts_paint', 09:18:27 INFO - 'tpaint', 09:18:27 INFO - 'sessionrestore', 09:18:27 INFO - 'sessionrestore_no_auto_restore', 09:18:27 INFO - 'tabpaint']}, 09:18:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:27 INFO - 'ts_paint', 09:18:27 INFO - 'tpaint', 09:18:27 INFO - 'sessionrestore', 09:18:27 INFO - 'sessionrestore_no_auto_restore', 09:18:27 INFO - 'tabpaint']}, 09:18:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:27 INFO - 'ts_paint', 09:18:27 INFO - 'tpaint', 09:18:27 INFO - 'sessionrestore', 09:18:27 INFO - 'sessionrestore_no_auto_restore', 09:18:27 INFO - 'tabpaint']}, 09:18:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['a11yr', 09:18:27 INFO - 'ts_paint', 09:18:27 INFO - 'tpaint', 09:18:27 INFO - 'sessionrestore', 09:18:27 INFO - 'sessionrestore_no_auto_restore', 09:18:27 INFO - 'tabpaint']}, 09:18:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['a11yr', 09:18:27 INFO - 'ts_paint', 09:18:27 INFO - 'tpaint', 09:18:27 INFO - 'sessionrestore', 09:18:27 INFO - 'sessionrestore_no_auto_restore', 09:18:27 INFO - 'tabpaint']}, 09:18:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['tsvgx', 09:18:27 INFO - 'tsvgr_opacity', 09:18:27 INFO - 'tart', 09:18:27 INFO - 'tscrollx', 09:18:27 INFO - 'cart']}, 09:18:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:27 INFO - 'tsvgr_opacity', 09:18:27 INFO - 'tart', 09:18:27 INFO - 'tscrollx', 09:18:27 INFO - 'cart']}, 09:18:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'talos_options': ['--disable-e10s'], 09:18:27 INFO - 'tests': ['tp5o']}, 09:18:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'tests': ['tp5o']}, 09:18:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'talos_options': ['--disable-e10s', 09:18:27 INFO - '--xperf_path', 09:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:27 INFO - 'tests': ['tp5n']}, 09:18:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:27 INFO - 'talos_options': ['--xperf_path', 09:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:27 INFO - 'tests': ['tp5n']}}, 09:18:27 INFO - 'talos.zip': {'path': '', 09:18:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:27 INFO - Running post-action listener: _resource_record_post_action 09:18:27 INFO - [mozharness: 2016-10-03 16:18:27.685724Z] Finished populate-webroot step (success) 09:18:27 INFO - [mozharness: 2016-10-03 16:18:27.685813Z] Running create-virtualenv step. 09:18:27 INFO - Running pre-action listener: _resource_record_pre_action 09:18:27 INFO - Running main action method: create_virtualenv 09:18:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:27 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:18:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:27 INFO - Using real prefix '/usr' 09:18:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:30 INFO - Installing pip.................done. 09:18:30 INFO - Return code: 0 09:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:18:30 INFO - Reading from file tmpfile_stdout 09:18:30 INFO - Output received: 09:18:30 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:18:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:30 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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:30 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:18:30 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:18:30 INFO - Using env: {'DISPLAY': ':0', 09:18:30 INFO - 'HOME': '/home/cltbld', 09:18:30 INFO - 'LANG': 'en_US.UTF-8', 09:18:30 INFO - 'LANGUAGE': 'en_US:en', 09:18:30 INFO - 'LOGNAME': 'cltbld', 09:18:30 INFO - 'MAIL': '/var/mail/cltbld', 09:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:30 INFO - 'MOZ_NO_REMOTE': '1', 09:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:30 INFO - 'NO_EM_RESTART': '1', 09:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:30 INFO - 'PWD': '/builds/slave/test', 09:18:30 INFO - 'SHELL': '/bin/bash', 09:18:30 INFO - 'SHLVL': '1', 09:18:30 INFO - 'TERM': 'linux', 09:18:30 INFO - 'TMOUT': '86400', 09:18:30 INFO - 'USER': 'cltbld', 09:18:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:30 INFO - '_': '/tools/buildbot/bin/python'} 09:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:30 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:18:30 INFO - Cleaning up... 09:18:30 INFO - Return code: 0 09:18:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:30 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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:30 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:18:30 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:18:30 INFO - Using env: {'DISPLAY': ':0', 09:18:30 INFO - 'HOME': '/home/cltbld', 09:18:30 INFO - 'LANG': 'en_US.UTF-8', 09:18:30 INFO - 'LANGUAGE': 'en_US:en', 09:18:30 INFO - 'LOGNAME': 'cltbld', 09:18:30 INFO - 'MAIL': '/var/mail/cltbld', 09:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:30 INFO - 'MOZ_NO_REMOTE': '1', 09:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:30 INFO - 'NO_EM_RESTART': '1', 09:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:30 INFO - 'PWD': '/builds/slave/test', 09:18:30 INFO - 'SHELL': '/bin/bash', 09:18:30 INFO - 'SHLVL': '1', 09:18:30 INFO - 'TERM': 'linux', 09:18:30 INFO - 'TMOUT': '86400', 09:18:30 INFO - 'USER': 'cltbld', 09:18:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:30 INFO - '_': '/tools/buildbot/bin/python'} 09:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:30 INFO - Downloading/unpacking psutil>=3.1.1 09:18:30 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:18:30 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:18:30 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:18:30 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:18:30 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:18:30 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:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:32 INFO - Installing collected packages: psutil 09:18:32 INFO - Running setup.py install for psutil 09:18:33 INFO - building 'psutil._psutil_linux' extension 09:18:33 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:18:33 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:18:33 INFO - building 'psutil._psutil_posix' extension 09:18:33 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:18:33 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:18:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:33 INFO - Successfully installed psutil 09:18:33 INFO - Cleaning up... 09:18:33 INFO - Return code: 0 09:18:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:18:33 INFO - Using env: {'DISPLAY': ':0', 09:18:33 INFO - 'HOME': '/home/cltbld', 09:18:33 INFO - 'LANG': 'en_US.UTF-8', 09:18:33 INFO - 'LANGUAGE': 'en_US:en', 09:18:33 INFO - 'LOGNAME': 'cltbld', 09:18:33 INFO - 'MAIL': '/var/mail/cltbld', 09:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:33 INFO - 'MOZ_NO_REMOTE': '1', 09:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:33 INFO - 'NO_EM_RESTART': '1', 09:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:33 INFO - 'PWD': '/builds/slave/test', 09:18:33 INFO - 'SHELL': '/bin/bash', 09:18:33 INFO - 'SHLVL': '1', 09:18:33 INFO - 'TERM': 'linux', 09:18:33 INFO - 'TMOUT': '86400', 09:18:33 INFO - 'USER': 'cltbld', 09:18:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:33 INFO - '_': '/tools/buildbot/bin/python'} 09:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18: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:18: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:18: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:18: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:18: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:18: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:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:35 INFO - Installing collected packages: mozsystemmonitor 09:18:35 INFO - Running setup.py install for mozsystemmonitor 09:18:35 INFO - Successfully installed mozsystemmonitor 09:18:35 INFO - Cleaning up... 09:18:35 INFO - Return code: 0 09:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:18:35 INFO - Using env: {'DISPLAY': ':0', 09:18:35 INFO - 'HOME': '/home/cltbld', 09:18:35 INFO - 'LANG': 'en_US.UTF-8', 09:18:35 INFO - 'LANGUAGE': 'en_US:en', 09:18:35 INFO - 'LOGNAME': 'cltbld', 09:18:35 INFO - 'MAIL': '/var/mail/cltbld', 09:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:35 INFO - 'MOZ_NO_REMOTE': '1', 09:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:35 INFO - 'NO_EM_RESTART': '1', 09:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:35 INFO - 'PWD': '/builds/slave/test', 09:18:35 INFO - 'SHELL': '/bin/bash', 09:18:35 INFO - 'SHLVL': '1', 09:18:35 INFO - 'TERM': 'linux', 09:18:35 INFO - 'TMOUT': '86400', 09:18:35 INFO - 'USER': 'cltbld', 09:18:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:35 INFO - '_': '/tools/buildbot/bin/python'} 09:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 09:18: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:18: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:18: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:18: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:18: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:18: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:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:37 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:18:37 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:18:37 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:18:37 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:18:37 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:18:37 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:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:38 INFO - warning: no files found matching '*.txt' 09:18:38 INFO - no previously-included directories found matching 'build' 09:18:38 INFO - no previously-included directories found matching 'dist' 09:18:38 INFO - no previously-included directories found matching '.git*' 09:18:38 INFO - Installing collected packages: jsonschema, functools32 09:18:38 INFO - Running setup.py install for functools32 09:18:38 INFO - warning: no files found matching '*.txt' 09:18:38 INFO - no previously-included directories found matching 'build' 09:18:38 INFO - no previously-included directories found matching 'dist' 09:18:38 INFO - no previously-included directories found matching '.git*' 09:18:38 INFO - Successfully installed jsonschema functools32 09:18:38 INFO - Cleaning up... 09:18:38 INFO - Return code: 0 09:18:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:38 INFO - Using env: {'DISPLAY': ':0', 09:18:38 INFO - 'HOME': '/home/cltbld', 09:18:38 INFO - 'LANG': 'en_US.UTF-8', 09:18:38 INFO - 'LANGUAGE': 'en_US:en', 09:18:38 INFO - 'LOGNAME': 'cltbld', 09:18:38 INFO - 'MAIL': '/var/mail/cltbld', 09:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:38 INFO - 'MOZ_NO_REMOTE': '1', 09:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:38 INFO - 'NO_EM_RESTART': '1', 09:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:38 INFO - 'PWD': '/builds/slave/test', 09:18:38 INFO - 'SHELL': '/bin/bash', 09:18:38 INFO - 'SHLVL': '1', 09:18:38 INFO - 'TERM': 'linux', 09:18:38 INFO - 'TMOUT': '86400', 09:18:38 INFO - 'USER': 'cltbld', 09:18:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:38 INFO - '_': '/tools/buildbot/bin/python'} 09:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:38 INFO - Cleaning up... 09:18:38 INFO - Return code: 0 09:18:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:18:38 INFO - Using env: {'DISPLAY': ':0', 09:18:38 INFO - 'HOME': '/home/cltbld', 09:18:38 INFO - 'LANG': 'en_US.UTF-8', 09:18:38 INFO - 'LANGUAGE': 'en_US:en', 09:18:38 INFO - 'LOGNAME': 'cltbld', 09:18:38 INFO - 'MAIL': '/var/mail/cltbld', 09:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:38 INFO - 'MOZ_NO_REMOTE': '1', 09:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:38 INFO - 'NO_EM_RESTART': '1', 09:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:38 INFO - 'PWD': '/builds/slave/test', 09:18:38 INFO - 'SHELL': '/bin/bash', 09:18:38 INFO - 'SHLVL': '1', 09:18:38 INFO - 'TERM': 'linux', 09:18:38 INFO - 'TMOUT': '86400', 09:18:38 INFO - 'USER': 'cltbld', 09:18:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:38 INFO - '_': '/tools/buildbot/bin/python'} 09:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:41 INFO - Downloading docopt-0.6.1.tar.gz 09:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:41 INFO - Running setup.py install for blobuploader 09:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:41 INFO - Running setup.py install for requests 09:18:41 INFO - Running setup.py install for docopt 09:18:42 INFO - Successfully installed blobuploader requests docopt 09:18:42 INFO - Cleaning up... 09:18:42 INFO - Return code: 0 09:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:42 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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:42 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:18:42 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:18:42 INFO - Using env: {'DISPLAY': ':0', 09:18:42 INFO - 'HOME': '/home/cltbld', 09:18:42 INFO - 'LANG': 'en_US.UTF-8', 09:18:42 INFO - 'LANGUAGE': 'en_US:en', 09:18:42 INFO - 'LOGNAME': 'cltbld', 09:18:42 INFO - 'MAIL': '/var/mail/cltbld', 09:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:42 INFO - 'MOZ_NO_REMOTE': '1', 09:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:42 INFO - 'NO_EM_RESTART': '1', 09:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:42 INFO - 'PWD': '/builds/slave/test', 09:18:42 INFO - 'SHELL': '/bin/bash', 09:18:42 INFO - 'SHLVL': '1', 09:18:42 INFO - 'TERM': 'linux', 09:18:42 INFO - 'TMOUT': '86400', 09:18:42 INFO - 'USER': 'cltbld', 09:18:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:42 INFO - '_': '/tools/buildbot/bin/python'} 09:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:42 INFO - Running setup.py (path:/tmp/pip-57oqYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:42 INFO - Running setup.py (path:/tmp/pip-Ntc9Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:42 INFO - Running setup.py (path:/tmp/pip-QQmbq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:42 INFO - Running setup.py (path:/tmp/pip-Y_6RcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:42 INFO - Running setup.py (path:/tmp/pip-FRWTO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:42 INFO - Running setup.py (path:/tmp/pip-_vGoCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:42 INFO - Running setup.py (path:/tmp/pip-r5BN_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:42 INFO - Running setup.py (path:/tmp/pip-LD8UWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:42 INFO - Running setup.py (path:/tmp/pip-pSLa30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:42 INFO - Running setup.py (path:/tmp/pip-ya1JZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:43 INFO - Running setup.py (path:/tmp/pip-xY3qmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:43 INFO - Running setup.py (path:/tmp/pip-nINILn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:43 INFO - Running setup.py (path:/tmp/pip-cLmV6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:43 INFO - Running setup.py (path:/tmp/pip-Ktg4C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:43 INFO - Running setup.py (path:/tmp/pip-esHWlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:43 INFO - Running setup.py (path:/tmp/pip-C2cPRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:43 INFO - Running setup.py (path:/tmp/pip-gTQ8Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:43 INFO - Running setup.py install for manifestparser 09:18:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for mozcrash 09:18:43 INFO - Running setup.py install for mozdebug 09:18:43 INFO - Running setup.py install for mozdevice 09:18:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for mozfile 09:18:44 INFO - Running setup.py install for mozhttpd 09:18:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozinfo 09:18:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozInstall 09:18:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozleak 09:18:44 INFO - Running setup.py install for mozlog 09:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for moznetwork 09:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozprocess 09:18:44 INFO - Running setup.py install for mozprofile 09:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozrunner 09:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:45 INFO - Running setup.py install for mozscreenshot 09:18:45 INFO - Running setup.py install for moztest 09:18:45 INFO - Running setup.py install for mozversion 09:18:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:45 INFO - Cleaning up... 09:18:45 INFO - Return code: 0 09:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18: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:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:45 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:18:45 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:18:45 INFO - Using env: {'DISPLAY': ':0', 09:18:45 INFO - 'HOME': '/home/cltbld', 09:18:45 INFO - 'LANG': 'en_US.UTF-8', 09:18:45 INFO - 'LANGUAGE': 'en_US:en', 09:18:45 INFO - 'LOGNAME': 'cltbld', 09:18:45 INFO - 'MAIL': '/var/mail/cltbld', 09:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:45 INFO - 'MOZ_NO_REMOTE': '1', 09:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:45 INFO - 'NO_EM_RESTART': '1', 09:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:45 INFO - 'PWD': '/builds/slave/test', 09:18:45 INFO - 'SHELL': '/bin/bash', 09:18:45 INFO - 'SHLVL': '1', 09:18:45 INFO - 'TERM': 'linux', 09:18:45 INFO - 'TMOUT': '86400', 09:18:45 INFO - 'USER': 'cltbld', 09:18:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:45 INFO - '_': '/tools/buildbot/bin/python'} 09:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:45 INFO - Running setup.py (path:/tmp/pip-rr_WZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:45 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:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:45 INFO - Running setup.py (path:/tmp/pip-KqJ0fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:45 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:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:45 INFO - Running setup.py (path:/tmp/pip-Y2oUIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:45 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:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:45 INFO - Running setup.py (path:/tmp/pip-Z8kh7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:45 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:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:45 INFO - Running setup.py (path:/tmp/pip-nUgyrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:45 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:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:45 INFO - Running setup.py (path:/tmp/pip-ltrdX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:45 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:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:45 INFO - Running setup.py (path:/tmp/pip-OidEaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:46 INFO - Running setup.py (path:/tmp/pip-RWDVS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:46 INFO - Running setup.py (path:/tmp/pip-f7K2RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:46 INFO - Running setup.py (path:/tmp/pip-cXtFX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:46 INFO - Running setup.py (path:/tmp/pip-6Xtl5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:46 INFO - Running setup.py (path:/tmp/pip-o2zKOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:46 INFO - Running setup.py (path:/tmp/pip-Q9ryKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:46 INFO - Running setup.py (path:/tmp/pip-r4O429-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:46 INFO - Running setup.py (path:/tmp/pip-T7LP7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:46 INFO - Running setup.py (path:/tmp/pip-PLoGCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:46 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:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:46 INFO - Running setup.py (path:/tmp/pip-8B0gmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:46 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:18:48 INFO - Downloading blessings-1.6.tar.gz 09:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:48 INFO - Installing collected packages: blessings 09:18:48 INFO - Running setup.py install for blessings 09:18:48 INFO - Successfully installed blessings 09:18:48 INFO - Cleaning up... 09:18:48 INFO - Return code: 0 09:18:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:49 INFO - Reading from file tmpfile_stdout 09:18:49 INFO - Current package versions: 09:18:49 INFO - argparse == 1.2.1 09:18:49 INFO - blessings == 1.6 09:18:49 INFO - blobuploader == 1.2.4 09:18:49 INFO - docopt == 0.6.1 09:18:49 INFO - functools32 == 3.2.3-2 09:18:49 INFO - jsonschema == 2.5.1 09:18:49 INFO - manifestparser == 1.1 09:18:49 INFO - mozInstall == 1.12 09:18:49 INFO - mozcrash == 0.17 09:18:49 INFO - mozdebug == 0.1 09:18:49 INFO - mozdevice == 0.48 09:18:49 INFO - mozfile == 1.2 09:18:49 INFO - mozhttpd == 0.7 09:18:49 INFO - mozinfo == 0.9 09:18:49 INFO - mozleak == 0.1 09:18:49 INFO - mozlog == 3.4 09:18:49 INFO - moznetwork == 0.27 09:18:49 INFO - mozprocess == 0.23 09:18:49 INFO - mozprofile == 0.28 09:18:49 INFO - mozrunner == 6.12 09:18:49 INFO - mozscreenshot == 0.1 09:18:49 INFO - mozsystemmonitor == 0.3 09:18:49 INFO - moztest == 0.7 09:18:49 INFO - mozversion == 1.4 09:18:49 INFO - psutil == 3.1.1 09:18:49 INFO - requests == 1.2.3 09:18:49 INFO - wsgiref == 0.1.2 09:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:49 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:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:49 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:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:49 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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:49 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:18:49 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:18:49 INFO - Using env: {'DISPLAY': ':0', 09:18:49 INFO - 'HOME': '/home/cltbld', 09:18:49 INFO - 'LANG': 'en_US.UTF-8', 09:18:49 INFO - 'LANGUAGE': 'en_US:en', 09:18:49 INFO - 'LOGNAME': 'cltbld', 09:18:49 INFO - 'MAIL': '/var/mail/cltbld', 09:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:49 INFO - 'MOZ_NO_REMOTE': '1', 09:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:49 INFO - 'NO_EM_RESTART': '1', 09:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:49 INFO - 'PWD': '/builds/slave/test', 09:18:49 INFO - 'SHELL': '/bin/bash', 09:18:49 INFO - 'SHLVL': '1', 09:18:49 INFO - 'TERM': 'linux', 09:18:49 INFO - 'TMOUT': '86400', 09:18:49 INFO - 'USER': 'cltbld', 09:18:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:49 INFO - '_': '/tools/buildbot/bin/python'} 09:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 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:18:49 INFO - Cleaning up... 09:18:49 INFO - Return code: 0 09:18:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:49 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:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:49 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:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:49 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 0x7f20d5ea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, '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': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', '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:18:49 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:18:49 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:18:49 INFO - Using env: {'DISPLAY': ':0', 09:18:49 INFO - 'HOME': '/home/cltbld', 09:18:49 INFO - 'LANG': 'en_US.UTF-8', 09:18:49 INFO - 'LANGUAGE': 'en_US:en', 09:18:49 INFO - 'LOGNAME': 'cltbld', 09:18:49 INFO - 'MAIL': '/var/mail/cltbld', 09:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:49 INFO - 'MOZ_NO_REMOTE': '1', 09:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:49 INFO - 'NO_EM_RESTART': '1', 09:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:49 INFO - 'PWD': '/builds/slave/test', 09:18:49 INFO - 'SHELL': '/bin/bash', 09:18:49 INFO - 'SHLVL': '1', 09:18:49 INFO - 'TERM': 'linux', 09:18:49 INFO - 'TMOUT': '86400', 09:18:49 INFO - 'USER': 'cltbld', 09:18:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:49 INFO - '_': '/tools/buildbot/bin/python'} 09:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:49 INFO - Cleaning up... 09:18:49 INFO - Return code: 0 09:18:49 INFO - Running post-action listener: _resource_record_post_action 09:18:49 INFO - Running post-action listener: _start_resource_monitoring 09:18:49 INFO - Starting resource monitoring. 09:18:49 INFO - [mozharness: 2016-10-03 16:18:49.664516Z] Finished create-virtualenv step (success) 09:18:49 INFO - [mozharness: 2016-10-03 16:18:49.665028Z] Running install step. 09:18:49 INFO - Running pre-action listener: _resource_record_pre_action 09:18:49 INFO - Running main action method: install 09:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:49 INFO - Reading from file tmpfile_stdout 09:18:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:49 INFO - Reading from file tmpfile_stdout 09:18:49 INFO - Output received: 09:18:49 INFO - Usage: mozinstall [options] installer 09:18:49 INFO - Options: 09:18:49 INFO - -h, --help show this help message and exit 09:18:49 INFO - -d DEST, --destination=DEST 09:18:49 INFO - Directory to install application into. [default: 09:18:49 INFO - "/builds/slave/test"] 09:18:49 INFO - --app=APP Application being installed. [default: firefox] 09:18:49 INFO - mkdir: /builds/slave/test/build/application 09:18:49 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:18:49 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:19:07 INFO - Reading from file tmpfile_stdout 09:19:07 INFO - Output received: 09:19:07 INFO - /builds/slave/test/build/application/firefox/firefox 09:19:07 INFO - Running post-action listener: _resource_record_post_action 09:19:07 INFO - [mozharness: 2016-10-03 16:19:07.637390Z] Finished install step (success) 09:19:07 INFO - [mozharness: 2016-10-03 16:19:07.637635Z] Running run-tests step. 09:19:07 INFO - Running pre-action listener: _resource_record_pre_action 09:19:07 INFO - Running main action method: run_tests 09:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:07 INFO - Python 2.7.3 09:19:07 INFO - Return code: 0 09:19:07 INFO - grabbing minidump binary from tooltool 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 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 0xedd790>, '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 0xede690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:07 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:19:07 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:19:07 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:19:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:07 INFO - Return code: 0 09:19:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:19:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:19:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:19:07 INFO - Using env: {'DISPLAY': ':0', 09:19:07 INFO - 'HOME': '/home/cltbld', 09:19:07 INFO - 'LANG': 'en_US.UTF-8', 09:19:07 INFO - 'LANGUAGE': 'en_US:en', 09:19:07 INFO - 'LOGNAME': 'cltbld', 09:19:07 INFO - 'MAIL': '/var/mail/cltbld', 09:19:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:07 INFO - 'MOZ_NO_REMOTE': '1', 09:19:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:07 INFO - 'NO_EM_RESTART': '1', 09:19:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:07 INFO - 'PWD': '/builds/slave/test', 09:19:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:07 INFO - 'SHELL': '/bin/bash', 09:19:07 INFO - 'SHLVL': '1', 09:19:07 INFO - 'TERM': 'linux', 09:19:07 INFO - 'TMOUT': '86400', 09:19:07 INFO - 'USER': 'cltbld', 09:19:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445', 09:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:07 INFO - '_': '/tools/buildbot/bin/python'} 09:19:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:19:07 INFO - mozversion application_buildid: 20161003063000 09:19:07 INFO - mozversion application_changeset: 73e1dac8253d1c57cef65bd88f923738b7b84de0 09:19:07 INFO - mozversion application_display_name: Nightly 09:19:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:07 INFO - mozversion application_name: Firefox 09:19:07 INFO - mozversion application_remotingname: firefox 09:19:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:19:07 INFO - mozversion application_vendor: Mozilla 09:19:07 INFO - mozversion application_version: 52.0a1 09:19:07 INFO - mozversion platform_buildid: 20161003063000 09:19:07 INFO - mozversion platform_changeset: 73e1dac8253d1c57cef65bd88f923738b7b84de0 09:19:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:19:07 INFO - mozversion platform_version: 52.0a1 09:19:07 INFO - using testdate: 1475511547 09:19:07 INFO - actual date: 1475511547 09:19:07 INFO - starting webserver on 'localhost:56843' 09:19:07 INFO - SUITE-START | Running 2 tests 09:19:07 INFO - TEST-START | dromaeo_css 09:19:07 INFO - operating with platform_type : linux_ 09:19:07 INFO - Initialising browser for dromaeo_css test... 09:19:07 INFO - TEST-INFO | started process 28891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO76pLe/profile http://localhost:56843/getInfo.html) 09:19:12 INFO - PROCESS | 28891 | __metrics Screen width/height:1600/1200 09:19:12 INFO - PROCESS | 28891 | colorDepth:24 09:19:12 INFO - PROCESS | 28891 | Browser inner width/height: 1024/697 09:19:12 INFO - PROCESS | 28891 | __metrics 09:19:13 ERROR - PROCESS | 28891 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 09:19:14 INFO - TEST-INFO | 28891: exit 0 09:19:14 INFO - Browser initialized. 09:19:14 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:14 INFO - TEST-INFO | started process 29013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO76pLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:26 INFO - PROCESS | 29013 | RSS: Main: 185159680 09:19:26 INFO - PROCESS | 29013 | 09:20:15 INFO - PROCESS | 29013 | 1475511615913 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:22:26 INFO - PROCESS | 29013 | Cycle 1(1): loaded http://localhost:56843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56843/tests/dromaeo/cssquery-ext.html) 09:22:27 INFO - PROCESS | 29013 | RSS: Main: 202190848 09:22:27 INFO - PROCESS | 29013 | 09:25:29 INFO - PROCESS | 29013 | Cycle 1(1): loaded http://localhost:56843/tests/dromaeo/cssquery-ext.html (next: http://localhost:56843/tests/dromaeo/cssquery-jquery.html) 09:25:30 INFO - PROCESS | 29013 | RSS: Main: 197713920 09:25:30 INFO - PROCESS | 29013 | 09:28:32 INFO - PROCESS | 29013 | Cycle 1(1): loaded http://localhost:56843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56843/tests/dromaeo/cssquery-mootools.html) 09:28:32 INFO - PROCESS | 29013 | RSS: Main: 199045120 09:28:32 INFO - PROCESS | 29013 | 09:31:34 INFO - PROCESS | 29013 | Cycle 1(1): loaded http://localhost:56843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56843/tests/dromaeo/cssquery-prototype.html) 09:31:35 INFO - PROCESS | 29013 | RSS: Main: 195964928 09:31:35 INFO - PROCESS | 29013 | 09:34:38 INFO - PROCESS | 29013 | Cycle 1(1): loaded http://localhost:56843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56843/tests/dromaeo/cssquery-yui.html) 09:34:38 INFO - PROCESS | 29013 | RSS: Main: 199507968 09:34:38 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | Cycle 1(1): loaded http://localhost:56843/tests/dromaeo/cssquery-yui.html (next: http://localhost:56843/tests/dromaeo/cssquery-dojo.html) 09:37:41 INFO - PROCESS | 29013 | RSS: Main: 199831552 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | __start_tp_report 09:37:41 INFO - PROCESS | 29013 | _x_x_mozilla_page_load 09:37:41 INFO - PROCESS | 29013 | _x_x_mozilla_page_load_details 09:37:41 INFO - PROCESS | 29013 | |i|pagename|runs| 09:37:41 INFO - PROCESS | 29013 | |0;dojo.html;3002.2794529312964;3003.8347890865994;3019.471592471318;3039.255382431304;3047.6952304769525;5115.155999260118;5279.868003299919;5339.252504649347;5362;5402.540784033357;5225.085610018241;5299.099153143965;5358.035553600351;5408.891822163564;5492.862678433041;4777.665563410563;4869.51304869512;4900.215965445529;4929.975350123244;4956.430010548779;4939.678920870132;4955.058538877602;4959.975200123994;4984.700917944917;4990.151674215392;4730.550597693214;4767.165745994472;4769.570738633505;4981.601471882241;5056;4826.710397376133;4857.635677324215;4895.192293271606;4909.533594308535;4921.975390123062;4784.067106914154;4811.374521312242;4826.276058591239;4856.223004319292;4896.657233993622;5128.333316668809;5266.210068489757;5300.814471493518;5317.441668624778;5366.570674346043;5508.889822203533;5630.408807075239;5699.971500142473;5702.344230413472;5780.959427303083;5705.515031222351;5706;5717.228174196472;5719.6854173020465;5776.768929242825;5365.54392876602;5372.7313634318125;5383.380911195184;5385.865353366197;5424.186372044225;5662.320521537442;5735.139729040678;5783.103618939072;5815.476607105296;5837.88324233513;5562.110062389998;5632.943670563324;5636.746346414421;5645.5483561314995;5691.943080569225;5579.2746942897165;5602.691851948182;5638.548916086703;5693.743781529758;5702.800401985911;5644.645285131539;5661.603687741901;5672.035753921843;5709.34342550612;5762.423757624204;5687.800926967537;5724.16999535065;5724.3130824300515;5735.2257445245195;5744.4829965303325;4321.395004699345;4442.111577684476;4496.348029535699;4497;4499.932501012488;3862.4013277941963;3907.199024200032;3920.6863450923856;3965.7025723070883;3999.340108882002;5346.8395948121615;5460.153676180119;5465.72671366438;5471.179323101487;5471.917921231185;5657.8019769307875;5713.457221563945;5730.770769169187;5739.770409183586;5785.566082543826;5351;5384.0847056000575;5442.183672449164;5470.835874923759;5488.396276409591;5006.3992320921;5007.324011258506;5007.799688012512;5013.273075404046;5050.217216331474;5975.19334889793;5980.461758441761;6000.669963152069;6004.729787159501;6016.308124565643;5664.5751568631695;5720.456556627114;5754.309482862083;5773.913391299218;5800.535957123504;5989.131575921379;5997.610155339889;6009.188759517584;6061.575689701678;6070.180525628984;5609.382967873612;5669.518090962314;5670.971645141748;5694.629849059798;5705.343885453226;5660.122680984454;5669.6314739541795;5774.162746401832;5799;5804.042333015005;5627.155926610877;5700.914486282626;5706.172604972338;5760.366359700513;5760.481556659921;5648.265725455664;5669.092945128759;5670.546356291569;5697.088465845445;5698.20225168485;5345.1982202669915;5347.732613369239;5503.917441238465;5537.529310008695;5621.184928185308;5711;5721.856953576027;5737.569682273763;5773.595848290747;5778.364379918122;5541.445855414427;5577.693226872399;5596.440355964371;5604.467575580314;5606.439356064361 09:37:41 INFO - PROCESS | 29013 | |1;ext.html;566.7761234312446;578.8581797459623;580.9448102430267;586.1120402590077;592.534860134794;41946.790266048665;43687.78156109219;43791.34312985308;47344;47399;43367.566324336745;43848.3422748659;43878.34182487257;43878.34182487265;43973.56026439735;8960.372773905829;9109.590068446936;9115.903342231291;9124.498152601604;9127.178553930145;8920.821583568324;9006.099390061006;9037.457752534836;9039.728808135766;9047.095290470967;9061.682841100563;9104.817903641957;9106.726798196065;9112;9112.908870911306;8955.149260820277;8990.145936136056;8997.865032024525;9057.728268152;9060.093990600953;8906.198442140174;8921.330900182447;8992.23565996891;8996.235319997808;9031.593578288926;40309.39535906934;40480;40839.7958010211;40923;40988;3101.1936896407096;3216.549683044376;3284.753643476725;3288.983555082233;3297.1262615406936;30901.69098309033;31113.37773244545;31188.220294492592;32296;33214.66785332164;4051.574584668597;4097.8565750198895;4153.522344930341;4161.375793630949;4164.68764842638;303529;304345;305502;306204;306852.9999999978;55146.72426637921;55448.6137846557;55465.44534554603;55498.72250638802;55546;59523.70238148781;59641;59739.402605974254;59915;60006.399936000955;14719.484818031318;14724.33740481681;14734.042287251294;14835.925820370829;14855;11301.378424186585;11302.37836918961;11320.433978301053;11331.150163737753;11332.6033588824;15823.920880395524;17303.82696173022;17344.653106938043;17417.65164696699;17600.735988960176;5705.172749951317;5824.679642619697;5924.6149000314845;5932.851678707981;5945.613535120204;943.4622265308845;943.6744323208482;1005.6580762540772;1016.3495362967707;1057.6456886942806;31523.527147092813;31595.21011974719;31737;31796;31845.36309273848;1067.8558394616782;1105.2705214558353;1107.3920916242294;1166.7783121206944;1245.620085873799;15177.24113794306;16910;17037.233324500427;17092.743608845878;17097.658046838995;463820;465876;466064;466746;469002;56435.153472697944;56543.71728141333;56670.43329566734;56800.71599642058;56946.43053569411;1315.7236980234068;1319.8680131986916;1345.7375811716818;1358.1647286918671;1360.3062438156612;29235.269118272212;30848;31044.689553105083;31788;32272.193195170308;48589.27116093332;50147.74926125492;53444.1983370242;53549;53717.73141134269;425760;427178;427566;428605;429351;27168.97373985819;28079.578806317513;28114.71885281121;28196.295092622848;28308;45764;46343.53656463392;46430.30354544617;47323.52676473191;47426.288605670255;38711;39421;39741;41053;41129.588704113776;39401;39740.6110205645;40258.19483610253;40625.59374406218;41193.38209926793;38688.41967370435;39460.2107957845;39499.80250098846;39864.2027159461;42153.36769948515;30443.2389190272;34491.13772155716;35927.03164158841;36122.63877361193;36692;27450.313742155806;27582.17253482399;27618;27668.86260814395;28046.62208054247 09:37:41 INFO - PROCESS | 29013 | |2;jquery.html;383.6834611445558;384.00925611921235;386.1639550373442;391.9000895496517;403.54802621064414;14347.28263586819;17685;17826.376076837296;19508.31720889769;19510.902445487787;17760.46718598441;18291.359802406918;18951.33670321539;18962;19002.524936876584;5241.8951620967655;5263.315768950031;5352.678839269637;5396.91904621431;5397.595180361489;5208.479152084799;5286.154215325549;5295.0733621616255;5300.204969254623;5319.627626066177;5255.84371438283;5265.736713164346;5728.42715728428;5794.884102317951;5797.71011449428;5782.45066718661;5821.068629019379;5821.767129314822;5833.241678581779;5843.444872737083;5177.119889618773;5479.123340265538;5501.862453438696;5512.118061110244;5585.1063829787445;13669.384877680528;13782.65543361414;13953.930230348884;13998.930005349908;14010.439582416793;2097.590969760897;2148.473623962124;2154.2998525479284;2182.519845633958;2185.344396681005;9879.506024698809;10206.132478739317;10422.270441069128;10481.633142839964;10507.211959103099;1865.897375644339;1982.70259461082;2030.1777779999125;2055.2601063617085;2058.8455865810124;78794;79369.60315198445;80088.59291256685;80506;81027;10928.180386471047;11110.222284440011;11124.388158651353;11195.776084478428;11437.256578322382;12504.937475312565;15868.285927133076;15870.2064896757;15883.52349429519;15916.363345466283;7434.591097489581;7515.586642734702;7716.074071111502;7764.572948487775;7773.183815699384;7227.566346019255;7232.421406287484;7275.272472752682;7490.550566966;7525.736599219001;3934.7639141651593;4014.437978682987;4087.2847251731423;4167.229062623424;4297.861066817296;1959.8040195980288;1980.4652743759104;1984.8511361647934;2002.6495363311362;2057.68105943579;870.3472395703222;952.0812416018437;955.9525704281406;966.2366730283138;1003.508280942333;18122.275108995756;19308.903455482632;19453.902730486257;19458.124384402738;19496.220151194077;960.279790157382;960.8943016268205;963.6579014449769;986.9950650246847;1003.693873368615;10267.35722284431;10831.133509319236;10976.670699879016;11015.614453494089;11080.722981925355;356293;448162;459596;460187.5924963031;460522;93418.53290733503;96521.03478965121;98503;98675.01324986658;101020.49489752504;960.1166926427703;1001.9849702254472;1041.9270651054353;1042.3433237060603;1047.4710271312786;17300.04849733277;17407.651846962737;18199.636007279514;18235.635287294444;18285.725714114564;37972.240555189295;41077.79461102795;41187.588124118374;41355.58644413517;43267.35098973581;50799.492005079475;56548.43451565432;58085;58285;59263.70368148132;10915.672529824118;11113.277636953571;12408.62774116778;12545;12569.183003104768;13532.188068715908;13947;13999.23004234736;14482.420703171754;14578.85421145775;11831.881681183422;12049.879501204876;12255;12377.814332785196;12421.130520863453;11848.822267666164;12096.141431196236;12145.271283723005;12189.451474683838;12400.31798251105;11948.581799636971;12298.75402491963;12322.137450378388;12359.134860560034;12484.56304029391;12527.686807829878;12630.747385052431;12817.871821281668;12994.545190918272;13075.869241307846;12007.579734709243;12130.575429859913;12298.20061695987;12539.310337931136;12724 09:37:41 INFO - PROCESS | 29013 | |3;mootools.html;1455.0905683947528;1484.0947022316386;1611.5165450364896;1678.91605419729;1731.8441340279373;8015.478993865395;8254.092049874509;8655.567221638916;9378.062193780619;9437.386569872953;8566.271866891306;8826.691065812698;8843.557822108902;9116.951550571686;9143.90856091439;2279.509905370345;2284.577353189661;2310.1452462588863;2316.652502124678;2321.3152120124605;2294.89672964717;2337.4506990857135;2337.497438050819;2342.2504798464497;2354.764523547649;2284.9657255141187;2331.6152834782242;2331.62693968965;2343.4024323797407;2354.281944007077;2265.2637892684943;2293.552757212344;2304.1129165271323;2311.9537609247805;2314.6412306092584;2273.658951157323;2273.6589511573397;2276.9886150569305;2279.566882292359;2283.7259528856475;9116;9130.81738365229;9199.310051746079;9206.49364284964;9234.492102934337;4961.7022978621035;5153.9742301288625;5156.92264616031;5159;5159.22611608258;3151.322465669892;3212.16483714236;3366.4445366514497;3370.3259348130473;3391.2708767614836;1086.3916206924148;1105.060698406356;1108;1124.5164579230927;1125.9211855170142;12794.616161515169;12902.935485322607;12954.222746635232;12972.740545189137;12974.156679815782;4436.157130145262;4509.255972764523;4628.907421851544;4709.811607535728;4717.457492388351;10704.678859634223;10720.731981700364;10723.571057157626;10738.892611073945;10758.56965721378;5208.947910520847;5223.973880130651;5228.869278268074;5248.580113590903;5259.579233661298;3988.900277493086;4137.875863724033;4614.630829533629;4719.032598317337;4846.539578740014;3883.922321553553;4028.5165780106577;4096.9795151024055;4106.835726570964;4110.486189226347;1290.4580076367947;1290.8773666501668;1297.9221246725226;1306.2684896458013;1337.3848029906158;907.3104440625173;924.3714274293545;938.6761567259284;941.3645789092335;948.4878165790396;5734.139879018181;5827.621204621686;5847.356790753014;5860.589758716849;5942.376050514634;468.77498800575916;473.16958737415615;475.99048019039424;479.2260499293616;480.5194805194805;3907.4138879167785;3973.443717879499;3985.70107241958;3994.360902255625;4052.756834589934;10940.398278094623;11483.13876459269;11507.942460287644;11587.942060289814;11599.826002609967;11460.426978651034;11537.942310288396;11555.306681599131;11577.363245021605;11593.536258549564;8175.754727358189;8333.250007499355;8440.282575980988;8452.154784521621;8493.150684931581;5736.4550367715;5749.482546570829;5751.884962300647;5798.507126894261;5948.5538584605465;10470.476476176009;10531.157507399543;10534.36793792375;10640.733981650212;10757.30077544957;10484.370937743759;10570.2072344576;10665.46672666348;10684.626038088629;10775.299605525615;7125.251848555827;7279.1628962667855;7634.8091297718;7912.881306780288;8028.197180282159;8482.61828217744;8901.421407608485;8925.509096999727;8925.553722313989;8926.06276340975;7732.961335193288;7853.803654908673;7860.292573668397;8089.797755056171;8230.506169629842;7668.846623067619;7826.373890088893;7884.448088633741;8025.438219324825;8048.678052877819;6753.054572359972;6909.205441374105;6994;7012.859742805013;7016.19313778922;4932.3341348918875;4939.802407903644;5027.497250274943;5096.413912400121;5197.584193264454;5042.798288068583;5118.74406279692;5118.986987826701;5280.788768449219;5353.2773075634295 09:37:41 INFO - PROCESS | 29013 | |4;prototype.html;323.54057238721015;332.63410248726404;334.6352475801376;339.9405104106781;341.34121146187863;5393.298871146751;5474.452554744524;5489.945100548994;5503.477169668875;5533.833984980447;5415.702136382497;5425.02349577076;5449.4005659377435;5451.972740136293;5460.672359658423;4009.6391324780766;4065.6544193743566;4123.36087906375;4192.832286708528;4194.475690538683;4190.580941905816;4197.643200327976;4230.302000169968;4231.42875711778;4243.702940794145;4192.874213773576;4219.430376899126;4229.133027729308;4233.259179643565;4233.280342341809;4082.387641853716;4206.390073439365;4207.347861081537;4217.662586993033;4224.345226489868;3710.257948410329;3713;3717;3725.453936616301;3735.869244576454;5254.8686282842855;5267.786650143409;5279.366476022902;5281.445448227919;5301.549368303698;4637.585536411393;4792.736399498026;4805.8558243252755;4822.807087716487;4850.442199147108;5613.803516876889;5620.662760234399;5652.378238393773;5673.404292549264;5687;4032.294348489003;4079.4084857695466;4097.713160078795;4105.835766569334;4114.403411505315;5567.969925563743;5814.5057670098095;5842.386549412293;5855.151003104526;5894;4093.5497095319492;4141.751494910315;4150.211459822624;4153.169366126726;4156.314208155621;4190.141021090669;4195.769232692171;4199.9370009449885;4201.327787553977;4208.410822484854;4563;4765.69023013503;4834.20235661119;4845.152098382769;4845.176320025604;5655.943440565542;5695.45893140151;5705.5435565154685;5724.513416359573;5730.19777231188;1486.8067151270266;1506.3823832228734;1508.3363320139104;1511.199064495819;1512.2665507228985;901.1664210605164;940.7789169545151;946.6213514594217;961.2502248246379;986.3933680786408;5406.432324605938;5437.864053398696;5452.672839629635;5512.310961129859;5522.30971128609;5781.248437703071;5789.623674461147;5802.448767367094;5809.186713860063;5817;5249.212618107238;5459.481349271813;5476.808311709071;5476.945230547643;5519.448055194529;3100.5194194899827;3122.297483066292;3132.624085109756;3143.512755522898;3144.748420126384;5782.161586569924;6063.181470501514;6094.725737341831;6095.146679464879;6120.418560236771;5908.675022873783;6004.279486461653;6040.338906800577;6044.848878778066;6051.818445446644;6075.908861367083;6128.40661428023;6131.221945635805;6133.570650054543;6165.784197552975;5656.575756818337;5873.588848780715;5910.96558102339;5926.555508336805;5948.2862056553495;5862.853428664147;5865;5871.6183448075735;5872.412758724094;5897.823065308047;5824.5340372770925;6074.056301983323;6127.295361033538;6145.293291271382;6163.753449861955;4150.501939767248;4157.147784704068;4175.70770046106;4183.247015537232;4197.769122698281;5934.584579079423;5941.2276404068925;5943.227380440515;5958.970205148947;5961.523078153824;5665.235193249024;5743.74153163117;5788.363280039276;5804.477597016289;5815.854603634943;5800.187973683604;5814.499765100878;5816.243888294494;5816.796412125555;5840.153177789111;5341;5747.4252574742195;5749.511291540266;5757.510611598061;5764.884702305846;5748.597598168255;5761.8559536011935;5762.913556296575;5780.710964451677;5811.767529298781;5649.915251271316;5669.234653321913;5709.857253568694;5716.657000579979;5720.885582288248 09:37:41 INFO - PROCESS | 29013 | |5;yui.html;694.8540806430649;701.4283359062367;767.0833354141799;782.2177822177822;800.9679612815489;15145.697086058271;15588.946873812805;15622.76565851513;15700.450484233053;15740.134292613902;15184.924075379635;15406.30671619777;15422.305996230169;15432.151231682254;15440.84559154408;645.935406459355;661.576590981772;749.0786332810646;762.8321769210764;777.1373775109623;788.1094363369384;789.4986683456018;791.7347688524351;793.0760663826635;793.9682412703485;828.3125006244802;833.8582440985047;834.2116699718769;836.7238811192323;839.4627438439404;832.7252006837729;833.1668331668332;837.426362941384;837.9539125348103;840.7141571865595;608.9786857460012;611.6513587255266;612.1277180018456;612.1429998002787;613.0773186354508;14546.709065818624;14606.123632581974;14634.780478292834;14641.414343426357;14671.70656586873;14301;14433.917456190828;14475.973932077814;14630.780538291934;14659.706805863929;11022.338659680365;11039.72400689981;11047.779044419147;11118.555257789678;11211.551537938472;4370.4318438603095;4382.167388196232;4467.24056910326;4656.41794775653;4670.649701272384;71481;72536;72777;72950.27049729488;74029;10433.32183408076;11265.54937802495;11523.884761152449;11650.941745291218;11709.151153504667;21404.678929816066;21648.24231151902;21649.45876353072;21703.45741356479;21757.564848702936;7789.610519474004;8069.31410830086;8139.593020349077;8146.837063258702;8173.18268173178;4533.705309154894;4576.771161441915;4592.357070010201;4593.173228818845;4619;3363.075154332529;3441.15691655546;3463.584369875631;3463.740219483549;3473.392156372625;596.573449983264;607.2985701514757;622.7789134857151;624;628.7233617208414;667.2226855713137;679.8232459560451;689.8861687821453;725.3471875312262;726.7383741852929;8461.205373363076;9167.816643667089;9341.813163736822;9344.672936447192;9528.857067143997;532.0290469892461;536.1341433584811;549.7090503899963;569.1889058092202;570.4523657289049;4272.401863739079;4280.5291417944;4336.2845130553105;4394.715152726067;4548.249538826057;122787;124931.37534312271;125215.3739231298;126485.36757316155;127311.36344318218;102521;105431;106494;110047;112884;72643.63678181576;93429.53285233666;98245.50877245568;101544;101559.49220253999;8334.291585215324;8384.622691978753;8504.659813607386;8555.31557475388;8747.212750852454;56114.43885561092;56230;56751.71624141853;57592.4240757587;58267;74747;81056.54642885782;81215;82522;84482;11323.490442929924;12889;12913.612591622266;13074.346282686018;13637.181769093886;14898.404063837324;14949.25253737287;15003.849961500246;15799.921000394925;15835;12061.879381206076;12397.876021239672;12596.370181490705;12771.233725976099;13589.048766586244;14246.643833904236;14304.427822887385;14399;14520.240846732777;14769.92615036918;11607.187496875475;12175.39123043862;12308.446119924445;12634.431450584929;12808.423620936894;10937.445574016925;10971.615993440191;11262.7747445049;11318.830217546909;11517.424128793695;10488.213383996079;10778.838317425088;10873.347599144077;10995.175361848052;11008.724781880197 09:37:41 INFO - PROCESS | 29013 | __end_tp_report 09:37:41 INFO - PROCESS | 29013 | __start_cc_report 09:37:41 INFO - PROCESS | 29013 | _x_x_mozilla_cycle_collect,309 09:37:41 INFO - PROCESS | 29013 | __end_cc_report 09:37:41 INFO - PROCESS | 29013 | __startTimestamp1475512661918__endTimestamp 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | ------- Summary: start ------- 09:37:41 INFO - PROCESS | 29013 | Number of tests: 6 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | [#0] dojo.html Cycles:165 Average:5332.66 Median:5577.69 stddev:611.81 (11.0%) stddev-sans-first:585.74 09:37:41 INFO - PROCESS | 29013 | Values: 3002.3 3003.8 3019.5 3039.3 3047.7 5115.2 5279.9 5339.3 5362.0 5402.5 5225.1 5299.1 5358.0 5408.9 5492.9 4777.7 4869.5 4900.2 4930.0 4956.4 4939.7 4955.1 4960.0 4984.7 4990.2 4730.6 4767.2 4769.6 4981.6 5056.0 4826.7 4857.6 4895.2 4909.5 4922.0 4784.1 4811.4 4826.3 4856.2 4896.7 5128.3 5266.2 5300.8 5317.4 5366.6 5508.9 5630.4 5700.0 5702.3 5781.0 5705.5 5706.0 5717.2 5719.7 5776.8 5365.5 5372.7 5383.4 5385.9 5424.2 5662.3 5735.1 5783.1 5815.5 5837.9 5562.1 5632.9 5636.7 5645.5 5691.9 5579.3 5602.7 5638.5 5693.7 5702.8 5644.6 5661.6 5672.0 5709.3 5762.4 5687.8 5724.2 5724.3 5735.2 5744.5 4321.4 4442.1 4496.3 4497.0 4499.9 3862.4 3907.2 3920.7 3965.7 3999.3 5346.8 5460.2 5465.7 5471.2 5471.9 5657.8 5713.5 5730.8 5739.8 5785.6 5351.0 5384.1 5442.2 5470.8 5488.4 5006.4 5007.3 5007.8 5013.3 5050.2 5975.2 5980.5 6000.7 6004.7 6016.3 5664.6 5720.5 5754.3 5773.9 5800.5 5989.1 5997.6 6009.2 6061.6 6070.2 5609.4 5669.5 5671.0 5694.6 5705.3 5660.1 5669.6 5774.2 5799.0 5804.0 5627.2 5700.9 5706.2 5760.4 5760.5 5648.3 5669.1 5670.5 5697.1 5698.2 5345.2 5347.7 5503.9 5537.5 5621.2 5711.0 5721.9 5737.6 5773.6 5778.4 5541.4 5577.7 5596.4 5604.5 5606.4 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | [#1] ext.html Cycles:180 Average:56288.56 Median:41020.50 stddev:107246.94 (261.4%) stddev-sans-first:107466.20 09:37:41 INFO - PROCESS | 29013 | Values: 566.8 578.9 580.9 586.1 592.5 41946.8 43687.8 43791.3 47344.0 47399.0 43367.6 43848.3 43878.3 43878.3 43973.6 8960.4 9109.6 9115.9 9124.5 9127.2 8920.8 9006.1 9037.5 9039.7 9047.1 9061.7 9104.8 9106.7 9112.0 9112.9 8955.1 8990.1 8997.9 9057.7 9060.1 8906.2 8921.3 8992.2 8996.2 9031.6 40309.4 40480.0 40839.8 40923.0 40988.0 3101.2 3216.5 3284.8 3289.0 3297.1 30901.7 31113.4 31188.2 32296.0 33214.7 4051.6 4097.9 4153.5 4161.4 4164.7 303529.0 304345.0 305502.0 306204.0 306853.0 55146.7 55448.6 55465.4 55498.7 55546.0 59523.7 59641.0 59739.4 59915.0 60006.4 14719.5 14724.3 14734.0 14835.9 14855.0 11301.4 11302.4 11320.4 11331.2 11332.6 15823.9 17303.8 17344.7 17417.7 17600.7 5705.2 5824.7 5924.6 5932.9 5945.6 943.5 943.7 1005.7 1016.3 1057.6 31523.5 31595.2 31737.0 31796.0 31845.4 1067.9 1105.3 1107.4 1166.8 1245.6 15177.2 16910.0 17037.2 17092.7 17097.7 463820.0 465876.0 466064.0 466746.0 469002.0 56435.2 56543.7 56670.4 56800.7 56946.4 1315.7 1319.9 1345.7 1358.2 1360.3 29235.3 30848.0 31044.7 31788.0 32272.2 48589.3 50147.7 53444.2 53549.0 53717.7 425760.0 427178.0 427566.0 428605.0 429351.0 27169.0 28079.6 28114.7 28196.3 28308.0 45764.0 46343.5 46430.3 47323.5 47426.3 38711.0 39421.0 39741.0 41053.0 41129.6 39401.0 39740.6 40258.2 40625.6 41193.4 38688.4 39460.2 39499.8 39864.2 42153.4 30443.2 34491.1 35927.0 36122.6 36692.0 27450.3 27582.2 27618.0 27668.9 28046.6 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | [#2] jquery.html Cycles:180 Average:27519.79 Median:1993.75 stddev:72786.57 (3650.7%) stddev-sans-first:72962.24 09:37:41 INFO - PROCESS | 29013 | Values: 383.7 384.0 386.2 391.9 403.5 14347.3 17685.0 17826.4 19508.3 19510.9 17760.5 18291.4 18951.3 18962.0 19002.5 5241.9 5263.3 5352.7 5396.9 5397.6 5208.5 5286.2 5295.1 5300.2 5319.6 5255.8 5265.7 5728.4 5794.9 5797.7 5782.5 5821.1 5821.8 5833.2 5843.4 5177.1 5479.1 5501.9 5512.1 5585.1 13669.4 13782.7 13953.9 13998.9 14010.4 2097.6 2148.5 2154.3 2182.5 2185.3 9879.5 10206.1 10422.3 10481.6 10507.2 1865.9 1982.7 2030.2 2055.3 2058.8 78794.0 79369.6 80088.6 80506.0 81027.0 10928.2 11110.2 11124.4 11195.8 11437.3 12504.9 15868.3 15870.2 15883.5 15916.4 7434.6 7515.6 7716.1 7764.6 7773.2 7227.6 7232.4 7275.3 7490.6 7525.7 3934.8 4014.4 4087.3 4167.2 4297.9 1959.8 1980.5 1984.9 2002.6 2057.7 870.3 952.1 956.0 966.2 1003.5 18122.3 19308.9 19453.9 19458.1 19496.2 960.3 960.9 963.7 987.0 1003.7 10267.4 10831.1 10976.7 11015.6 11080.7 356293.0 448162.0 459596.0 460187.6 460522.0 93418.5 96521.0 98503.0 98675.0 101020.5 960.1 1002.0 1041.9 1042.3 1047.5 17300.0 17407.7 18199.6 18235.6 18285.7 37972.2 41077.8 41187.6 41355.6 43267.4 50799.5 56548.4 58085.0 58285.0 59263.7 10915.7 11113.3 12408.6 12545.0 12569.2 13532.2 13947.0 13999.2 14482.4 14578.9 11831.9 12049.9 12255.0 12377.8 12421.1 11848.8 12096.1 12145.3 12189.5 12400.3 11948.6 12298.8 12322.1 12359.1 12484.6 12527.7 12630.7 12817.9 12994.5 13075.9 12007.6 12130.6 12298.2 12539.3 12724.0 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | [#3] mootools.html Cycles:180 Average:5883.62 Median:2548.84 stddev:3490.55 (136.9%) stddev-sans-first:3484.48 09:37:41 INFO - PROCESS | 29013 | Values: 1455.1 1484.1 1611.5 1678.9 1731.8 8015.5 8254.1 8655.6 9378.1 9437.4 8566.3 8826.7 8843.6 9117.0 9143.9 2279.5 2284.6 2310.1 2316.7 2321.3 2294.9 2337.5 2337.5 2342.3 2354.8 2285.0 2331.6 2331.6 2343.4 2354.3 2265.3 2293.6 2304.1 2312.0 2314.6 2273.7 2273.7 2277.0 2279.6 2283.7 9116.0 9130.8 9199.3 9206.5 9234.5 4961.7 5154.0 5156.9 5159.0 5159.2 3151.3 3212.2 3366.4 3370.3 3391.3 1086.4 1105.1 1108.0 1124.5 1125.9 12794.6 12902.9 12954.2 12972.7 12974.2 4436.2 4509.3 4628.9 4709.8 4717.5 10704.7 10720.7 10723.6 10738.9 10758.6 5208.9 5224.0 5228.9 5248.6 5259.6 3988.9 4137.9 4614.6 4719.0 4846.5 3883.9 4028.5 4097.0 4106.8 4110.5 1290.5 1290.9 1297.9 1306.3 1337.4 907.3 924.4 938.7 941.4 948.5 5734.1 5827.6 5847.4 5860.6 5942.4 468.8 473.2 476.0 479.2 480.5 3907.4 3973.4 3985.7 3994.4 4052.8 10940.4 11483.1 11507.9 11587.9 11599.8 11460.4 11537.9 11555.3 11577.4 11593.5 8175.8 8333.3 8440.3 8452.2 8493.2 5736.5 5749.5 5751.9 5798.5 5948.6 10470.5 10531.2 10534.4 10640.7 10757.3 10484.4 10570.2 10665.5 10684.6 10775.3 7125.3 7279.2 7634.8 7912.9 8028.2 8482.6 8901.4 8925.5 8925.6 8926.1 7733.0 7853.8 7860.3 8089.8 8230.5 7668.8 7826.4 7884.4 8025.4 8048.7 6753.1 6909.2 6994.0 7012.9 7016.2 4932.3 4939.8 5027.5 5096.4 5197.6 5042.8 5118.7 5119.0 5280.8 5353.3 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | [#4] prototype.html Cycles:180 Average:4811.55 Median:5496.71 stddev:1426.39 (25.9%) stddev-sans-first:1390.05 09:37:41 INFO - PROCESS | 29013 | Values: 323.5 332.6 334.6 339.9 341.3 5393.3 5474.5 5489.9 5503.5 5533.8 5415.7 5425.0 5449.4 5452.0 5460.7 4009.6 4065.7 4123.4 4192.8 4194.5 4190.6 4197.6 4230.3 4231.4 4243.7 4192.9 4219.4 4229.1 4233.3 4233.3 4082.4 4206.4 4207.3 4217.7 4224.3 3710.3 3713.0 3717.0 3725.5 3735.9 5254.9 5267.8 5279.4 5281.4 5301.5 4637.6 4792.7 4805.9 4822.8 4850.4 5613.8 5620.7 5652.4 5673.4 5687.0 4032.3 4079.4 4097.7 4105.8 4114.4 5568.0 5814.5 5842.4 5855.2 5894.0 4093.5 4141.8 4150.2 4153.2 4156.3 4190.1 4195.8 4199.9 4201.3 4208.4 4563.0 4765.7 4834.2 4845.2 4845.2 5655.9 5695.5 5705.5 5724.5 5730.2 1486.8 1506.4 1508.3 1511.2 1512.3 901.2 940.8 946.6 961.3 986.4 5406.4 5437.9 5452.7 5512.3 5522.3 5781.2 5789.6 5802.4 5809.2 5817.0 5249.2 5459.5 5476.8 5476.9 5519.4 3100.5 3122.3 3132.6 3143.5 3144.7 5782.2 6063.2 6094.7 6095.1 6120.4 5908.7 6004.3 6040.3 6044.8 6051.8 6075.9 6128.4 6131.2 6133.6 6165.8 5656.6 5873.6 5911.0 5926.6 5948.3 5862.9 5865.0 5871.6 5872.4 5897.8 5824.5 6074.1 6127.3 6145.3 6163.8 4150.5 4157.1 4175.7 4183.2 4197.8 5934.6 5941.2 5943.2 5959.0 5961.5 5665.2 5743.7 5788.4 5804.5 5815.9 5800.2 5814.5 5816.2 5816.8 5840.2 5341.0 5747.4 5749.5 5757.5 5764.9 5748.6 5761.9 5762.9 5780.7 5811.8 5649.9 5669.2 5709.9 5716.7 5720.9 09:37:41 INFO - PROCESS | 29013 | 09:37:41 INFO - PROCESS | 29013 | [#5] yui.html Cycles:180 Average:21653.59 Median:4376.30 stddev:32330.53 (738.8%) stddev-sans-first:32382.93 09:37:41 INFO - PROCESS | 29013 | Values: 694.9 701.4 767.1 782.2 801.0 15145.7 15588.9 15622.8 15700.5 15740.1 15184.9 15406.3 15422.3 15432.2 15440.8 645.9 661.6 749.1 762.8 777.1 788.1 789.5 791.7 793.1 794.0 828.3 833.9 834.2 836.7 839.5 832.7 833.2 837.4 838.0 840.7 609.0 611.7 612.1 612.1 613.1 14546.7 14606.1 14634.8 14641.4 14671.7 14301.0 14433.9 14476.0 14630.8 14659.7 11022.3 11039.7 11047.8 11118.6 11211.6 4370.4 4382.2 4467.2 4656.4 4670.6 71481.0 72536.0 72777.0 72950.3 74029.0 10433.3 11265.5 11523.9 11650.9 11709.2 21404.7 21648.2 21649.5 21703.5 21757.6 7789.6 8069.3 8139.6 8146.8 8173.2 4533.7 4576.8 4592.4 4593.2 4619.0 3363.1 3441.2 3463.6 3463.7 3473.4 596.6 607.3 622.8 624.0 628.7 667.2 679.8 689.9 725.3 726.7 8461.2 9167.8 9341.8 9344.7 9528.9 532.0 536.1 549.7 569.2 570.5 4272.4 4280.5 4336.3 4394.7 4548.2 122787.0 124931.4 125215.4 126485.4 127311.4 102521.0 105431.0 106494.0 110047.0 112884.0 72643.6 93429.5 98245.5 101544.0 101559.5 8334.3 8384.6 8504.7 8555.3 8747.2 56114.4 56230.0 56751.7 57592.4 58267.0 74747.0 81056.5 81215.0 82522.0 84482.0 11323.5 12889.0 12913.6 13074.3 13637.2 14898.4 14949.3 15003.8 15799.9 15835.0 12061.9 12397.9 12596.4 12771.2 13589.0 14246.6 14304.4 14399.0 14520.2 14769.9 11607.2 12175.4 12308.4 12634.4 12808.4 10937.4 10971.6 11262.8 11318.8 11517.4 10488.2 10778.8 10873.3 10995.2 11008.7 09:37:41 INFO - PROCESS | 29013 | -------- Summary: end -------- 09:37:41 INFO - PROCESS | 29013 | 09:37:42 INFO - TEST-INFO | 29013: exit 0 09:37:42 INFO - TEST-OK | dromaeo_css | took 1115063ms 09:37:42 INFO - TEST-START | kraken 09:37:42 INFO - operating with platform_type : linux_ 09:37:42 INFO - Initialising browser for kraken test... 09:37:42 INFO - TEST-INFO | started process 29367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8dWeIw/profile http://localhost:56843/getInfo.html) 09:37:47 INFO - PROCESS | 29367 | __metrics Screen width/height:1600/1200 09:37:47 INFO - PROCESS | 29367 | colorDepth:24 09:37:47 INFO - PROCESS | 29367 | Browser inner width/height: 1024/697 09:37:47 INFO - PROCESS | 29367 | __metrics 09:37:47 ERROR - PROCESS | 29367 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 09:37:48 INFO - TEST-INFO | 29367: exit 0 09:37:48 INFO - Browser initialized. 09:37:48 INFO - Running cycle 1/1 for kraken test... 09:37:48 INFO - TEST-INFO | started process 29486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8dWeIw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:00 INFO - PROCESS | 29486 | RSS: Main: 186277888 09:38:00 INFO - PROCESS | 29486 | 09:38:03 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56843/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:04 INFO - PROCESS | 29486 | RSS: Main: 200097792 09:38:04 INFO - PROCESS | 29486 | 09:38:06 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56843/tests/kraken/driver.html?testName=audio-dft) 09:38:07 INFO - PROCESS | 29486 | RSS: Main: 197152768 09:38:07 INFO - PROCESS | 29486 | 09:38:10 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56843/tests/kraken/driver.html?testName=audio-fft) 09:38:10 INFO - PROCESS | 29486 | RSS: Main: 193232896 09:38:10 INFO - PROCESS | 29486 | 09:38:13 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56843/tests/kraken/driver.html?testName=audio-oscillator) 09:38:13 INFO - PROCESS | 29486 | RSS: Main: 194187264 09:38:13 INFO - PROCESS | 29486 | 09:38:15 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:16 INFO - PROCESS | 29486 | RSS: Main: 194363392 09:38:16 INFO - PROCESS | 29486 | 09:38:19 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56843/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:20 INFO - PROCESS | 29486 | RSS: Main: 194969600 09:38:20 INFO - PROCESS | 29486 | 09:38:23 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56843/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:24 INFO - PROCESS | 29486 | RSS: Main: 193372160 09:38:24 INFO - PROCESS | 29486 | 09:38:27 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56843/tests/kraken/driver.html?testName=json-parse-financial) 09:38:27 INFO - PROCESS | 29486 | RSS: Main: 193978368 09:38:27 INFO - PROCESS | 29486 | 09:38:29 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:29 INFO - PROCESS | 29486 | RSS: Main: 194383872 09:38:29 INFO - PROCESS | 29486 | 09:38:31 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:32 INFO - PROCESS | 29486 | RSS: Main: 194932736 09:38:32 INFO - PROCESS | 29486 | 09:38:34 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:34 INFO - PROCESS | 29486 | RSS: Main: 194547712 09:38:34 INFO - PROCESS | 29486 | 09:38:37 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:38 INFO - PROCESS | 29486 | RSS: Main: 194416640 09:38:38 INFO - PROCESS | 29486 | 09:38:41 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:41 INFO - PROCESS | 29486 | RSS: Main: 194924544 09:38:41 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | Cycle 1(1): loaded http://localhost:56843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56843/tests/kraken/driver.html?testName=ai-astar) 09:38:43 INFO - PROCESS | 29486 | RSS: Main: 196247552 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | __start_tp_report 09:38:43 INFO - PROCESS | 29486 | _x_x_mozilla_page_load 09:38:43 INFO - PROCESS | 29486 | _x_x_mozilla_page_load_details 09:38:43 INFO - PROCESS | 29486 | |i|pagename|runs| 09:38:43 INFO - PROCESS | 29486 | |0;ai-astar;109;111;112;111;112;111;112;110;110;109 09:38:43 INFO - PROCESS | 29486 | |1;audio-beat-detection;157;125;128;181;130;126;131;131;158;125 09:38:43 INFO - PROCESS | 29486 | |2;audio-dft;161;163;163;164;172;163;163;165;162;162 09:38:43 INFO - PROCESS | 29486 | |3;audio-fft;76;77;76;114;78;76;77;76;100;76 09:38:43 INFO - PROCESS | 29486 | |4;audio-oscillator;82;82;123;83;82;83;105;81;82;105 09:38:43 INFO - PROCESS | 29486 | |5;imaging-gaussian-blur;118;118;118;118;117;118;118;117;118;118 09:38:43 INFO - PROCESS | 29486 | |6;imaging-darkroom;147;147;147;146;146;147;146;147;146;147 09:38:43 INFO - PROCESS | 29486 | |7;imaging-desaturate;96;97;97;95;95;96;96;97;95;95 09:38:43 INFO - PROCESS | 29486 | |8;json-parse-financial;52;54;54;52;57;58;53;56;53;53 09:38:43 INFO - PROCESS | 29486 | |9;json-stringify-tinderbox;61;62;62;63;63;62;62;62;62;62 09:38:43 INFO - PROCESS | 29486 | |10;stanford-crypto-aes;86;81;82;82;80;87;80;81;81;86 09:38:43 INFO - PROCESS | 29486 | |11;stanford-crypto-ccm;145;142;138;139;133;143;131;144;191;152 09:38:43 INFO - PROCESS | 29486 | |12;stanford-crypto-pbkdf2;171;177;165;166;164;169;172;167;169;167 09:38:43 INFO - PROCESS | 29486 | |13;stanford-crypto-sha256-iterative;66;67;72;65;67;67;66;67;68;65 09:38:43 INFO - PROCESS | 29486 | __end_tp_report 09:38:43 INFO - PROCESS | 29486 | __start_cc_report 09:38:43 INFO - PROCESS | 29486 | _x_x_mozilla_cycle_collect,765 09:38:43 INFO - PROCESS | 29486 | __end_cc_report 09:38:43 INFO - PROCESS | 29486 | __startTimestamp1475512723850__endTimestamp 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | ------- Summary: start ------- 09:38:43 INFO - PROCESS | 29486 | Number of tests: 14 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 09:38:43 INFO - PROCESS | 29486 | Values: 109.0 111.0 112.0 111.0 112.0 111.0 112.0 110.0 110.0 109.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:131.00 stddev:19.26 (14.7%) stddev-sans-first:19.32 09:38:43 INFO - PROCESS | 29486 | Values: 157.0 125.0 128.0 181.0 130.0 126.0 131.0 131.0 158.0 125.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.08 (1.9%) stddev-sans-first:3.10 09:38:43 INFO - PROCESS | 29486 | Values: 161.0 163.0 163.0 164.0 172.0 163.0 163.0 165.0 162.0 162.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.29 (17.5%) stddev-sans-first:13.88 09:38:43 INFO - PROCESS | 29486 | Values: 76.0 77.0 76.0 114.0 78.0 76.0 77.0 76.0 100.0 76.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.00 stddev:14.79 (18.0%) stddev-sans-first:15.34 09:38:43 INFO - PROCESS | 29486 | Values: 82.0 82.0 123.0 83.0 82.0 83.0 105.0 81.0 82.0 105.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:38:43 INFO - PROCESS | 29486 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:38:43 INFO - PROCESS | 29486 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 09:38:43 INFO - PROCESS | 29486 | Values: 96.0 97.0 97.0 95.0 95.0 96.0 96.0 97.0 95.0 95.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.10 (3.9%) stddev-sans-first:2.07 09:38:43 INFO - PROCESS | 29486 | Values: 52.0 54.0 54.0 52.0 57.0 58.0 53.0 56.0 53.0 53.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 09:38:43 INFO - PROCESS | 29486 | Values: 61.0 62.0 62.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.67 (3.3%) stddev-sans-first:2.54 09:38:43 INFO - PROCESS | 29486 | Values: 86.0 81.0 82.0 82.0 80.0 87.0 80.0 81.0 81.0 86.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:143.50 stddev:16.99 (11.8%) stddev-sans-first:18.02 09:38:43 INFO - PROCESS | 29486 | Values: 145.0 142.0 138.0 139.0 133.0 143.0 131.0 144.0 191.0 152.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:3.86 (2.3%) stddev-sans-first:4.00 09:38:43 INFO - PROCESS | 29486 | Values: 171.0 177.0 165.0 166.0 164.0 169.0 172.0 167.0 169.0 167.0 09:38:43 INFO - PROCESS | 29486 | 09:38:43 INFO - PROCESS | 29486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.00 (3.0%) stddev-sans-first:2.09 09:38:43 INFO - PROCESS | 29486 | Values: 66.0 67.0 72.0 65.0 67.0 67.0 66.0 67.0 68.0 65.0 09:38:43 INFO - PROCESS | 29486 | -------- Summary: end -------- 09:38:43 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - PROCESS | 29486 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:38:44 INFO - PROCESS | 29486 | 09:38:44 INFO - TEST-INFO | 29486: exit 0 09:38:44 INFO - TEST-OK | kraken | took 61976ms 09:38:44 INFO - SUITE-END | took 1177s 09:38:45 INFO - Completed test suite (00:19:37) 09:38:45 INFO - javascript benchmark 09:38:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7205.994228582309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3002.2794529312964, 3003.8347890865994, 3019.471592471318, 3039.255382431304, 3047.6952304769525, 5115.155999260118, 5279.868003299919, 5339.252504649347, 5362.0, 5402.540784033357, 5225.085610018241, 5299.099153143965, 5358.035553600351, 5408.891822163564, 5492.862678433041, 4777.665563410563, 4869.51304869512, 4900.215965445529, 4929.975350123244, 4956.430010548779, 4939.678920870132, 4955.058538877602, 4959.975200123994, 4984.700917944917, 4990.151674215392, 4730.550597693214, 4767.165745994472, 4769.570738633505, 4981.601471882241, 5056.0, 4826.710397376133, 4857.635677324215, 4895.192293271606, 4909.533594308535, 4921.975390123062, 4784.067106914154, 4811.374521312242, 4826.276058591239, 4856.223004319292, 4896.657233993622, 5128.333316668809, 5266.210068489757, 5300.814471493518, 5317.441668624778, 5366.570674346043, 5508.889822203533, 5630.408807075239, 5699.971500142473, 5702.344230413472, 5780.959427303083, 5705.515031222351, 5706.0, 5717.228174196472, 5719.6854173020465, 5776.768929242825, 5365.54392876602, 5372.7313634318125, 5383.380911195184, 5385.865353366197, 5424.186372044225, 5662.320521537442, 5735.139729040678, 5783.103618939072, 5815.476607105296, 5837.88324233513, 5562.110062389998, 5632.943670563324, 5636.746346414421, 5645.5483561314995, 5691.943080569225, 5579.2746942897165, 5602.691851948182, 5638.548916086703, 5693.743781529758, 5702.800401985911, 5644.645285131539, 5661.603687741901, 5672.035753921843, 5709.34342550612, 5762.423757624204, 5687.800926967537, 5724.16999535065, 5724.3130824300515, 5735.2257445245195, 5744.4829965303325, 4321.395004699345, 4442.111577684476, 4496.348029535699, 4497.0, 4499.932501012488, 3862.4013277941963, 3907.199024200032, 3920.6863450923856, 3965.7025723070883, 3999.340108882002, 5346.8395948121615, 5460.153676180119, 5465.72671366438, 5471.179323101487, 5471.917921231185, 5657.8019769307875, 5713.457221563945, 5730.770769169187, 5739.770409183586, 5785.566082543826, 5351.0, 5384.0847056000575, 5442.183672449164, 5470.835874923759, 5488.396276409591, 5006.3992320921, 5007.324011258506, 5007.799688012512, 5013.273075404046, 5050.217216331474, 5975.19334889793, 5980.461758441761, 6000.669963152069, 6004.729787159501, 6016.308124565643, 5664.5751568631695, 5720.456556627114, 5754.309482862083, 5773.913391299218, 5800.535957123504, 5989.131575921379, 5997.610155339889, 6009.188759517584, 6061.575689701678, 6070.180525628984, 5609.382967873612, 5669.518090962314, 5670.971645141748, 5694.629849059798, 5705.343885453226, 5660.122680984454, 5669.6314739541795, 5774.162746401832, 5799.0, 5804.042333015005, 5627.155926610877, 5700.914486282626, 5706.172604972338, 5760.366359700513, 5760.481556659921, 5648.265725455664, 5669.092945128759, 5670.546356291569, 5697.088465845445, 5698.20225168485, 5345.1982202669915, 5347.732613369239, 5503.917441238465, 5537.529310008695, 5621.184928185308, 5711.0, 5721.856953576027, 5737.569682273763, 5773.595848290747, 5778.364379918122, 5541.445855414427, 5577.693226872399, 5596.440355964371, 5604.467575580314, 5606.439356064361], "value": 5290.457597548363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7761234312446, 578.8581797459623, 580.9448102430267, 586.1120402590077, 592.534860134794, 41946.790266048665, 43687.78156109219, 43791.34312985308, 47344.0, 47399.0, 43367.566324336745, 43848.3422748659, 43878.34182487257, 43878.34182487265, 43973.56026439735, 8960.372773905829, 9109.590068446936, 9115.903342231291, 9124.498152601604, 9127.178553930145, 8920.821583568324, 9006.099390061006, 9037.457752534836, 9039.728808135766, 9047.095290470967, 9061.682841100563, 9104.817903641957, 9106.726798196065, 9112.0, 9112.908870911306, 8955.149260820277, 8990.145936136056, 8997.865032024525, 9057.728268152, 9060.093990600953, 8906.198442140174, 8921.330900182447, 8992.23565996891, 8996.235319997808, 9031.593578288926, 40309.39535906934, 40480.0, 40839.7958010211, 40923.0, 40988.0, 3101.1936896407096, 3216.549683044376, 3284.753643476725, 3288.983555082233, 3297.1262615406936, 30901.69098309033, 31113.37773244545, 31188.220294492592, 32296.0, 33214.66785332164, 4051.574584668597, 4097.8565750198895, 4153.522344930341, 4161.375793630949, 4164.68764842638, 303529.0, 304345.0, 305502.0, 306204.0, 306852.9999999978, 55146.72426637921, 55448.6137846557, 55465.44534554603, 55498.72250638802, 55546.0, 59523.70238148781, 59641.0, 59739.402605974254, 59915.0, 60006.399936000955, 14719.484818031318, 14724.33740481681, 14734.042287251294, 14835.925820370829, 14855.0, 11301.378424186585, 11302.37836918961, 11320.433978301053, 11331.150163737753, 11332.6033588824, 15823.920880395524, 17303.82696173022, 17344.653106938043, 17417.65164696699, 17600.735988960176, 5705.172749951317, 5824.679642619697, 5924.6149000314845, 5932.851678707981, 5945.613535120204, 943.4622265308845, 943.6744323208482, 1005.6580762540772, 1016.3495362967707, 1057.6456886942806, 31523.527147092813, 31595.21011974719, 31737.0, 31796.0, 31845.36309273848, 1067.8558394616782, 1105.2705214558353, 1107.3920916242294, 1166.7783121206944, 1245.620085873799, 15177.24113794306, 16910.0, 17037.233324500427, 17092.743608845878, 17097.658046838995, 463820.0, 465876.0, 466064.0, 466746.0, 469002.0, 56435.153472697944, 56543.71728141333, 56670.43329566734, 56800.71599642058, 56946.43053569411, 1315.7236980234068, 1319.8680131986916, 1345.7375811716818, 1358.1647286918671, 1360.3062438156612, 29235.269118272212, 30848.0, 31044.689553105083, 31788.0, 32272.193195170308, 48589.27116093332, 50147.74926125492, 53444.1983370242, 53549.0, 53717.73141134269, 425760.0, 427178.0, 427566.0, 428605.0, 429351.0, 27168.97373985819, 28079.578806317513, 28114.71885281121, 28196.295092622848, 28308.0, 45764.0, 46343.53656463392, 46430.30354544617, 47323.52676473191, 47426.288605670255, 38711.0, 39421.0, 39741.0, 41053.0, 41129.588704113776, 39401.0, 39740.6110205645, 40258.19483610253, 40625.59374406218, 41193.38209926793, 38688.41967370435, 39460.2107957845, 39499.80250098846, 39864.2027159461, 42153.36769948515, 30443.2389190272, 34491.13772155716, 35927.03164158841, 36122.63877361193, 36692.0, 27450.313742155806, 27582.17253482399, 27618.0, 27668.86260814395, 28046.62208054247], "value": 19418.405257563772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6834611445558, 384.00925611921235, 386.1639550373442, 391.9000895496517, 403.54802621064414, 14347.28263586819, 17685.0, 17826.376076837296, 19508.31720889769, 19510.902445487787, 17760.46718598441, 18291.359802406918, 18951.33670321539, 18962.0, 19002.524936876584, 5241.8951620967655, 5263.315768950031, 5352.678839269637, 5396.91904621431, 5397.595180361489, 5208.479152084799, 5286.154215325549, 5295.0733621616255, 5300.204969254623, 5319.627626066177, 5255.84371438283, 5265.736713164346, 5728.42715728428, 5794.884102317951, 5797.71011449428, 5782.45066718661, 5821.068629019379, 5821.767129314822, 5833.241678581779, 5843.444872737083, 5177.119889618773, 5479.123340265538, 5501.862453438696, 5512.118061110244, 5585.1063829787445, 13669.384877680528, 13782.65543361414, 13953.930230348884, 13998.930005349908, 14010.439582416793, 2097.590969760897, 2148.473623962124, 2154.2998525479284, 2182.519845633958, 2185.344396681005, 9879.506024698809, 10206.132478739317, 10422.270441069128, 10481.633142839964, 10507.211959103099, 1865.897375644339, 1982.70259461082, 2030.1777779999125, 2055.2601063617085, 2058.8455865810124, 78794.0, 79369.60315198445, 80088.59291256685, 80506.0, 81027.0, 10928.180386471047, 11110.222284440011, 11124.388158651353, 11195.776084478428, 11437.256578322382, 12504.937475312565, 15868.285927133076, 15870.2064896757, 15883.52349429519, 15916.363345466283, 7434.591097489581, 7515.586642734702, 7716.074071111502, 7764.572948487775, 7773.183815699384, 7227.566346019255, 7232.421406287484, 7275.272472752682, 7490.550566966, 7525.736599219001, 3934.7639141651593, 4014.437978682987, 4087.2847251731423, 4167.229062623424, 4297.861066817296, 1959.8040195980288, 1980.4652743759104, 1984.8511361647934, 2002.6495363311362, 2057.68105943579, 870.3472395703222, 952.0812416018437, 955.9525704281406, 966.2366730283138, 1003.508280942333, 18122.275108995756, 19308.903455482632, 19453.902730486257, 19458.124384402738, 19496.220151194077, 960.279790157382, 960.8943016268205, 963.6579014449769, 986.9950650246847, 1003.693873368615, 10267.35722284431, 10831.133509319236, 10976.670699879016, 11015.614453494089, 11080.722981925355, 356293.0, 448162.0, 459596.0, 460187.5924963031, 460522.0, 93418.53290733503, 96521.03478965121, 98503.0, 98675.01324986658, 101020.49489752504, 960.1166926427703, 1001.9849702254472, 1041.9270651054353, 1042.3433237060603, 1047.4710271312786, 17300.04849733277, 17407.651846962737, 18199.636007279514, 18235.635287294444, 18285.725714114564, 37972.240555189295, 41077.79461102795, 41187.588124118374, 41355.58644413517, 43267.35098973581, 50799.492005079475, 56548.43451565432, 58085.0, 58285.0, 59263.70368148132, 10915.672529824118, 11113.277636953571, 12408.62774116778, 12545.0, 12569.183003104768, 13532.188068715908, 13947.0, 13999.23004234736, 14482.420703171754, 14578.85421145775, 11831.881681183422, 12049.879501204876, 12255.0, 12377.814332785196, 12421.130520863453, 11848.822267666164, 12096.141431196236, 12145.271283723005, 12189.451474683838, 12400.31798251105, 11948.581799636971, 12298.75402491963, 12322.137450378388, 12359.134860560034, 12484.56304029391, 12527.686807829878, 12630.747385052431, 12817.871821281668, 12994.545190918272, 13075.869241307846, 12007.579734709243, 12130.575429859913, 12298.20061695987, 12539.310337931136, 12724.0], "value": 9153.495673622578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.0905683947528, 1484.0947022316386, 1611.5165450364896, 1678.91605419729, 1731.8441340279373, 8015.478993865395, 8254.092049874509, 8655.567221638916, 9378.062193780619, 9437.386569872953, 8566.271866891306, 8826.691065812698, 8843.557822108902, 9116.951550571686, 9143.90856091439, 2279.509905370345, 2284.577353189661, 2310.1452462588863, 2316.652502124678, 2321.3152120124605, 2294.89672964717, 2337.4506990857135, 2337.497438050819, 2342.2504798464497, 2354.764523547649, 2284.9657255141187, 2331.6152834782242, 2331.62693968965, 2343.4024323797407, 2354.281944007077, 2265.2637892684943, 2293.552757212344, 2304.1129165271323, 2311.9537609247805, 2314.6412306092584, 2273.658951157323, 2273.6589511573397, 2276.9886150569305, 2279.566882292359, 2283.7259528856475, 9116.0, 9130.81738365229, 9199.310051746079, 9206.49364284964, 9234.492102934337, 4961.7022978621035, 5153.9742301288625, 5156.92264616031, 5159.0, 5159.22611608258, 3151.322465669892, 3212.16483714236, 3366.4445366514497, 3370.3259348130473, 3391.2708767614836, 1086.3916206924148, 1105.060698406356, 1108.0, 1124.5164579230927, 1125.9211855170142, 12794.616161515169, 12902.935485322607, 12954.222746635232, 12972.740545189137, 12974.156679815782, 4436.157130145262, 4509.255972764523, 4628.907421851544, 4709.811607535728, 4717.457492388351, 10704.678859634223, 10720.731981700364, 10723.571057157626, 10738.892611073945, 10758.56965721378, 5208.947910520847, 5223.973880130651, 5228.869278268074, 5248.580113590903, 5259.579233661298, 3988.900277493086, 4137.875863724033, 4614.630829533629, 4719.032598317337, 4846.539578740014, 3883.922321553553, 4028.5165780106577, 4096.9795151024055, 4106.835726570964, 4110.486189226347, 1290.4580076367947, 1290.8773666501668, 1297.9221246725226, 1306.2684896458013, 1337.3848029906158, 907.3104440625173, 924.3714274293545, 938.6761567259284, 941.3645789092335, 948.4878165790396, 5734.139879018181, 5827.621204621686, 5847.356790753014, 5860.589758716849, 5942.376050514634, 468.77498800575916, 473.16958737415615, 475.99048019039424, 479.2260499293616, 480.5194805194805, 3907.4138879167785, 3973.443717879499, 3985.70107241958, 3994.360902255625, 4052.756834589934, 10940.398278094623, 11483.13876459269, 11507.942460287644, 11587.942060289814, 11599.826002609967, 11460.426978651034, 11537.942310288396, 11555.306681599131, 11577.363245021605, 11593.536258549564, 8175.754727358189, 8333.250007499355, 8440.282575980988, 8452.154784521621, 8493.150684931581, 5736.4550367715, 5749.482546570829, 5751.884962300647, 5798.507126894261, 5948.5538584605465, 10470.476476176009, 10531.157507399543, 10534.36793792375, 10640.733981650212, 10757.30077544957, 10484.370937743759, 10570.2072344576, 10665.46672666348, 10684.626038088629, 10775.299605525615, 7125.251848555827, 7279.1628962667855, 7634.8091297718, 7912.881306780288, 8028.197180282159, 8482.61828217744, 8901.421407608485, 8925.509096999727, 8925.553722313989, 8926.06276340975, 7732.961335193288, 7853.803654908673, 7860.292573668397, 8089.797755056171, 8230.506169629842, 7668.846623067619, 7826.373890088893, 7884.448088633741, 8025.438219324825, 8048.678052877819, 6753.054572359972, 6909.205441374105, 6994.0, 7012.859742805013, 7016.19313778922, 4932.3341348918875, 4939.802407903644, 5027.497250274943, 5096.413912400121, 5197.584193264454, 5042.798288068583, 5118.74406279692, 5118.986987826701, 5280.788768449219, 5353.2773075634295], "value": 4581.367970442984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.54057238721015, 332.63410248726404, 334.6352475801376, 339.9405104106781, 341.34121146187863, 5393.298871146751, 5474.452554744524, 5489.945100548994, 5503.477169668875, 5533.833984980447, 5415.702136382497, 5425.02349577076, 5449.4005659377435, 5451.972740136293, 5460.672359658423, 4009.6391324780766, 4065.6544193743566, 4123.36087906375, 4192.832286708528, 4194.475690538683, 4190.580941905816, 4197.643200327976, 4230.302000169968, 4231.42875711778, 4243.702940794145, 4192.874213773576, 4219.430376899126, 4229.133027729308, 4233.259179643565, 4233.280342341809, 4082.387641853716, 4206.390073439365, 4207.347861081537, 4217.662586993033, 4224.345226489868, 3710.257948410329, 3713.0, 3717.0, 3725.453936616301, 3735.869244576454, 5254.8686282842855, 5267.786650143409, 5279.366476022902, 5281.445448227919, 5301.549368303698, 4637.585536411393, 4792.736399498026, 4805.8558243252755, 4822.807087716487, 4850.442199147108, 5613.803516876889, 5620.662760234399, 5652.378238393773, 5673.404292549264, 5687.0, 4032.294348489003, 4079.4084857695466, 4097.713160078795, 4105.835766569334, 4114.403411505315, 5567.969925563743, 5814.5057670098095, 5842.386549412293, 5855.151003104526, 5894.0, 4093.5497095319492, 4141.751494910315, 4150.211459822624, 4153.169366126726, 4156.314208155621, 4190.141021090669, 4195.769232692171, 4199.9370009449885, 4201.327787553977, 4208.410822484854, 4563.0, 4765.69023013503, 4834.20235661119, 4845.152098382769, 4845.176320025604, 5655.943440565542, 5695.45893140151, 5705.5435565154685, 5724.513416359573, 5730.19777231188, 1486.8067151270266, 1506.3823832228734, 1508.3363320139104, 1511.199064495819, 1512.2665507228985, 901.1664210605164, 940.7789169545151, 946.6213514594217, 961.2502248246379, 986.3933680786408, 5406.432324605938, 5437.864053398696, 5452.672839629635, 5512.310961129859, 5522.30971128609, 5781.248437703071, 5789.623674461147, 5802.448767367094, 5809.186713860063, 5817.0, 5249.212618107238, 5459.481349271813, 5476.808311709071, 5476.945230547643, 5519.448055194529, 3100.5194194899827, 3122.297483066292, 3132.624085109756, 3143.512755522898, 3144.748420126384, 5782.161586569924, 6063.181470501514, 6094.725737341831, 6095.146679464879, 6120.418560236771, 5908.675022873783, 6004.279486461653, 6040.338906800577, 6044.848878778066, 6051.818445446644, 6075.908861367083, 6128.40661428023, 6131.221945635805, 6133.570650054543, 6165.784197552975, 5656.575756818337, 5873.588848780715, 5910.96558102339, 5926.555508336805, 5948.2862056553495, 5862.853428664147, 5865.0, 5871.6183448075735, 5872.412758724094, 5897.823065308047, 5824.5340372770925, 6074.056301983323, 6127.295361033538, 6145.293291271382, 6163.753449861955, 4150.501939767248, 4157.147784704068, 4175.70770046106, 4183.247015537232, 4197.769122698281, 5934.584579079423, 5941.2276404068925, 5943.227380440515, 5958.970205148947, 5961.523078153824, 5665.235193249024, 5743.74153163117, 5788.363280039276, 5804.477597016289, 5815.854603634943, 5800.187973683604, 5814.499765100878, 5816.243888294494, 5816.796412125555, 5840.153177789111, 5341.0, 5747.4252574742195, 5749.511291540266, 5757.510611598061, 5764.884702305846, 5748.597598168255, 5761.8559536011935, 5762.913556296575, 5780.710964451677, 5811.767529298781, 5649.915251271316, 5669.234653321913, 5709.857253568694, 5716.657000579979, 5720.885582288248], "value": 4355.079659777644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.8540806430649, 701.4283359062367, 767.0833354141799, 782.2177822177822, 800.9679612815489, 15145.697086058271, 15588.946873812805, 15622.76565851513, 15700.450484233053, 15740.134292613902, 15184.924075379635, 15406.30671619777, 15422.305996230169, 15432.151231682254, 15440.84559154408, 645.935406459355, 661.576590981772, 749.0786332810646, 762.8321769210764, 777.1373775109623, 788.1094363369384, 789.4986683456018, 791.7347688524351, 793.0760663826635, 793.9682412703485, 828.3125006244802, 833.8582440985047, 834.2116699718769, 836.7238811192323, 839.4627438439404, 832.7252006837729, 833.1668331668332, 837.426362941384, 837.9539125348103, 840.7141571865595, 608.9786857460012, 611.6513587255266, 612.1277180018456, 612.1429998002787, 613.0773186354508, 14546.709065818624, 14606.123632581974, 14634.780478292834, 14641.414343426357, 14671.70656586873, 14301.0, 14433.917456190828, 14475.973932077814, 14630.780538291934, 14659.706805863929, 11022.338659680365, 11039.72400689981, 11047.779044419147, 11118.555257789678, 11211.551537938472, 4370.4318438603095, 4382.167388196232, 4467.24056910326, 4656.41794775653, 4670.649701272384, 71481.0, 72536.0, 72777.0, 72950.27049729488, 74029.0, 10433.32183408076, 11265.54937802495, 11523.884761152449, 11650.941745291218, 11709.151153504667, 21404.678929816066, 21648.24231151902, 21649.45876353072, 21703.45741356479, 21757.564848702936, 7789.610519474004, 8069.31410830086, 8139.593020349077, 8146.837063258702, 8173.18268173178, 4533.705309154894, 4576.771161441915, 4592.357070010201, 4593.173228818845, 4619.0, 3363.075154332529, 3441.15691655546, 3463.584369875631, 3463.740219483549, 3473.392156372625, 596.573449983264, 607.2985701514757, 622.7789134857151, 624.0, 628.7233617208414, 667.2226855713137, 679.8232459560451, 689.8861687821453, 725.3471875312262, 726.7383741852929, 8461.205373363076, 9167.816643667089, 9341.813163736822, 9344.672936447192, 9528.857067143997, 532.0290469892461, 536.1341433584811, 549.7090503899963, 569.1889058092202, 570.4523657289049, 4272.401863739079, 4280.5291417944, 4336.2845130553105, 4394.715152726067, 4548.249538826057, 122787.0, 124931.37534312271, 125215.3739231298, 126485.36757316155, 127311.36344318218, 102521.0, 105431.0, 106494.0, 110047.0, 112884.0, 72643.63678181576, 93429.53285233666, 98245.50877245568, 101544.0, 101559.49220253999, 8334.291585215324, 8384.622691978753, 8504.659813607386, 8555.31557475388, 8747.212750852454, 56114.43885561092, 56230.0, 56751.71624141853, 57592.4240757587, 58267.0, 74747.0, 81056.54642885782, 81215.0, 82522.0, 84482.0, 11323.490442929924, 12889.0, 12913.612591622266, 13074.346282686018, 13637.181769093886, 14898.404063837324, 14949.25253737287, 15003.849961500246, 15799.921000394925, 15835.0, 12061.879381206076, 12397.876021239672, 12596.370181490705, 12771.233725976099, 13589.048766586244, 14246.643833904236, 14304.427822887385, 14399.0, 14520.240846732777, 14769.92615036918, 11607.187496875475, 12175.39123043862, 12308.446119924445, 12634.431450584929, 12808.423620936894, 10937.445574016925, 10971.615993440191, 11262.7747445049, 11318.830217546909, 11517.424128793695, 10488.213383996079, 10778.838317425088, 10873.347599144077, 10995.175361848052, 11008.724781880197], "value": 7461.659093003447, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 111.0, 112.0, 111.0, 112.0, 110.0, 110.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 128.0, 181.0, 130.0, 126.0, 131.0, 131.0, 158.0, 125.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 164.0, 172.0, 163.0, 163.0, 165.0, 162.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 114.0, 78.0, 76.0, 77.0, 76.0, 100.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 123.0, 83.0, 82.0, 83.0, 105.0, 81.0, 82.0, 105.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 95.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 52.0, 57.0, 58.0, 53.0, 56.0, 53.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 82.0, 82.0, 80.0, 87.0, 80.0, 81.0, 81.0, 86.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 142.0, 138.0, 139.0, 133.0, 143.0, 131.0, 144.0, 191.0, 152.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 177.0, 165.0, 166.0, 164.0, 169.0, 172.0, 167.0, 169.0, 167.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 72.0, 65.0, 67.0, 67.0, 66.0, 67.0, 68.0, 65.0], "value": 67.0, "unit": "score"}]}]} 09:38:45 INFO - Return code: 0 09:38:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:45 ERROR - # TBPL SUCCESS # 09:38:45 INFO - Running post-action listener: _resource_record_post_action 09:38:45 INFO - [mozharness: 2016-10-03 16:38:45.175093Z] Finished run-tests step (success) 09:38:45 INFO - Running post-run listener: _resource_record_post_run 09:38:45 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405090304; Read time: 20; Write time: 282328 09:38:45 INFO - TinderboxPrint: CPU usage
13.4% 09:38:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:38:45 INFO - TinderboxPrint: I/O write bytes / time
405,090,304 / 282,328 09:38:45 INFO - TinderboxPrint: CPU idle
8,253.7 (86.6%) 09:38:45 INFO - TinderboxPrint: CPU user
1,213.5 (12.7%) 09:38:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115310592; Read time: 0; Write time: 76636 09:38:45 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289779712; Read time: 20; Write time: 205692 09:38:45 INFO - Running post-run listener: _upload_blobber_files 09:38:45 INFO - Blob upload gear active. 09:38:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:45 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:38:45 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:45 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:46 INFO - (blobuploader) - INFO - Done attempting. 09:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:50 INFO - (blobuploader) - INFO - Done attempting. 09:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:51 INFO - (blobuploader) - INFO - Done attempting. 09:38:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:51 INFO - Return code: 0 09:38:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19d1c7922fb57f2a93a49db6cdba200942823df109c30979cefe6f48521565d8255595736485756c2c3e8ae815e256b8bfa19731084a0275a379d147e1b5ebf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3ff72c840cbf86b41e10ae9639391c291fd452e152d1ccf225169afa3a40cc525c92305d352c03def2daf1c00b26dc7fa056349551ca5b9f9aab069b6c3dfbc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a926e309772bcecd07785fcf50ddd98df3eae122c1bb2b5f2526d9b6b1c6eb7185aebfd8f30cb7941f0fbc5629588606fc88b6cf6c56f39dda9f449aaac94119"} 09:38:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:51 INFO - Contents: 09:38:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19d1c7922fb57f2a93a49db6cdba200942823df109c30979cefe6f48521565d8255595736485756c2c3e8ae815e256b8bfa19731084a0275a379d147e1b5ebf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3ff72c840cbf86b41e10ae9639391c291fd452e152d1ccf225169afa3a40cc525c92305d352c03def2daf1c00b26dc7fa056349551ca5b9f9aab069b6c3dfbc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a926e309772bcecd07785fcf50ddd98df3eae122c1bb2b5f2526d9b6b1c6eb7185aebfd8f30cb7941f0fbc5629588606fc88b6cf6c56f39dda9f449aaac94119"} 09:38:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:51 INFO - Copying logs to upload dir... 09:38:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.759680 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-03 09:38:48.004170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 09:38:48.008339) ========= 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=826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19d1c7922fb57f2a93a49db6cdba200942823df109c30979cefe6f48521565d8255595736485756c2c3e8ae815e256b8bfa19731084a0275a379d147e1b5ebf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3ff72c840cbf86b41e10ae9639391c291fd452e152d1ccf225169afa3a40cc525c92305d352c03def2daf1c00b26dc7fa056349551ca5b9f9aab069b6c3dfbc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a926e309772bcecd07785fcf50ddd98df3eae122c1bb2b5f2526d9b6b1c6eb7185aebfd8f30cb7941f0fbc5629588606fc88b6cf6c56f39dda9f449aaac94119"} build_url:https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/JXXMmc7eSXKdaTO6RMAFtQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19d1c7922fb57f2a93a49db6cdba200942823df109c30979cefe6f48521565d8255595736485756c2c3e8ae815e256b8bfa19731084a0275a379d147e1b5ebf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3ff72c840cbf86b41e10ae9639391c291fd452e152d1ccf225169afa3a40cc525c92305d352c03def2daf1c00b26dc7fa056349551ca5b9f9aab069b6c3dfbc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a926e309772bcecd07785fcf50ddd98df3eae122c1bb2b5f2526d9b6b1c6eb7185aebfd8f30cb7941f0fbc5629588606fc88b6cf6c56f39dda9f449aaac94119"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 09:38:48.037151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:38:48.037814) ========= 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=826874ccc97bd7bf541b4875000001d5-1475511067.250456-1616649445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 09:38:48.119765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 09:38:48.120191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 09:38:48.120635) ========= ========= Total master_lag: 0.18 =========