builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1475097188.09 results: success (0) buildid: 20160928124419 builduid: 3feb732c232049db8b79d1c0667cb064 revision: 7dac104b94dec3fa419b45683a9c76e7254896b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.091717) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.092219) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.092533) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.136713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.137020) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 14:13:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.2M=0s 2016-09-28 14:13:09 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.328631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.480773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.481164) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:08.530945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 14:13:08.531349) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7dac104b94dec3fa419b45683a9c76e7254896b0 --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 7dac104b94dec3fa419b45683a9c76e7254896b0 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 14:13:09,745 truncating revision to first 12 chars 2016-09-28 14:13:09,745 Setting DEBUG logging. 2016-09-28 14:13:09,746 attempt 1/10 2016-09-28 14:13:09,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7dac104b94de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 14:13:11,217 unpacking tar archive at: autoland-7dac104b94de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.877290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 14:13:10.427237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:10.428069) ========= script_repo_revision: 7dac104b94dec3fa419b45683a9c76e7254896b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:10.429087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:10.429833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 14:13:10.444333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-28 14:13:10.444887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:13:11 INFO - MultiFileLogger online at 20160928 14:13:11 in /builds/slave/test 14:13:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:13:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:13:11 INFO - {'append_to_log': False, 14:13:11 INFO - 'base_work_dir': '/builds/slave/test', 14:13:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:13:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:13:11 INFO - 'branch': 'Autoland-Non-PGO', 14:13:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:13:11 INFO - 'config_files': ('talos/linux_config.py',), 14:13:11 INFO - 'default_actions': ('clobber', 14:13:11 INFO - 'read-buildbot-config', 14:13:11 INFO - 'download-and-extract', 14:13:11 INFO - 'populate-webroot', 14:13:11 INFO - 'create-virtualenv', 14:13:11 INFO - 'install', 14:13:11 INFO - 'run-tests'), 14:13:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:13:11 INFO - 'download_minidump_stackwalk': True, 14:13:11 INFO - 'download_symbols': 'ondemand', 14:13:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:13:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:13:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:13:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:13:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:13:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:13:11 INFO - 'installer_path': 'installer.exe', 14:13:11 INFO - 'log_level': 'info', 14:13:11 INFO - 'log_name': 'talos', 14:13:11 INFO - 'log_to_console': True, 14:13:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:13:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:13:11 INFO - 'opt_config_files': (), 14:13:11 INFO - 'pip_index': False, 14:13:11 INFO - 'sps_profile': False, 14:13:11 INFO - 'sps_profile_interval': 0, 14:13:11 INFO - 'suite': 'dromaeojs', 14:13:11 INFO - 'system_bits': '32', 14:13:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:13:11 INFO - 'title': 'talos-linux64-ix-069', 14:13:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:13:11 INFO - 'use_talos_json': True, 14:13:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:13:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:13:11 INFO - 'work_dir': 'build'} 14:13:11 INFO - [mozharness: 2016-09-28 21:13:11.755698Z] Running clobber step. 14:13:11 INFO - Running pre-action listener: _resource_record_pre_action 14:13:11 INFO - Running main action method: clobber 14:13:11 INFO - rmtree: /builds/slave/test/build 14:13:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:13:12 INFO - Running post-action listener: _resource_record_post_action 14:13:12 INFO - [mozharness: 2016-09-28 21:13:12.226535Z] Finished clobber step (success) 14:13:12 INFO - [mozharness: 2016-09-28 21:13:12.226636Z] Running read-buildbot-config step. 14:13:12 INFO - Running pre-action listener: _resource_record_pre_action 14:13:12 INFO - Running main action method: read_buildbot_config 14:13:12 INFO - Using buildbot properties: 14:13:12 INFO - { 14:13:12 INFO - "project": "", 14:13:12 INFO - "product": "firefox", 14:13:12 INFO - "script_repo_revision": "production", 14:13:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:13:12 INFO - "repository": "", 14:13:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:13:12 INFO - "buildid": "20160928124419", 14:13:12 INFO - "pgo_build": "False", 14:13:12 INFO - "basedir": "/builds/slave/test", 14:13:12 INFO - "buildnumber": 725, 14:13:12 INFO - "slavename": "talos-linux64-ix-069", 14:13:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:13:12 INFO - "platform": "ubuntu64_hw", 14:13:12 INFO - "scheduler": "tests-autoland-linux64-talos", 14:13:12 INFO - "branch": "autoland", 14:13:12 INFO - "repo_path": "integration/autoland", 14:13:12 INFO - "revision": "7dac104b94dec3fa419b45683a9c76e7254896b0", 14:13:12 INFO - "stage_platform": "linux64", 14:13:12 INFO - "builduid": "3feb732c232049db8b79d1c0667cb064", 14:13:12 INFO - "slavebuilddir": "test" 14:13:12 INFO - } 14:13:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:13:12 INFO - Running post-action listener: _resource_record_post_action 14:13:12 INFO - [mozharness: 2016-09-28 21:13:12.229072Z] Finished read-buildbot-config step (success) 14:13:12 INFO - [mozharness: 2016-09-28 21:13:12.229161Z] Running download-and-extract step. 14:13:12 INFO - Running pre-action listener: _resource_record_pre_action 14:13:12 INFO - Running main action method: download_and_extract 14:13:12 INFO - mkdir: /builds/slave/test/build/tests 14:13:12 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')]} 14:13:12 INFO - trying https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:13:12 INFO - Downloading https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/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 14:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/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 14:13:12 INFO - Downloaded 1361 bytes. 14:13:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:13:12 INFO - Using the following test package requirements: 14:13:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:13:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:13:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:13:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'jsshell-linux-x86_64.zip'], 14:13:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:13:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:13:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:13:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:13:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:13:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:13:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:13:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:13:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:13:12 INFO - Fetch https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:13:13 INFO - Http code: 200 14:13:13 INFO - Content-Encoding: None 14:13:13 INFO - Content-Type: application/zip 14:13:13 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 14:13:13 INFO - x-amz-cf-id: dShwBkkJEi_jykbvawA5s9KItC_JMlNe6BouPODvxjkdfAb5_hxyug== 14:13:13 INFO - x-amz-version-id: R3GuWmYGlYwWceD3t.NWtdBrZWq.GgiM 14:13:13 INFO - x-cache: Hit from cloudfront 14:13:13 INFO - Expected file size: 20415898 14:13:13 INFO - Obtained file size: 20415898 14:13:17 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 14:13:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:13:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:13:17 INFO - Fetch https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:13:18 INFO - Http code: 200 14:13:18 INFO - Content-Encoding: None 14:13:18 INFO - Content-Type: application/zip 14:13:18 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 14:13:18 INFO - x-amz-cf-id: -6PcDbbCXEYxnkjh_dJFEtwHOn2bZQuxcGsiCN8FdDvqpV0Y9ezsKw== 14:13:18 INFO - x-amz-version-id: R3GuWmYGlYwWceD3t.NWtdBrZWq.GgiM 14:13:18 INFO - x-cache: Hit from cloudfront 14:13:18 INFO - Expected file size: 20415898 14:13:18 INFO - Obtained file size: 20415898 14:13:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:13:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:13:22 INFO - Fetch https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:13:23 INFO - Http code: 200 14:13:23 INFO - Content-Encoding: None 14:13:23 INFO - Content-Type: application/zip 14:13:23 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 14:13:23 INFO - x-amz-cf-id: UojA4VWofnXy2mz7doCgGJpJA7bQJXEc0ZarRmJA3-5emzYAfl5okQ== 14:13:23 INFO - x-amz-version-id: DDSfDEZV2zDh0.TW82B8Z.IDR6QhktJR 14:13:23 INFO - x-cache: Hit from cloudfront 14:13:23 INFO - Expected file size: 14414067 14:13:23 INFO - Obtained file size: 14414067 14:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:23 INFO - trying https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:23 INFO - Downloading https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/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 14:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/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 14:13:25 INFO - Downloaded 55740630 bytes. 14:13:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:25 INFO - mkdir: /builds/slave/test/properties 14:13:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:13:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:13:25 INFO - Contents: 14:13:25 INFO - build_url:https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:25 INFO - Running post-action listener: _resource_record_post_action 14:13:25 INFO - Running post-action listener: set_extra_try_arguments 14:13:25 INFO - [mozharness: 2016-09-28 21:13:25.762628Z] Finished download-and-extract step (success) 14:13:25 INFO - [mozharness: 2016-09-28 21:13:25.762854Z] Running populate-webroot step. 14:13:25 INFO - Running pre-action listener: _resource_record_pre_action 14:13:25 INFO - Running main action method: populate_webroot 14:13:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:13:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:13:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:13:25 INFO - '--tppagecycles', 14:13:25 INFO - '7'], 14:13:25 INFO - 'tests': ['tsvgm']}}, 14:13:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:13:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:13:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:13:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:13:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['damp', 'tps']}, 14:13:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'tests': ['damp', 'tps']}, 14:13:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['dromaeo_dom']}, 14:13:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:13:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['basic_compositor_video']}, 14:13:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:13:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['a11yr', 14:13:25 INFO - 'ts_paint', 14:13:25 INFO - 'tpaint', 14:13:25 INFO - 'sessionrestore', 14:13:25 INFO - 'sessionrestore_no_auto_restore', 14:13:25 INFO - 'tabpaint']}, 14:13:25 INFO - 'other-e10s': {'tests': ['a11yr', 14:13:25 INFO - 'ts_paint', 14:13:25 INFO - 'tpaint', 14:13:25 INFO - 'sessionrestore', 14:13:25 INFO - 'sessionrestore_no_auto_restore', 14:13:25 INFO - 'tabpaint']}, 14:13:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:13:25 INFO - 'ts_paint', 14:13:25 INFO - 'tpaint', 14:13:25 INFO - 'sessionrestore', 14:13:25 INFO - 'sessionrestore_no_auto_restore', 14:13:25 INFO - 'tabpaint']}, 14:13:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:13:25 INFO - 'ts_paint', 14:13:25 INFO - 'tpaint', 14:13:25 INFO - 'sessionrestore', 14:13:25 INFO - 'sessionrestore_no_auto_restore', 14:13:25 INFO - 'tabpaint']}, 14:13:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['a11yr', 14:13:25 INFO - 'ts_paint', 14:13:25 INFO - 'tpaint', 14:13:25 INFO - 'sessionrestore', 14:13:25 INFO - 'sessionrestore_no_auto_restore', 14:13:25 INFO - 'tabpaint']}, 14:13:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['a11yr', 14:13:25 INFO - 'ts_paint', 14:13:25 INFO - 'tpaint', 14:13:25 INFO - 'sessionrestore', 14:13:25 INFO - 'sessionrestore_no_auto_restore', 14:13:25 INFO - 'tabpaint']}, 14:13:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['tsvgx', 14:13:25 INFO - 'tsvgr_opacity', 14:13:25 INFO - 'tart', 14:13:25 INFO - 'tscrollx', 14:13:25 INFO - 'cart']}, 14:13:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:13:25 INFO - 'tsvgr_opacity', 14:13:25 INFO - 'tart', 14:13:25 INFO - 'tscrollx', 14:13:25 INFO - 'cart']}, 14:13:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'talos_options': ['--disable-e10s'], 14:13:25 INFO - 'tests': ['tp5o']}, 14:13:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'tests': ['tp5o']}, 14:13:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'talos_options': ['--disable-e10s', 14:13:25 INFO - '--xperf_path', 14:13:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:25 INFO - 'tests': ['tp5n']}, 14:13:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:25 INFO - 'talos_options': ['--xperf_path', 14:13:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:25 INFO - 'tests': ['tp5n']}}, 14:13:25 INFO - 'talos.zip': {'path': '', 14:13:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:13:25 INFO - Running post-action listener: _resource_record_post_action 14:13:25 INFO - [mozharness: 2016-09-28 21:13:25.779479Z] Finished populate-webroot step (success) 14:13:25 INFO - [mozharness: 2016-09-28 21:13:25.779567Z] Running create-virtualenv step. 14:13:25 INFO - Running pre-action listener: _resource_record_pre_action 14:13:25 INFO - Running main action method: create_virtualenv 14:13:25 INFO - Creating virtualenv /builds/slave/test/build/venv 14:13:25 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 14:13:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:13:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:13:25 INFO - Using real prefix '/usr' 14:13:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:13:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:13:28 INFO - Installing pip.................done. 14:13:28 INFO - Return code: 0 14:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:13:28 INFO - Reading from file tmpfile_stdout 14:13:28 INFO - Output received: 14:13:28 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) 14:13:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:28 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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:28 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 14:13:28 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 14:13:28 INFO - Using env: {'DISPLAY': ':0', 14:13:28 INFO - 'HOME': '/home/cltbld', 14:13:28 INFO - 'LANG': 'en_US.UTF-8', 14:13:28 INFO - 'LANGUAGE': 'en_US:en', 14:13:28 INFO - 'LOGNAME': 'cltbld', 14:13:28 INFO - 'MAIL': '/var/mail/cltbld', 14:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:28 INFO - 'MOZ_NO_REMOTE': '1', 14:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:28 INFO - 'NO_EM_RESTART': '1', 14:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:28 INFO - 'PWD': '/builds/slave/test', 14:13:28 INFO - 'SHELL': '/bin/bash', 14:13:28 INFO - 'SHLVL': '1', 14:13:28 INFO - 'TERM': 'linux', 14:13:28 INFO - 'TMOUT': '86400', 14:13:28 INFO - 'USER': 'cltbld', 14:13:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:28 INFO - '_': '/tools/buildbot/bin/python'} 14:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:28 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 14:13:28 INFO - Cleaning up... 14:13:28 INFO - Return code: 0 14:13:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:28 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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:28 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 14:13:28 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 14:13:28 INFO - Using env: {'DISPLAY': ':0', 14:13:28 INFO - 'HOME': '/home/cltbld', 14:13:28 INFO - 'LANG': 'en_US.UTF-8', 14:13:28 INFO - 'LANGUAGE': 'en_US:en', 14:13:28 INFO - 'LOGNAME': 'cltbld', 14:13:28 INFO - 'MAIL': '/var/mail/cltbld', 14:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:28 INFO - 'MOZ_NO_REMOTE': '1', 14:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:28 INFO - 'NO_EM_RESTART': '1', 14:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:28 INFO - 'PWD': '/builds/slave/test', 14:13:28 INFO - 'SHELL': '/bin/bash', 14:13:28 INFO - 'SHLVL': '1', 14:13:28 INFO - 'TERM': 'linux', 14:13:28 INFO - 'TMOUT': '86400', 14:13:28 INFO - 'USER': 'cltbld', 14:13:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:28 INFO - '_': '/tools/buildbot/bin/python'} 14:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:28 INFO - Downloading/unpacking psutil>=3.1.1 14:13:28 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 14:13:28 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 14:13:28 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 14:13:28 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 14:13:28 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 14:13:28 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 14:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:31 INFO - Installing collected packages: psutil 14:13:31 INFO - Running setup.py install for psutil 14:13:31 INFO - building 'psutil._psutil_linux' extension 14:13:31 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 14:13:31 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 14:13:31 INFO - building 'psutil._psutil_posix' extension 14:13:31 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 14:13:31 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 14:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:31 INFO - Successfully installed psutil 14:13:31 INFO - Cleaning up... 14:13:31 INFO - Return code: 0 14:13:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:13:31 INFO - Using env: {'DISPLAY': ':0', 14:13:31 INFO - 'HOME': '/home/cltbld', 14:13:31 INFO - 'LANG': 'en_US.UTF-8', 14:13:31 INFO - 'LANGUAGE': 'en_US:en', 14:13:31 INFO - 'LOGNAME': 'cltbld', 14:13:31 INFO - 'MAIL': '/var/mail/cltbld', 14:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:31 INFO - 'MOZ_NO_REMOTE': '1', 14:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:31 INFO - 'NO_EM_RESTART': '1', 14:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:31 INFO - 'PWD': '/builds/slave/test', 14:13:31 INFO - 'SHELL': '/bin/bash', 14:13:31 INFO - 'SHLVL': '1', 14:13:31 INFO - 'TERM': 'linux', 14:13:31 INFO - 'TMOUT': '86400', 14:13:31 INFO - 'USER': 'cltbld', 14:13:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:31 INFO - '_': '/tools/buildbot/bin/python'} 14:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:13:33 INFO - Installing collected packages: mozsystemmonitor 14:13:33 INFO - Running setup.py install for mozsystemmonitor 14:13:33 INFO - Successfully installed mozsystemmonitor 14:13:33 INFO - Cleaning up... 14:13:33 INFO - Return code: 0 14:13:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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', '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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:13: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 jsonschema==2.5.1 14:13:33 INFO - Using env: {'DISPLAY': ':0', 14:13:33 INFO - 'HOME': '/home/cltbld', 14:13:33 INFO - 'LANG': 'en_US.UTF-8', 14:13:33 INFO - 'LANGUAGE': 'en_US:en', 14:13:33 INFO - 'LOGNAME': 'cltbld', 14:13:33 INFO - 'MAIL': '/var/mail/cltbld', 14:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:33 INFO - 'MOZ_NO_REMOTE': '1', 14:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:33 INFO - 'NO_EM_RESTART': '1', 14:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:33 INFO - 'PWD': '/builds/slave/test', 14:13:33 INFO - 'SHELL': '/bin/bash', 14:13:33 INFO - 'SHLVL': '1', 14:13:33 INFO - 'TERM': 'linux', 14:13:33 INFO - 'TMOUT': '86400', 14:13:33 INFO - 'USER': 'cltbld', 14:13:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:33 INFO - '_': '/tools/buildbot/bin/python'} 14:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:34 INFO - Downloading/unpacking jsonschema==2.5.1 14:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:13:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:13:35 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 14:13:35 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 14:13:35 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 14:13:35 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 14:13:35 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 14:13:35 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 14:13:36 INFO - Downloading functools32-3.2.3-2.tar.gz 14:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:13:36 INFO - warning: no files found matching '*.txt' 14:13:36 INFO - no previously-included directories found matching 'build' 14:13:36 INFO - no previously-included directories found matching 'dist' 14:13:36 INFO - no previously-included directories found matching '.git*' 14:13:36 INFO - Installing collected packages: jsonschema, functools32 14:13:36 INFO - Running setup.py install for functools32 14:13:36 INFO - warning: no files found matching '*.txt' 14:13:36 INFO - no previously-included directories found matching 'build' 14:13:36 INFO - no previously-included directories found matching 'dist' 14:13:36 INFO - no previously-included directories found matching '.git*' 14:13:36 INFO - Successfully installed jsonschema functools32 14:13:36 INFO - Cleaning up... 14:13:36 INFO - Return code: 0 14:13:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:13:36 INFO - Using env: {'DISPLAY': ':0', 14:13:36 INFO - 'HOME': '/home/cltbld', 14:13:36 INFO - 'LANG': 'en_US.UTF-8', 14:13:36 INFO - 'LANGUAGE': 'en_US:en', 14:13:36 INFO - 'LOGNAME': 'cltbld', 14:13:36 INFO - 'MAIL': '/var/mail/cltbld', 14:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:36 INFO - 'MOZ_NO_REMOTE': '1', 14:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:36 INFO - 'NO_EM_RESTART': '1', 14:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:36 INFO - 'PWD': '/builds/slave/test', 14:13:36 INFO - 'SHELL': '/bin/bash', 14:13:36 INFO - 'SHLVL': '1', 14:13:36 INFO - 'TERM': 'linux', 14:13:36 INFO - 'TMOUT': '86400', 14:13:36 INFO - 'USER': 'cltbld', 14:13:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:36 INFO - '_': '/tools/buildbot/bin/python'} 14:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:13:36 INFO - Cleaning up... 14:13:36 INFO - Return code: 0 14:13:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:13:36 INFO - Using env: {'DISPLAY': ':0', 14:13:36 INFO - 'HOME': '/home/cltbld', 14:13:36 INFO - 'LANG': 'en_US.UTF-8', 14:13:36 INFO - 'LANGUAGE': 'en_US:en', 14:13:36 INFO - 'LOGNAME': 'cltbld', 14:13:36 INFO - 'MAIL': '/var/mail/cltbld', 14:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:36 INFO - 'MOZ_NO_REMOTE': '1', 14:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:36 INFO - 'NO_EM_RESTART': '1', 14:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:36 INFO - 'PWD': '/builds/slave/test', 14:13:36 INFO - 'SHELL': '/bin/bash', 14:13:36 INFO - 'SHLVL': '1', 14:13:36 INFO - 'TERM': 'linux', 14:13:36 INFO - 'TMOUT': '86400', 14:13:36 INFO - 'USER': 'cltbld', 14:13:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:36 INFO - '_': '/tools/buildbot/bin/python'} 14:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:36 INFO - Downloading/unpacking blobuploader==1.2.4 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13:38 INFO - Downloading blobuploader-1.2.4.tar.gz 14:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:13:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:13:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:39 INFO - Downloading docopt-0.6.1.tar.gz 14:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:13:39 INFO - Installing collected packages: blobuploader, requests, docopt 14:13:39 INFO - Running setup.py install for blobuploader 14:13:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:13:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:13:39 INFO - Running setup.py install for requests 14:13:40 INFO - Running setup.py install for docopt 14:13:40 INFO - Successfully installed blobuploader requests docopt 14:13:40 INFO - Cleaning up... 14:13:40 INFO - Return code: 0 14:13:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:40 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')]} 14:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:40 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')]} 14:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:40 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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:40 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 14:13:40 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 14:13:40 INFO - Using env: {'DISPLAY': ':0', 14:13:40 INFO - 'HOME': '/home/cltbld', 14:13:40 INFO - 'LANG': 'en_US.UTF-8', 14:13:40 INFO - 'LANGUAGE': 'en_US:en', 14:13:40 INFO - 'LOGNAME': 'cltbld', 14:13:40 INFO - 'MAIL': '/var/mail/cltbld', 14:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:40 INFO - 'MOZ_NO_REMOTE': '1', 14:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:40 INFO - 'NO_EM_RESTART': '1', 14:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:40 INFO - 'PWD': '/builds/slave/test', 14:13:40 INFO - 'SHELL': '/bin/bash', 14:13:40 INFO - 'SHLVL': '1', 14:13:40 INFO - 'TERM': 'linux', 14:13:40 INFO - 'TMOUT': '86400', 14:13:40 INFO - 'USER': 'cltbld', 14:13:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:40 INFO - '_': '/tools/buildbot/bin/python'} 14:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:40 INFO - Running setup.py (path:/tmp/pip-DFAZJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:40 INFO - Running setup.py (path:/tmp/pip-uXO66T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:40 INFO - Running setup.py (path:/tmp/pip-ZbmPOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:40 INFO - Running setup.py (path:/tmp/pip-voBqp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:40 INFO - Running setup.py (path:/tmp/pip-p4ALMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:40 INFO - Running setup.py (path:/tmp/pip-E_Czv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:40 INFO - Running setup.py (path:/tmp/pip-pm6vNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:40 INFO - Running setup.py (path:/tmp/pip-izg856-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:41 INFO - Running setup.py (path:/tmp/pip-NhbfOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:41 INFO - Running setup.py (path:/tmp/pip-V8nGdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:41 INFO - Running setup.py (path:/tmp/pip-eoY0dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:41 INFO - Running setup.py (path:/tmp/pip-pavtDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:41 INFO - Running setup.py (path:/tmp/pip-VuUOvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:13:41 INFO - Running setup.py (path:/tmp/pip-S2uyeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:41 INFO - Running setup.py (path:/tmp/pip-FKkzru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:13:41 INFO - Running setup.py (path:/tmp/pip-9DbqxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:13:41 INFO - Running setup.py (path:/tmp/pip-fJh7WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:13:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:13:41 INFO - Running setup.py install for manifestparser 14:13:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:13:41 INFO - Running setup.py install for mozcrash 14:13:41 INFO - Running setup.py install for mozdebug 14:13:41 INFO - Running setup.py install for mozdevice 14:13:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for mozfile 14:13:42 INFO - Running setup.py install for mozhttpd 14:13:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for mozinfo 14:13:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for mozInstall 14:13:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for mozleak 14:13:42 INFO - Running setup.py install for mozlog 14:13:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for moznetwork 14:13:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for mozprocess 14:13:42 INFO - Running setup.py install for mozprofile 14:13:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:13:42 INFO - Running setup.py install for mozrunner 14:13:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:13:43 INFO - Running setup.py install for mozscreenshot 14:13:43 INFO - Running setup.py install for moztest 14:13:43 INFO - Running setup.py install for mozversion 14:13:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:13:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:13:43 INFO - Cleaning up... 14:13:43 INFO - Return code: 0 14:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:43 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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:43 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 14:13:43 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 14:13:43 INFO - Using env: {'DISPLAY': ':0', 14:13:43 INFO - 'HOME': '/home/cltbld', 14:13:43 INFO - 'LANG': 'en_US.UTF-8', 14:13:43 INFO - 'LANGUAGE': 'en_US:en', 14:13:43 INFO - 'LOGNAME': 'cltbld', 14:13:43 INFO - 'MAIL': '/var/mail/cltbld', 14:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:43 INFO - 'MOZ_NO_REMOTE': '1', 14:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:43 INFO - 'NO_EM_RESTART': '1', 14:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:43 INFO - 'PWD': '/builds/slave/test', 14:13:43 INFO - 'SHELL': '/bin/bash', 14:13:43 INFO - 'SHLVL': '1', 14:13:43 INFO - 'TERM': 'linux', 14:13:43 INFO - 'TMOUT': '86400', 14:13:43 INFO - 'USER': 'cltbld', 14:13:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:43 INFO - '_': '/tools/buildbot/bin/python'} 14:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:43 INFO - Running setup.py (path:/tmp/pip-xbdYzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:43 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)) 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:43 INFO - Running setup.py (path:/tmp/pip-baXHoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:43 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)) 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:43 INFO - Running setup.py (path:/tmp/pip-rffldm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:43 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)) 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:43 INFO - Running setup.py (path:/tmp/pip-sv85HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:43 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)) 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:43 INFO - Running setup.py (path:/tmp/pip-4E5cWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:44 INFO - Running setup.py (path:/tmp/pip-LrqY6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:44 INFO - Running setup.py (path:/tmp/pip-LnCual-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:44 INFO - Running setup.py (path:/tmp/pip-DK_xmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:44 INFO - Running setup.py (path:/tmp/pip-8fsddr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:44 INFO - Running setup.py (path:/tmp/pip-eZD5XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:44 INFO - Running setup.py (path:/tmp/pip-n1zt1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:44 INFO - Running setup.py (path:/tmp/pip-SqRqdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:44 INFO - Running setup.py (path:/tmp/pip-5KFHXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:13:44 INFO - Running setup.py (path:/tmp/pip-Pthx1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:44 INFO - Running setup.py (path:/tmp/pip-V3FwnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:13:44 INFO - Running setup.py (path:/tmp/pip-i06xbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:13:44 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)) 14:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:13:44 INFO - Running setup.py (path:/tmp/pip-jmuKCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:13:44 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)) 14:13:44 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)) 14:13:44 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)) 14:13:44 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)) 14:13:44 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)) 14:13:44 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)) 14:13:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:46 INFO - Downloading blessings-1.6.tar.gz 14:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:13:46 INFO - Installing collected packages: blessings 14:13:46 INFO - Running setup.py install for blessings 14:13:46 INFO - Successfully installed blessings 14:13:46 INFO - Cleaning up... 14:13:47 INFO - Return code: 0 14:13:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:47 INFO - Reading from file tmpfile_stdout 14:13:47 INFO - Current package versions: 14:13:47 INFO - argparse == 1.2.1 14:13:47 INFO - blessings == 1.6 14:13:47 INFO - blobuploader == 1.2.4 14:13:47 INFO - docopt == 0.6.1 14:13:47 INFO - functools32 == 3.2.3-2 14:13:47 INFO - jsonschema == 2.5.1 14:13:47 INFO - manifestparser == 1.1 14:13:47 INFO - mozInstall == 1.12 14:13:47 INFO - mozcrash == 0.17 14:13:47 INFO - mozdebug == 0.1 14:13:47 INFO - mozdevice == 0.48 14:13:47 INFO - mozfile == 1.2 14:13:47 INFO - mozhttpd == 0.7 14:13:47 INFO - mozinfo == 0.9 14:13:47 INFO - mozleak == 0.1 14:13:47 INFO - mozlog == 3.4 14:13:47 INFO - moznetwork == 0.27 14:13:47 INFO - mozprocess == 0.23 14:13:47 INFO - mozprofile == 0.28 14:13:47 INFO - mozrunner == 6.12 14:13:47 INFO - mozscreenshot == 0.1 14:13:47 INFO - mozsystemmonitor == 0.3 14:13:47 INFO - moztest == 0.7 14:13:47 INFO - mozversion == 1.4 14:13:47 INFO - psutil == 3.1.1 14:13:47 INFO - requests == 1.2.3 14:13:47 INFO - wsgiref == 0.1.2 14:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:47 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')]} 14:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:47 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')]} 14:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:47 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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:47 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 14:13:47 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 14:13:47 INFO - Using env: {'DISPLAY': ':0', 14:13:47 INFO - 'HOME': '/home/cltbld', 14:13:47 INFO - 'LANG': 'en_US.UTF-8', 14:13:47 INFO - 'LANGUAGE': 'en_US:en', 14:13:47 INFO - 'LOGNAME': 'cltbld', 14:13:47 INFO - 'MAIL': '/var/mail/cltbld', 14:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:47 INFO - 'MOZ_NO_REMOTE': '1', 14:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:47 INFO - 'NO_EM_RESTART': '1', 14:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:47 INFO - 'PWD': '/builds/slave/test', 14:13:47 INFO - 'SHELL': '/bin/bash', 14:13:47 INFO - 'SHLVL': '1', 14:13:47 INFO - 'TERM': 'linux', 14:13:47 INFO - 'TMOUT': '86400', 14:13:47 INFO - 'USER': 'cltbld', 14:13:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:47 INFO - '_': '/tools/buildbot/bin/python'} 14:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 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)) 14:13:47 INFO - Cleaning up... 14:13:47 INFO - Return code: 0 14:13:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:13:47 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')]} 14:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:47 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')]} 14:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:47 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 0x7f2119a16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', '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 14:13:47 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 14:13:47 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 14:13:47 INFO - Using env: {'DISPLAY': ':0', 14:13:47 INFO - 'HOME': '/home/cltbld', 14:13:47 INFO - 'LANG': 'en_US.UTF-8', 14:13:47 INFO - 'LANGUAGE': 'en_US:en', 14:13:47 INFO - 'LOGNAME': 'cltbld', 14:13:47 INFO - 'MAIL': '/var/mail/cltbld', 14:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:47 INFO - 'MOZ_NO_REMOTE': '1', 14:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:47 INFO - 'NO_EM_RESTART': '1', 14:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:47 INFO - 'PWD': '/builds/slave/test', 14:13:47 INFO - 'SHELL': '/bin/bash', 14:13:47 INFO - 'SHLVL': '1', 14:13:47 INFO - 'TERM': 'linux', 14:13:47 INFO - 'TMOUT': '86400', 14:13:47 INFO - 'USER': 'cltbld', 14:13:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:47 INFO - '_': '/tools/buildbot/bin/python'} 14:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:13:47 INFO - Cleaning up... 14:13:47 INFO - Return code: 0 14:13:47 INFO - Running post-action listener: _resource_record_post_action 14:13:47 INFO - Running post-action listener: _start_resource_monitoring 14:13:47 INFO - Starting resource monitoring. 14:13:47 INFO - [mozharness: 2016-09-28 21:13:47.779948Z] Finished create-virtualenv step (success) 14:13:47 INFO - [mozharness: 2016-09-28 21:13:47.780630Z] Running install step. 14:13:47 INFO - Running pre-action listener: _resource_record_pre_action 14:13:47 INFO - Running main action method: install 14:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:47 INFO - Reading from file tmpfile_stdout 14:13:47 INFO - Detecting whether we're running mozinstall >=1.0... 14:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:13:48 INFO - Reading from file tmpfile_stdout 14:13:48 INFO - Output received: 14:13:48 INFO - Usage: mozinstall [options] installer 14:13:48 INFO - Options: 14:13:48 INFO - -h, --help show this help message and exit 14:13:48 INFO - -d DEST, --destination=DEST 14:13:48 INFO - Directory to install application into. [default: 14:13:48 INFO - "/builds/slave/test"] 14:13:48 INFO - --app=APP Application being installed. [default: firefox] 14:13:48 INFO - mkdir: /builds/slave/test/build/application 14:13:48 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'] 14:13:48 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 14:14:04 INFO - Reading from file tmpfile_stdout 14:14:04 INFO - Output received: 14:14:04 INFO - /builds/slave/test/build/application/firefox/firefox 14:14:04 INFO - Running post-action listener: _resource_record_post_action 14:14:04 INFO - [mozharness: 2016-09-28 21:14:04.197456Z] Finished install step (success) 14:14:04 INFO - [mozharness: 2016-09-28 21:14:04.197701Z] Running run-tests step. 14:14:04 INFO - Running pre-action listener: _resource_record_pre_action 14:14:04 INFO - Running main action method: run_tests 14:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:14:04 INFO - Python 2.7.3 14:14:04 INFO - Return code: 0 14:14:04 INFO - grabbing minidump binary from tooltool 14:14:04 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')]} 14:14:04 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 0x2336f60>, '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 0x2337d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23381d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:14:04 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 14:14:04 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 14:14:04 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 14:14:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:14:04 INFO - Return code: 0 14:14:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:14:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:14:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:14:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:14:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:14:04 INFO - Using env: {'DISPLAY': ':0', 14:14:04 INFO - 'HOME': '/home/cltbld', 14:14:04 INFO - 'LANG': 'en_US.UTF-8', 14:14:04 INFO - 'LANGUAGE': 'en_US:en', 14:14:04 INFO - 'LOGNAME': 'cltbld', 14:14:04 INFO - 'MAIL': '/var/mail/cltbld', 14:14:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:14:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:04 INFO - 'MOZ_NO_REMOTE': '1', 14:14:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:04 INFO - 'NO_EM_RESTART': '1', 14:14:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:04 INFO - 'PWD': '/builds/slave/test', 14:14:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:14:04 INFO - 'SHELL': '/bin/bash', 14:14:04 INFO - 'SHLVL': '1', 14:14:04 INFO - 'TERM': 'linux', 14:14:04 INFO - 'TMOUT': '86400', 14:14:04 INFO - 'USER': 'cltbld', 14:14:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554', 14:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:04 INFO - '_': '/tools/buildbot/bin/python'} 14:14:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:14:04 INFO - mozversion application_buildid: 20160928124419 14:14:04 INFO - mozversion application_changeset: 7dac104b94dec3fa419b45683a9c76e7254896b0 14:14:04 INFO - mozversion application_display_name: Nightly 14:14:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:14:04 INFO - mozversion application_name: Firefox 14:14:04 INFO - mozversion application_remotingname: firefox 14:14:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:14:04 INFO - mozversion application_vendor: Mozilla 14:14:04 INFO - mozversion application_version: 52.0a1 14:14:04 INFO - mozversion platform_buildid: 20160928124419 14:14:04 INFO - mozversion platform_changeset: 7dac104b94dec3fa419b45683a9c76e7254896b0 14:14:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:14:04 INFO - mozversion platform_version: 52.0a1 14:14:04 INFO - using testdate: 1475097244 14:14:04 INFO - actual date: 1475097244 14:14:04 INFO - starting webserver on 'localhost:36373' 14:14:04 INFO - SUITE-START | Running 2 tests 14:14:04 INFO - TEST-START | dromaeo_css 14:14:04 INFO - operating with platform_type : linux_ 14:14:04 INFO - Initialising browser for dromaeo_css test... 14:14:04 INFO - TEST-INFO | started process 26267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpve11IX/profile http://localhost:36373/getInfo.html) 14:14:08 INFO - PROCESS | 26267 | __metrics Screen width/height:1600/1200 14:14:08 INFO - PROCESS | 26267 | colorDepth:24 14:14:08 INFO - PROCESS | 26267 | Browser inner width/height: 1024/697 14:14:08 INFO - PROCESS | 26267 | __metrics 14:14:09 INFO - PROCESS | 26267 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:14:09 INFO - PROCESS | 26267 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:14:10 INFO - PROCESS | 26267 | console.error: PushService: 14:14:10 INFO - PROCESS | 26267 | stateChangeProcessEnqueue: Error transitioning state 14:14:10 INFO - PROCESS | 26267 | UnknownError 14:14:10 INFO - TEST-INFO | 26267: exit 0 14:14:10 INFO - Browser initialized. 14:14:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:14:10 INFO - TEST-INFO | started process 26351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpve11IX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:23 INFO - PROCESS | 26351 | RSS: Main: 174821376 14:14:23 INFO - PROCESS | 26351 | 14:15:14 INFO - PROCESS | 26351 | 1475097314935 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] 14:17:27 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:36373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36373/tests/dromaeo/cssquery-ext.html) 14:17:28 INFO - PROCESS | 26351 | RSS: Main: 290983936 14:17:28 INFO - PROCESS | 26351 | 14:20:31 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:36373/tests/dromaeo/cssquery-ext.html (next: http://localhost:36373/tests/dromaeo/cssquery-jquery.html) 14:20:31 INFO - PROCESS | 26351 | RSS: Main: 274808832 14:20:31 INFO - PROCESS | 26351 | 14:23:33 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:36373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36373/tests/dromaeo/cssquery-mootools.html) 14:23:34 INFO - PROCESS | 26351 | RSS: Main: 222588928 14:23:34 INFO - PROCESS | 26351 | 14:26:36 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:36373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36373/tests/dromaeo/cssquery-prototype.html) 14:26:37 INFO - PROCESS | 26351 | RSS: Main: 221372416 14:26:37 INFO - PROCESS | 26351 | 14:29:40 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:36373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36373/tests/dromaeo/cssquery-yui.html) 14:29:41 INFO - PROCESS | 26351 | RSS: Main: 224583680 14:29:41 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | Cycle 1(1): loaded http://localhost:36373/tests/dromaeo/cssquery-yui.html (next: http://localhost:36373/tests/dromaeo/cssquery-dojo.html) 14:32:44 INFO - PROCESS | 26351 | RSS: Main: 311033856 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | __start_tp_report 14:32:44 INFO - PROCESS | 26351 | _x_x_mozilla_page_load 14:32:44 INFO - PROCESS | 26351 | _x_x_mozilla_page_load_details 14:32:44 INFO - PROCESS | 26351 | |i|pagename|runs| 14:32:44 INFO - PROCESS | 26351 | |0;dojo.html;2536.9746302536973;2552.540542702313;2585.8707064646765;2590.0675756727574;2604.8827802748874;4562.589366956973;4633.814647414099;4719.150552900476;4725.976370118153;4749.168895443297;4674.929876051862;4694.812207511704;4728.621710263179;4746.738929358884;4805.61555075594;4291.892702682427;4308.526062133163;4349.238883195444;4358.8474403395885;4376.037271800199;4375.9562404375865;4444.11117776446;4447.1995040892625;4455.576720211575;4463.575960283784;4289.506706728735;4370.147821174872;4375.278079116942;4400.977995110036;4483.237849565566;4254.851080212208;4256.042390462152;4287.485501739811;4307.052448461365;4378.233809083397;4225.704200705952;4228.725132866354;4237.894052648678;4281.914361712779;4317.654587633013;4593.977030114828;4598.977005114953;4631.907361852744;4635.351050852883;4665.906681866378;4914.8771280718265;4933.481984391623;4970.279309500138;4987.62592805541;5030.220315851049;5030.4215015272985;5035.420926593452;5073.162928116856;5084.567811736007;5085.415177254626;4721.3390125382475;4728.267118596623;4730.574248317668;4731.787069581877;4789.114013907473;5003.849884503471;5053.418856831438;5057.039162559102;5156.495726071727;5227.424983251839;4955.5044495550155;5001.949980500149;5009.849704508871;5071.391433027987;5072.746362681851;5076.314697515862;5078.898422031539;5081.3140226069745;5081.390233172043;5139.691618502902;5019.171836646912;5053.761828352077;5058.924116138261;5107.336046313955;5130.563902068291;4885.511448855157;4940.851774446773;4944.332515110486;4950.8267210647455;4987.850364489072;4233.661307095425;4235.53409124996;4278.657707383464;4282.486101667758;4293.184294983943;3728.067983004249;3729.8321575529167;3734.626537346244;3763.6048214937036;3777.490038844776;4259.318509038539;4305.095929854766;4307.569243075667;4324.740515569076;4363.781810909441;5022.773975171126;5061.240813877947;5064.5441910228255;5077.796888124508;5118.283440318359;4340.327249276367;4366.083122544302;4369.148016136886;4369.628581570539;4420.381146639473;4523.95476045242;4626.259798432235;4628.699134556243;4629.305604159335;4679.181143299977;4640.767961601839;4649.930251046237;4691.695039822401;4702;4727.149113159664;5070.518300761421;5073.822416215415;5073.974630126826;5074.391073071255;5122.564582010571;4690.437147542317;4693;4698.9530104698515;4743.1225223333795;4753.667243292936;4795.20879054966;4884.12085824555;4966.354373931365;4984.252362145708;5023.773930173078;5111.207762796773;5118.104331741856;5127.282180494659;5151.871203219949;5173.991071740975;4836.153673107263;4837.830675926326;4872.269159626085;4877.6829506081995;4915.3855768029;4711.458182309078;4750.477447480705;4759.3336932830125;4824.300476430968;4888.951110488992;4756.310335001474;4786.1624215762795;4797.880052998703;4826.251930950708;4844.903101938012;4772.809087636595;4882.731449770296;4886.486918873467;4896.2410826321975;4923.064617722621;4713.363695901009;4741.644376671695;4746.0745154694505;4761.4762376137905;4775.617950564016 14:32:44 INFO - PROCESS | 26351 | |1;ext.html;562.4459906991614;571.6027360984118;571.70557163061;573.480999695276;573.5182446744734;28029.859850700745;30728.84635576822;30803;37680.246395072085;38414;39894.401583976265;40350.59649403505;40452.19095618086;40468.59531404685;40510.18979620406;7580.090389153309;7719;7724.07311122666;7783.455158138932;7786;7609.0869095708595;7705.922940770604;7710.421718371116;7716.305532502074;7724;7744.651490682904;7756.689732410697;7773.183815699355;7776.611169441505;7778.261065198797;7686.423518236126;7718.807029824243;7719.575423351714;7728.343090837286;7737.72917947872;7641.503302285334;7702.768916932501;7708.537487750753;7708.922910770877;7709.807254818675;36830.4475432866;37148.257034859154;37163;37224.62775372239;37227.62772372269;2833;2894.1462268630803;2959.615250017484;3184.9044528663944;3465.3415850988486;28069.71930280712;28148.296292592644;28313.433731325258;28597.57103643447;31580.526292105405;3492.0571445709516;3534.4874993125854;3538.097785064818;3554.449060395643;3577.6780089791782;245393;245432;246122;246939;248064;52529.47470525246;52922.67693307698;52958.73520632372;53002.469975300526;53027.469725303024;31354;32351.676483235336;32394.190145246084;34179.316413671586;34253.657463425545;13885.791713124312;13915.721685566434;13941.372638231303;13950.162990220619;13973.09174903628;10486.947565262124;10580.947095264475;10606.257561970742;10617;10617.097546708615;17303.91348043252;17312.567185820204;17406.651866962842;17414.39049633282;17505.912470437564;6762.222344430355;6807.591544507345;6868.519203655696;6877.518573699793;6971.198312194061;762.5500954436798;846.4794151596724;863.6415887406656;903.9728808135767;920.3695468604028;25630.74369256321;27089.1873243803;27257.727422725915;28117.859410703226;28123.718762812518;892.7589550821242;909.7043460875242;913.3789023464108;916.9954150229339;938.5964035464816;14085.295735213198;14374.640633984025;14627.8947316132;14765.48320808788;14826;365217;368351;368510;369831;371042;47769.76115119402;48147.27779083316;48259.5174048255;48290.5170948286;48300;1024.948752562369;1083.3012706803909;1083.6586475260426;1144.0961640304233;1175.735459521601;27028.864855675594;28068.71931280661;29381.85309073441;30386;31666.841665791522;45887.54112458833;46569.30146047744;46592.53407465882;46609;46664;350472;353698;354117;354646;355296.91733908735;36497.63502365049;36582.59804534142;37167.6283237175;37243.62756372402;37286.813565931996;40304.59695403009;40912;40966.1806763869;41535.376969346085;41606.37590436085;34300.14249643779;34672.30655386828;34728.826355868056;34904.65095349014;34959.65040349666;34704.65295347014;34992.65007349996;35043.64956350404;35192.64807351894;35217.47173792446;25482.872585636953;30339.544906825973;30639.2340191497;35057.82471087628;35390;28027.85986070138;32207.677923221407;32359.776959831463;32477;32594.51108233331;23909;24922.626160607244;24963.375915602257;25074.49851002933;25425 14:32:44 INFO - PROCESS | 26351 | |2;jquery.html;344.796570023686;349.47055211354797;350.3850741947883;361.391056070521;367.2434784344251;15659.530214093582;15826.050436973776;16740.330386784528;16841.326346946138;16979.83020169801;14456.349464274106;15125.470608528703;15207.46773862915;15456.381744730197;15820.920895395508;4545.704529205607;4749.548792864673;5078.5175408336145;5097.541221290083;5103.821366252182;4980.726060066695;5037.5214354636255;5044.2937988681615;5046.798128074873;5049.141645920184;4827.300041493982;4928.457869634337;4937.481564435737;4959.305697202394;5029.1199040168;4533.614642755353;4561.29299958507;4569.948911750299;4571.3600095986585;4572.382728331682;4122.113745544692;4168.645665118469;4175.185838761443;4361.389405483234;4481.229914183879;12223.816642750366;12241.571544995972;12384.8142277865;12409.75180496385;12413.131080824345;1743.1894169211378;1746.0745804723517;1805.3230038735473;1879.1543805287674;1882.7552418185685;9003.234725048378;9223.584938677775;9224.123708247706;9404.05959404061;9540.713778586654;1662.5095596798974;1676.79040119985;1695.9745603815952;1760.6654735600323;1805.0794095011508;63156.68421657862;63195;63343.29910308094;63484.682576587285;63877.68061159665;8030.678772849021;8517.318614510825;8521.57392130391;8654.87017694735;9815.263855210746;10760.838587421194;10815.459227038617;10817;10843.240973131962;10844.783104337868;6293.905591416133;6445.355464453611;6485.967570162119;6596.208454985433;6634.601923884582;6455.677216139175;6471.320511346335;6667.499937504706;6669;6711.261761206263;3288.8848890288723;3429.763505497105;3446.638102999199;3452.6202117767025;3478.617352091268;1667.1330907927809;1721.5782133377402;1734.3582874336576;1759.894406335624;1785.8392744653045;825.9297959673495;833.5123952487742;858.9141085891486;897.3354427536956;940.5062342270363;16195.514134575982;16468.341266349453;16571.25429355682;16736.414225502293;17428.82571174272;839.9706010289733;843.4812590256947;856.0412338181277;877.929765618749;927.452802846324;8997.955010225038;9494.667686630935;9572.282078844115;9605.855912161323;9685.370450920667;357417;363070;368723;370425;371454;77305.61347193229;78074.21925780782;78377;81199;82347.41314671333;848.1476116502876;866.3112825303898;910.8314961732101;919.2232563483846;923.7459698582809;14125;14925.776113358526;15661.37354505807;16004.87782936582;17082.829171708123;38229.61770382261;38311.23377532378;39367.80316098401;39612.60387396089;40647;50346.244806328665;50918;50953.745231273606;51231;51301;6309;6521.608703477807;6861.176658800976;6955.721771129098;7078.433725302067;8919.910800891908;11479.598214062467;11631;11855.110866684861;11881.287122772661;9828.4102953823;9962.452065136487;10216.233782466195;10229.43738094412;10251.077403033763;4782.736949467673;6261.874762504815;9902.653407130716;10276;10316.865144833911;9741.561629726537;9775.560099795384;10005;10162.695119146438;10285.2800303978;6431.935680643133;6940.930590694028;7137.1435427749;7180.640967951686;7346.191918888811;8846.443581000673;10114.797704046025;10136.746581335525;10281.897181028095;10552.630657926935 14:32:44 INFO - PROCESS | 26351 | |3;mootools.html;1227.6562562482497;1345.8115863779067;1376.2499437806393;1423.6298562373786;1680.8403201695842;6343.587666801661;7109.537880037794;7314;7349.338559529635;7567.962160189205;7346.228645992161;7400.333969942704;7411.110666719987;7419.295166959144;7419.888701669466;2031.918723251072;2039.9796002039939;2041.6018876319124;2049.3442098528476;2055.8869262190574;2026.6048120616485;2044.8364130869495;2050.364387040015;2069.368842503036;2070.5858828234336;2052.7126202331688;2053.4147767886157;2057.341650671786;2058.9176432942663;2061.4846288427893;2045.2125931516325;2052.8768273903615;2053.1376821734907;2053.774084850665;2055.1676570988775;1960.0591715976411;1975.8518111141723;1988.67186914159;1992;1993.6810110382269;7112.110986126734;7306.525075870051;7497.212792656747;7602.657880395395;7603.7718868433485;4244.045089854789;4422.601965823092;4427.535108813592;4431.180231657154;4434.578715022068;2771.794269492757;2909.141803168049;2947.3957838643028;2959.215807810932;2965.644122705268;983.3657291047234;985.9211263098935;999.8550210219478;1002.1531805624236;1013.5084484025242;9287.674931377369;9290.72127836166;9327.11392417726;9396.248300135972;9400.62397504099;3615.6565126312958;3672.2839046385698;3747.512823333004;3810.599887011879;3851.056491159628;7622.199669034782;7625.6568454419685;7630.847383052308;7637.15991240963;7641.694332226649;4242.936355954663;4243.8090285937205;4245.61789438952;4246.639035682002;4246.766427846498;3464.2205503761957;3496.2483066140394;3597.5323207982797;3975.1453437510495;3980.5820388859333;2935.1488068460335;3302.653221411765;3326.1185785766793;3330.533725278463;3345.7825241359233;976.1068622210598;1018.9643362482277;1021.2391768132788;1027.2552399510444;1031.7730099378125;696.9024336592881;804.2359758229705;819.2626636027504;825.9008918929646;841.9536925469158;4937.7777999990085;5056.84829455117;5063.164577844688;5183.896322073538;5296.947030529645;377.8620803406737;383.93856982883165;384.33126360133724;388.76673995602414;396.1621171222843;3227.322262324891;3342.08092774489;3357.1942733744213;3361.8487168077495;3436.1581412554083;8941.687040953535;9299.256059515357;9382.812343753087;9409.153176214173;9411.482368469662;9271.814563708687;9274.165325120772;9353.579088941015;9376.578053987587;9378.249740020781;7052.823679407953;7092.538984966064;7131.072960515204;7134.143902731602;7135.215126336099;4768.809247630056;4910.729909854992;4950.851474455772;4963.280324353021;5088.491150884882;8460;8473.57632118404;8634.438761480484;8649.654013839376;8678.82642347162;7879.921200787919;8617.784555386166;8825.955870220865;8835.33734969867;8877.511736854534;5465.699386533779;5980.730867111078;6193.938060619516;6195.628262304276;6332;7199.604021778852;7213.495055346076;7264.418846492374;7268.636568171464;7278.454115941219;6580.440662543738;6604.438622717123;6720.764773232913;6725.798226053226;6759.729610815512;6424.775132870327;6542.313057128933;6542.771003014872;6576.671166441754;6625.271220165681;6033.155358249761;6063.151158837854;6145.293291271561;6193.194884664965;6214.067889816563;4324;4347.978260108805;4410.470743510799;4437.290033594739;4486.484054333793;4587.311903214544;4594.517575654641;4625.259958406638;4718.103560323528;4734.952650473451 14:32:44 INFO - PROCESS | 26351 | |4;prototype.html;286.6259531311637;291.2238883375804;295.2971926814182;297.1057118074595;300.30779054279884;4792.209285467902;4797.784099715513;4820.228763397857;4824;4824.1316563018645;4715.269133284346;4718.57532822046;4756.38398880616;4758.2862570614425;4763.714177149365;3743.5320584926885;3756.192418629994;3756.69946404287;3761.755485893422;3762.9811850940705;3650.8357123929354;3763.397856342972;3778.716596255278;3810.5998870118656;3822.7132965027595;3740.45763364312;3742.401215805458;3760.0787806987328;3764.6235376462273;3785.413260944558;3726.8384337084426;3728.6084961079237;3738.3831667774784;3747.6627103560672;3753.2305877295225;3096.380723855238;3318.4192766266046;3323.11937336606;3326.1518312830317;3331.1505566080737;4538.614217791492;4539.614132798716;4593.517680643517;4638.234691275969;4652.534746525354;4201.306784380604;4220.620144187038;4233.280342341778;4235.322348424268;4237.237297286487;4637.884052898671;4928.778204980748;4929.359183306147;4942.87642808929;4968.254761785725;3364.562606861117;3455.481677748333;3567.7502574819773;3600.981995090034;3609.8917032489067;5122.718250496221;5122.871928201825;5135.6918584885025;5140.9668295705715;5143.871403214912;3667.9816600916824;3674.540682414698;3682.606305901186;3691.4093745000673;3707.925841483155;3630.9092272692865;3724.65912271582;3725.906852328659;3742.794146321924;3770;4233.5131459882505;4241.130568233505;4245.936310955338;4247.3628955656895;4257.93428731313;4956.596050915303;4969.751512424365;4977.90044199114;4979.800807967641;5002.124628190052;1244.4897591987242;1297.6172029251393;1304.7847105227531;1316.6774140335679;1317.5059352742721;837.4933165434946;849.7068511363569;862.5557837713583;865.4071960706935;866.2204016385303;3886.0867696091395;3895.06598335683;3897.7661340319673;3952.8418863245147;3954.7429417087797;4448.888777780581;4453.332000199931;4454.732716037048;4499.77501124949;4513.232750432434;3904.5314562252142;3911.8435262589746;3911.9804400977814;3916.4712763777097;3958.6239307265764;2433.6349547568007;2443.1920378919826;2525.861077640711;2710.4037111835364;2732;4535;4758.857874110188;4760.166970780099;4776.665633405698;4783.736894470768;5067.97466012675;5098.260752190911;5109.897802043938;5112.821051263262;5230.895382092337;4753.524647535219;4770.185590501621;4775.283707443911;4782.665213435096;4786.856394308106;4988.201887697951;5109.492699653537;5116.2395639204415;5119.180931051014;5175.81884634036;4979.5269449403695;5025.145725226794;5028.547430731252;5049.065922804293;5070.366204224472;4743.596794272526;4759.524047595212;4769.879078416639;4806.2310030394965;4809.134355815987;3493.2010014841867;3589.2821435713486;3596.8021758803516;3599.8740044099377;3614.4457883110513;5041.269015992587;5072.61587054084;5075.720835353944;5084.694918304914;5091.694498330112;4848.3454733610515;4856.95143048565;4858.295547145573;4860.78126484302;4884.9511504884495;4611.723296602215;4852.102361063074;4862.027594481188;4869.6347773917805;4884.438289596742;4771.188897887437;4775.257031183663;4784.952150478451;4789.640776941813;4791.209450440778;4862.781174847069;4872.512748725099;4878.56092951636;4886.853394398174;4896.338994235733;4633.675642705113;4765.285207218945;4777.522247775334;4781;4783.497732738012 14:32:44 INFO - PROCESS | 26351 | |5;yui.html;645.7610684046901;664.2394458345192;666.8032930285565;671.9126513553238;784.2667106255651;12709.745805083892;13105.148165369244;13761.174329540223;13774.793378099337;13777.862221377809;13560.796588051187;13582.25297608631;13679.794803077937;13715.862841371583;13734.519291824789;605.9303180134275;617.7714245729087;739.3493725521547;757.3675980556242;762.9618519074052;729.773770131261;756.7237958145292;762.9084509858825;765.5521519910831;765.7013764631798;793.9047314322261;796.8127490039836;797.6689673785401;798.0901771979948;800.8318253166842;634.1882390540115;790.0164295452199;792.9048514178278;798.5767543202141;800.1238643685156;461.38405229018963;562.2437821130613;570.6576054367388;581.1979468333715;584.8742520358144;13099.476020959246;13119.344032798323;13131.343432828417;13138.737225255538;13149.21104733719;12359.938200308941;12617.432215550321;12975.480980760758;13134.408951597201;13292.40184191704;11902.761944761143;11945.343006134659;11955.760884782256;12483.937580312131;12640.178388404724;4108.322126849066;4111.342185250345;4172.5410204877435;4180.3102488089735;4257.638100761439;62822;63548;64614.35385646178;64655.3534464654;66124;9973.202143828476;10236.33463824864;10332.328398654063;10410.739731506774;10663.786724265627;19503.609927801364;19544.31594894172;19548.804511954982;19552.90223548873;19563.315283964992;6735.629540375228;6741.528093033538;6767.966160169168;6998.335158159966;7013.684384202723;3510.8946731598094;3673.8714145004797;3707.5550933887566;3717.4795528626014;3745.7752534847996;2683.195041487585;2762.033288349062;2763.1434255380495;2769.8338099714083;2771.362586605052;461.6560662306603;464.3638215644589;466.64534953435634;472.68094036525207;472.7777944366142;373.908392443853;447.9260921947842;471.7924113390166;489.47626040136714;508.5346907579523;7344.926550734531;7486.737964171337;7951.006124234471;8003.079645840687;8023.077346105156;434.9543297953669;473.3113320119218;478.72712553843974;490.2107606753125;542.4223202289628;3927.626875446828;3948.763074215556;4002.8598999034893;4148.875533733993;4149.8962525937095;57264.427355726744;57337.42662573404;57412;58460.70769646124;71512;85131;85265.14734852697;86959;89507.55246223728;91343.73552599453;77514.6124269375;78286.60856695793;78296.60851695706;79034.6048269755;79991.2000880007;6857.657117144223;7050.048243487064;7138.286171383028;7529.924700752922;7533.616225331925;40861.591384085776;41080.38379424371;42573.78713106415;42807.785961069996;43848.123037539706;40156;40560.79719601383;59695.40304596898;60537.09194362;65128.3948642049;8974;9201.171894529525;9317.39436936597;9527.809443811224;9857.35927164732;9861;10117.342372745748;10135.898641013791;10147.492625368553;10749;9308.674196403093;10071.546780394754;10097.697069087939;10196.490175491048;10591.682249532527;10898.400587967737;10917.23579349438;11186.10511159089;11482.36846973391;11576.430435257076;10349.643398523654;10848.132149428184;10903.236773425784;10976.286541374786;11078.113750899747;8507.659693612186;8518.275946544365;8685.088065753258;8788.340874434316;9545.952270238882;9564.187044101329;9693.563789629343;9804.705858824247;9830.557624906753;9929.304948653526 14:32:44 INFO - PROCESS | 26351 | __end_tp_report 14:32:44 INFO - PROCESS | 26351 | __start_cc_report 14:32:44 INFO - PROCESS | 26351 | _x_x_mozilla_cycle_collect,931 14:32:44 INFO - PROCESS | 26351 | __end_cc_report 14:32:44 INFO - PROCESS | 26351 | __startTimestamp1475098364597__endTimestamp 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | ------- Summary: start ------- 14:32:44 INFO - PROCESS | 26351 | Number of tests: 6 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | [#0] dojo.html Cycles:165 Average:4646.30 Median:4743.12 stddev:491.80 (10.4%) stddev-sans-first:464.64 14:32:44 INFO - PROCESS | 26351 | Values: 2537.0 2552.5 2585.9 2590.1 2604.9 4562.6 4633.8 4719.2 4726.0 4749.2 4674.9 4694.8 4728.6 4746.7 4805.6 4291.9 4308.5 4349.2 4358.8 4376.0 4376.0 4444.1 4447.2 4455.6 4463.6 4289.5 4370.1 4375.3 4401.0 4483.2 4254.9 4256.0 4287.5 4307.1 4378.2 4225.7 4228.7 4237.9 4281.9 4317.7 4594.0 4599.0 4631.9 4635.4 4665.9 4914.9 4933.5 4970.3 4987.6 5030.2 5030.4 5035.4 5073.2 5084.6 5085.4 4721.3 4728.3 4730.6 4731.8 4789.1 5003.8 5053.4 5057.0 5156.5 5227.4 4955.5 5001.9 5009.8 5071.4 5072.7 5076.3 5078.9 5081.3 5081.4 5139.7 5019.2 5053.8 5058.9 5107.3 5130.6 4885.5 4940.9 4944.3 4950.8 4987.9 4233.7 4235.5 4278.7 4282.5 4293.2 3728.1 3729.8 3734.6 3763.6 3777.5 4259.3 4305.1 4307.6 4324.7 4363.8 5022.8 5061.2 5064.5 5077.8 5118.3 4340.3 4366.1 4369.1 4369.6 4420.4 4524.0 4626.3 4628.7 4629.3 4679.2 4640.8 4649.9 4691.7 4702.0 4727.1 5070.5 5073.8 5074.0 5074.4 5122.6 4690.4 4693.0 4699.0 4743.1 4753.7 4795.2 4884.1 4966.4 4984.3 5023.8 5111.2 5118.1 5127.3 5151.9 5174.0 4836.2 4837.8 4872.3 4877.7 4915.4 4711.5 4750.5 4759.3 4824.3 4889.0 4756.3 4786.2 4797.9 4826.3 4844.9 4772.8 4882.7 4886.5 4896.2 4923.1 4713.4 4741.6 4746.1 4761.5 4775.6 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | [#1] ext.html Cycles:180 Average:47016.51 Median:179425.68 stddev:86242.30 (48.1%) stddev-sans-first:86413.71 14:32:44 INFO - PROCESS | 26351 | Values: 562.4 571.6 571.7 573.5 573.5 28029.9 30728.8 30803.0 37680.2 38414.0 39894.4 40350.6 40452.2 40468.6 40510.2 7580.1 7719.0 7724.1 7783.5 7786.0 7609.1 7705.9 7710.4 7716.3 7724.0 7744.7 7756.7 7773.2 7776.6 7778.3 7686.4 7718.8 7719.6 7728.3 7737.7 7641.5 7702.8 7708.5 7708.9 7709.8 36830.4 37148.3 37163.0 37224.6 37227.6 2833.0 2894.1 2959.6 3184.9 3465.3 28069.7 28148.3 28313.4 28597.6 31580.5 3492.1 3534.5 3538.1 3554.4 3577.7 245393.0 245432.0 246122.0 246939.0 248064.0 52529.5 52922.7 52958.7 53002.5 53027.5 31354.0 32351.7 32394.2 34179.3 34253.7 13885.8 13915.7 13941.4 13950.2 13973.1 10486.9 10580.9 10606.3 10617.0 10617.1 17303.9 17312.6 17406.7 17414.4 17505.9 6762.2 6807.6 6868.5 6877.5 6971.2 762.6 846.5 863.6 904.0 920.4 25630.7 27089.2 27257.7 28117.9 28123.7 892.8 909.7 913.4 917.0 938.6 14085.3 14374.6 14627.9 14765.5 14826.0 365217.0 368351.0 368510.0 369831.0 371042.0 47769.8 48147.3 48259.5 48290.5 48300.0 1024.9 1083.3 1083.7 1144.1 1175.7 27028.9 28068.7 29381.9 30386.0 31666.8 45887.5 46569.3 46592.5 46609.0 46664.0 350472.0 353698.0 354117.0 354646.0 355296.9 36497.6 36582.6 37167.6 37243.6 37286.8 40304.6 40912.0 40966.2 41535.4 41606.4 34300.1 34672.3 34728.8 34904.7 34959.7 34704.7 34992.7 35043.6 35192.6 35217.5 25482.9 30339.5 30639.2 35057.8 35390.0 28027.9 32207.7 32359.8 32477.0 32594.5 23909.0 24922.6 24963.4 25074.5 25425.0 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | [#2] jquery.html Cycles:180 Average:22930.65 Median:4571.87 stddev:60733.80 (1328.4%) stddev-sans-first:60880.49 14:32:44 INFO - PROCESS | 26351 | Values: 344.8 349.5 350.4 361.4 367.2 15659.5 15826.1 16740.3 16841.3 16979.8 14456.3 15125.5 15207.5 15456.4 15820.9 4545.7 4749.5 5078.5 5097.5 5103.8 4980.7 5037.5 5044.3 5046.8 5049.1 4827.3 4928.5 4937.5 4959.3 5029.1 4533.6 4561.3 4569.9 4571.4 4572.4 4122.1 4168.6 4175.2 4361.4 4481.2 12223.8 12241.6 12384.8 12409.8 12413.1 1743.2 1746.1 1805.3 1879.2 1882.8 9003.2 9223.6 9224.1 9404.1 9540.7 1662.5 1676.8 1696.0 1760.7 1805.1 63156.7 63195.0 63343.3 63484.7 63877.7 8030.7 8517.3 8521.6 8654.9 9815.3 10760.8 10815.5 10817.0 10843.2 10844.8 6293.9 6445.4 6486.0 6596.2 6634.6 6455.7 6471.3 6667.5 6669.0 6711.3 3288.9 3429.8 3446.6 3452.6 3478.6 1667.1 1721.6 1734.4 1759.9 1785.8 825.9 833.5 858.9 897.3 940.5 16195.5 16468.3 16571.3 16736.4 17428.8 840.0 843.5 856.0 877.9 927.5 8998.0 9494.7 9572.3 9605.9 9685.4 357417.0 363070.0 368723.0 370425.0 371454.0 77305.6 78074.2 78377.0 81199.0 82347.4 848.1 866.3 910.8 919.2 923.7 14125.0 14925.8 15661.4 16004.9 17082.8 38229.6 38311.2 39367.8 39612.6 40647.0 50346.2 50918.0 50953.7 51231.0 51301.0 6309.0 6521.6 6861.2 6955.7 7078.4 8919.9 11479.6 11631.0 11855.1 11881.3 9828.4 9962.5 10216.2 10229.4 10251.1 4782.7 6261.9 9902.7 10276.0 10316.9 9741.6 9775.6 10005.0 10162.7 10285.3 6431.9 6940.9 7137.1 7180.6 7346.2 8846.4 10114.8 10136.7 10281.9 10552.6 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | [#3] mootools.html Cycles:180 Average:4831.98 Median:5010.06 stddev:2716.21 (54.2%) stddev-sans-first:2710.32 14:32:44 INFO - PROCESS | 26351 | Values: 1227.7 1345.8 1376.2 1423.6 1680.8 6343.6 7109.5 7314.0 7349.3 7568.0 7346.2 7400.3 7411.1 7419.3 7419.9 2031.9 2040.0 2041.6 2049.3 2055.9 2026.6 2044.8 2050.4 2069.4 2070.6 2052.7 2053.4 2057.3 2058.9 2061.5 2045.2 2052.9 2053.1 2053.8 2055.2 1960.1 1975.9 1988.7 1992.0 1993.7 7112.1 7306.5 7497.2 7602.7 7603.8 4244.0 4422.6 4427.5 4431.2 4434.6 2771.8 2909.1 2947.4 2959.2 2965.6 983.4 985.9 999.9 1002.2 1013.5 9287.7 9290.7 9327.1 9396.2 9400.6 3615.7 3672.3 3747.5 3810.6 3851.1 7622.2 7625.7 7630.8 7637.2 7641.7 4242.9 4243.8 4245.6 4246.6 4246.8 3464.2 3496.2 3597.5 3975.1 3980.6 2935.1 3302.7 3326.1 3330.5 3345.8 976.1 1019.0 1021.2 1027.3 1031.8 696.9 804.2 819.3 825.9 842.0 4937.8 5056.8 5063.2 5183.9 5296.9 377.9 383.9 384.3 388.8 396.2 3227.3 3342.1 3357.2 3361.8 3436.2 8941.7 9299.3 9382.8 9409.2 9411.5 9271.8 9274.2 9353.6 9376.6 9378.2 7052.8 7092.5 7131.1 7134.1 7135.2 4768.8 4910.7 4950.9 4963.3 5088.5 8460.0 8473.6 8634.4 8649.7 8678.8 7879.9 8617.8 8826.0 8835.3 8877.5 5465.7 5980.7 6193.9 6195.6 6332.0 7199.6 7213.5 7264.4 7268.6 7278.5 6580.4 6604.4 6720.8 6725.8 6759.7 6424.8 6542.3 6542.8 6576.7 6625.3 6033.2 6063.2 6145.3 6193.2 6214.1 4324.0 4348.0 4410.5 4437.3 4486.5 4587.3 4594.5 4625.3 4718.1 4735.0 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | [#4] prototype.html Cycles:180 Average:4067.47 Median:4635.78 stddev:1169.33 (25.2%) stddev-sans-first:1137.66 14:32:44 INFO - PROCESS | 26351 | Values: 286.6 291.2 295.3 297.1 300.3 4792.2 4797.8 4820.2 4824.0 4824.1 4715.3 4718.6 4756.4 4758.3 4763.7 3743.5 3756.2 3756.7 3761.8 3763.0 3650.8 3763.4 3778.7 3810.6 3822.7 3740.5 3742.4 3760.1 3764.6 3785.4 3726.8 3728.6 3738.4 3747.7 3753.2 3096.4 3318.4 3323.1 3326.2 3331.2 4538.6 4539.6 4593.5 4638.2 4652.5 4201.3 4220.6 4233.3 4235.3 4237.2 4637.9 4928.8 4929.4 4942.9 4968.3 3364.6 3455.5 3567.8 3601.0 3609.9 5122.7 5122.9 5135.7 5141.0 5143.9 3668.0 3674.5 3682.6 3691.4 3707.9 3630.9 3724.7 3725.9 3742.8 3770.0 4233.5 4241.1 4245.9 4247.4 4257.9 4956.6 4969.8 4977.9 4979.8 5002.1 1244.5 1297.6 1304.8 1316.7 1317.5 837.5 849.7 862.6 865.4 866.2 3886.1 3895.1 3897.8 3952.8 3954.7 4448.9 4453.3 4454.7 4499.8 4513.2 3904.5 3911.8 3912.0 3916.5 3958.6 2433.6 2443.2 2525.9 2710.4 2732.0 4535.0 4758.9 4760.2 4776.7 4783.7 5068.0 5098.3 5109.9 5112.8 5230.9 4753.5 4770.2 4775.3 4782.7 4786.9 4988.2 5109.5 5116.2 5119.2 5175.8 4979.5 5025.1 5028.5 5049.1 5070.4 4743.6 4759.5 4769.9 4806.2 4809.1 3493.2 3589.3 3596.8 3599.9 3614.4 5041.3 5072.6 5075.7 5084.7 5091.7 4848.3 4857.0 4858.3 4860.8 4885.0 4611.7 4852.1 4862.0 4869.6 4884.4 4771.2 4775.3 4785.0 4789.6 4791.2 4862.8 4872.5 4878.6 4886.9 4896.3 4633.7 4765.3 4777.5 4781.0 4783.5 14:32:44 INFO - PROCESS | 26351 | 14:32:44 INFO - PROCESS | 26351 | [#5] yui.html Cycles:180 Average:16499.13 Median:484.10 stddev:22971.53 (4745.2%) stddev-sans-first:23005.13 14:32:44 INFO - PROCESS | 26351 | Values: 645.8 664.2 666.8 671.9 784.3 12709.7 13105.1 13761.2 13774.8 13777.9 13560.8 13582.3 13679.8 13715.9 13734.5 605.9 617.8 739.3 757.4 763.0 729.8 756.7 762.9 765.6 765.7 793.9 796.8 797.7 798.1 800.8 634.2 790.0 792.9 798.6 800.1 461.4 562.2 570.7 581.2 584.9 13099.5 13119.3 13131.3 13138.7 13149.2 12359.9 12617.4 12975.5 13134.4 13292.4 11902.8 11945.3 11955.8 12483.9 12640.2 4108.3 4111.3 4172.5 4180.3 4257.6 62822.0 63548.0 64614.4 64655.4 66124.0 9973.2 10236.3 10332.3 10410.7 10663.8 19503.6 19544.3 19548.8 19552.9 19563.3 6735.6 6741.5 6768.0 6998.3 7013.7 3510.9 3673.9 3707.6 3717.5 3745.8 2683.2 2762.0 2763.1 2769.8 2771.4 461.7 464.4 466.6 472.7 472.8 373.9 447.9 471.8 489.5 508.5 7344.9 7486.7 7951.0 8003.1 8023.1 435.0 473.3 478.7 490.2 542.4 3927.6 3948.8 4002.9 4148.9 4149.9 57264.4 57337.4 57412.0 58460.7 71512.0 85131.0 85265.1 86959.0 89507.6 91343.7 77514.6 78286.6 78296.6 79034.6 79991.2 6857.7 7050.0 7138.3 7529.9 7533.6 40861.6 41080.4 42573.8 42807.8 43848.1 40156.0 40560.8 59695.4 60537.1 65128.4 8974.0 9201.2 9317.4 9527.8 9857.4 9861.0 10117.3 10135.9 10147.5 10749.0 9308.7 10071.5 10097.7 10196.5 10591.7 10898.4 10917.2 11186.1 11482.4 11576.4 10349.6 10848.1 10903.2 10976.3 11078.1 8507.7 8518.3 8685.1 8788.3 9546.0 9564.2 9693.6 9804.7 9830.6 9929.3 14:32:44 INFO - PROCESS | 26351 | -------- Summary: end -------- 14:32:44 INFO - PROCESS | 26351 | 14:32:45 INFO - TEST-INFO | 26351: exit 0 14:32:45 INFO - TEST-OK | dromaeo_css | took 1121135ms 14:32:45 INFO - TEST-START | kraken 14:32:45 INFO - operating with platform_type : linux_ 14:32:45 INFO - Initialising browser for kraken test... 14:32:45 INFO - TEST-INFO | started process 26663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpieacus/profile http://localhost:36373/getInfo.html) 14:32:50 INFO - PROCESS | 26663 | __metrics Screen width/height:1600/1200 14:32:50 INFO - PROCESS | 26663 | colorDepth:24 14:32:50 INFO - PROCESS | 26663 | Browser inner width/height: 1024/697 14:32:50 INFO - PROCESS | 26663 | __metrics 14:32:50 INFO - PROCESS | 26663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:32:50 INFO - PROCESS | 26663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:32:51 INFO - PROCESS | 26663 | console.error: PushService: 14:32:51 INFO - PROCESS | 26663 | stateChangeProcessEnqueue: Error transitioning state 14:32:51 INFO - PROCESS | 26663 | UnknownError 14:32:52 INFO - TEST-INFO | 26663: exit 0 14:32:52 INFO - Browser initialized. 14:32:52 INFO - Running cycle 1/1 for kraken test... 14:32:52 INFO - TEST-INFO | started process 26743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpieacus/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:04 INFO - PROCESS | 26743 | RSS: Main: 174907392 14:33:04 INFO - PROCESS | 26743 | 14:33:07 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36373/tests/kraken/driver.html?testName=audio-beat-detection) 14:33:08 INFO - PROCESS | 26743 | RSS: Main: 234184704 14:33:08 INFO - PROCESS | 26743 | 14:33:10 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36373/tests/kraken/driver.html?testName=audio-dft) 14:33:11 INFO - PROCESS | 26743 | RSS: Main: 218554368 14:33:11 INFO - PROCESS | 26743 | 14:33:14 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36373/tests/kraken/driver.html?testName=audio-fft) 14:33:15 INFO - PROCESS | 26743 | RSS: Main: 300224512 14:33:15 INFO - PROCESS | 26743 | 14:33:17 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36373/tests/kraken/driver.html?testName=audio-oscillator) 14:33:18 INFO - PROCESS | 26743 | RSS: Main: 210214912 14:33:18 INFO - PROCESS | 26743 | 14:33:20 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:33:20 INFO - PROCESS | 26743 | RSS: Main: 214339584 14:33:20 INFO - PROCESS | 26743 | 14:33:24 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36373/tests/kraken/driver.html?testName=imaging-darkroom) 14:33:24 INFO - PROCESS | 26743 | RSS: Main: 250425344 14:33:24 INFO - PROCESS | 26743 | 14:33:28 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36373/tests/kraken/driver.html?testName=imaging-desaturate) 14:33:28 INFO - PROCESS | 26743 | RSS: Main: 249487360 14:33:28 INFO - PROCESS | 26743 | 14:33:31 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36373/tests/kraken/driver.html?testName=json-parse-financial) 14:33:32 INFO - PROCESS | 26743 | RSS: Main: 249348096 14:33:32 INFO - PROCESS | 26743 | 14:33:34 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:33:34 INFO - PROCESS | 26743 | RSS: Main: 211673088 14:33:34 INFO - PROCESS | 26743 | 14:33:36 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:33:37 INFO - PROCESS | 26743 | RSS: Main: 219275264 14:33:37 INFO - PROCESS | 26743 | 14:33:39 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:33:40 INFO - PROCESS | 26743 | RSS: Main: 223588352 14:33:40 INFO - PROCESS | 26743 | 14:33:42 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:33:43 INFO - PROCESS | 26743 | RSS: Main: 224727040 14:33:43 INFO - PROCESS | 26743 | 14:33:46 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:33:47 INFO - PROCESS | 26743 | RSS: Main: 222179328 14:33:47 INFO - PROCESS | 26743 | 14:33:48 INFO - PROCESS | 26743 | Cycle 1(1): loaded http://localhost:36373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36373/tests/kraken/driver.html?testName=ai-astar) 14:33:49 INFO - PROCESS | 26743 | RSS: Main: 274251776 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | __start_tp_report 14:33:49 INFO - PROCESS | 26743 | _x_x_mozilla_page_load 14:33:49 INFO - PROCESS | 26743 | _x_x_mozilla_page_load_details 14:33:49 INFO - PROCESS | 26743 | |i|pagename|runs| 14:33:49 INFO - PROCESS | 26743 | |0;ai-astar;110;117;114;115;114;116;114;114;114;114 14:33:49 INFO - PROCESS | 26743 | |1;audio-beat-detection;152;124;124;165;129;130;124;124;156;124 14:33:49 INFO - PROCESS | 26743 | |2;audio-dft;160;160;161;161;161;161;162;161;162;161 14:33:49 INFO - PROCESS | 26743 | |3;audio-fft;76;76;77;106;78;76;75;76;113;76 14:33:49 INFO - PROCESS | 26743 | |4;audio-oscillator;83;84;115;83;83;84;108;84;84;117 14:33:49 INFO - PROCESS | 26743 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 14:33:49 INFO - PROCESS | 26743 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;145;147 14:33:49 INFO - PROCESS | 26743 | |7;imaging-desaturate;95;95;95;94;94;96;95;95;95;95 14:33:49 INFO - PROCESS | 26743 | |8;json-parse-financial;64;62;62;62;62;63;64;70;64;63 14:33:49 INFO - PROCESS | 26743 | |9;json-stringify-tinderbox;66;66;66;67;66;65;65;66;66;70 14:33:49 INFO - PROCESS | 26743 | |10;stanford-crypto-aes;83;82;81;91;82;88;82;83;83;82 14:33:49 INFO - PROCESS | 26743 | |11;stanford-crypto-ccm;138;136;144;143;143;143;155;137;187;136 14:33:49 INFO - PROCESS | 26743 | |12;stanford-crypto-pbkdf2;174;175;175;176;174;175;177;174;173;173 14:33:49 INFO - PROCESS | 26743 | |13;stanford-crypto-sha256-iterative;70;72;69;70;69;71;70;71;68;67 14:33:49 INFO - PROCESS | 26743 | __end_tp_report 14:33:49 INFO - PROCESS | 26743 | __start_cc_report 14:33:49 INFO - PROCESS | 26743 | _x_x_mozilla_cycle_collect,1887 14:33:49 INFO - PROCESS | 26743 | __end_cc_report 14:33:49 INFO - PROCESS | 26743 | __startTimestamp1475098429221__endTimestamp 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | ------- Summary: start ------- 14:33:49 INFO - PROCESS | 26743 | Number of tests: 14 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.12 14:33:49 INFO - PROCESS | 26743 | Values: 110.0 117.0 114.0 115.0 114.0 116.0 114.0 114.0 114.0 114.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.50 stddev:15.97 (12.3%) stddev-sans-first:15.74 14:33:49 INFO - PROCESS | 26743 | Values: 152.0 124.0 124.0 165.0 129.0 130.0 124.0 124.0 156.0 124.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 14:33:49 INFO - PROCESS | 26743 | Values: 160.0 160.0 161.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.14 (18.6%) stddev-sans-first:14.77 14:33:49 INFO - PROCESS | 26743 | Values: 76.0 76.0 77.0 106.0 78.0 76.0 75.0 76.0 113.0 76.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:83.50 stddev:14.55 (17.4%) stddev-sans-first:15.03 14:33:49 INFO - PROCESS | 26743 | Values: 83.0 84.0 115.0 83.0 83.0 84.0 108.0 84.0 84.0 117.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:33:49 INFO - PROCESS | 26743 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:33:49 INFO - PROCESS | 26743 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 147.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:33:49 INFO - PROCESS | 26743 | Values: 95.0 95.0 95.0 94.0 94.0 96.0 95.0 95.0 95.0 95.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:2.41 (3.8%) stddev-sans-first:2.55 14:33:49 INFO - PROCESS | 26743 | Values: 64.0 62.0 62.0 62.0 62.0 63.0 64.0 70.0 64.0 63.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 14:33:49 INFO - PROCESS | 26743 | Values: 66.0 66.0 66.0 67.0 66.0 65.0 65.0 66.0 66.0 70.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.20 (3.9%) stddev-sans-first:3.38 14:33:49 INFO - PROCESS | 26743 | Values: 83.0 82.0 81.0 91.0 82.0 88.0 82.0 83.0 83.0 82.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:143.00 stddev:15.41 (10.8%) stddev-sans-first:16.06 14:33:49 INFO - PROCESS | 26743 | Values: 138.0 136.0 144.0 143.0 143.0 143.0 155.0 137.0 187.0 136.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:1.26 (0.7%) stddev-sans-first:1.32 14:33:49 INFO - PROCESS | 26743 | Values: 174.0 175.0 175.0 176.0 174.0 175.0 177.0 174.0 173.0 173.0 14:33:49 INFO - PROCESS | 26743 | 14:33:49 INFO - PROCESS | 26743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.49 (2.1%) stddev-sans-first:1.58 14:33:49 INFO - PROCESS | 26743 | Values: 70.0 72.0 69.0 70.0 69.0 71.0 70.0 71.0 68.0 67.0 14:33:49 INFO - PROCESS | 26743 | -------- Summary: end -------- 14:33:49 INFO - PROCESS | 26743 | 14:33:50 INFO - TEST-INFO | 26743: exit 0 14:33:50 INFO - TEST-OK | kraken | took 64854ms 14:33:50 INFO - SUITE-END | took 1185s 14:33:50 INFO - Completed test suite (00:19:46) 14:33:50 INFO - javascript benchmark 14:33:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2536.9746302536973, 2552.540542702313, 2585.8707064646765, 2590.0675756727574, 2604.8827802748874, 4562.589366956973, 4633.814647414099, 4719.150552900476, 4725.976370118153, 4749.168895443297, 4674.929876051862, 4694.812207511704, 4728.621710263179, 4746.738929358884, 4805.61555075594, 4291.892702682427, 4308.526062133163, 4349.238883195444, 4358.8474403395885, 4376.037271800199, 4375.9562404375865, 4444.11117776446, 4447.1995040892625, 4455.576720211575, 4463.575960283784, 4289.506706728735, 4370.147821174872, 4375.278079116942, 4400.977995110036, 4483.237849565566, 4254.851080212208, 4256.042390462152, 4287.485501739811, 4307.052448461365, 4378.233809083397, 4225.704200705952, 4228.725132866354, 4237.894052648678, 4281.914361712779, 4317.654587633013, 4593.977030114828, 4598.977005114953, 4631.907361852744, 4635.351050852883, 4665.906681866378, 4914.8771280718265, 4933.481984391623, 4970.279309500138, 4987.62592805541, 5030.220315851049, 5030.4215015272985, 5035.420926593452, 5073.162928116856, 5084.567811736007, 5085.415177254626, 4721.3390125382475, 4728.267118596623, 4730.574248317668, 4731.787069581877, 4789.114013907473, 5003.849884503471, 5053.418856831438, 5057.039162559102, 5156.495726071727, 5227.424983251839, 4955.5044495550155, 5001.949980500149, 5009.849704508871, 5071.391433027987, 5072.746362681851, 5076.314697515862, 5078.898422031539, 5081.3140226069745, 5081.390233172043, 5139.691618502902, 5019.171836646912, 5053.761828352077, 5058.924116138261, 5107.336046313955, 5130.563902068291, 4885.511448855157, 4940.851774446773, 4944.332515110486, 4950.8267210647455, 4987.850364489072, 4233.661307095425, 4235.53409124996, 4278.657707383464, 4282.486101667758, 4293.184294983943, 3728.067983004249, 3729.8321575529167, 3734.626537346244, 3763.6048214937036, 3777.490038844776, 4259.318509038539, 4305.095929854766, 4307.569243075667, 4324.740515569076, 4363.781810909441, 5022.773975171126, 5061.240813877947, 5064.5441910228255, 5077.796888124508, 5118.283440318359, 4340.327249276367, 4366.083122544302, 4369.148016136886, 4369.628581570539, 4420.381146639473, 4523.95476045242, 4626.259798432235, 4628.699134556243, 4629.305604159335, 4679.181143299977, 4640.767961601839, 4649.930251046237, 4691.695039822401, 4702.0, 4727.149113159664, 5070.518300761421, 5073.822416215415, 5073.974630126826, 5074.391073071255, 5122.564582010571, 4690.437147542317, 4693.0, 4698.9530104698515, 4743.1225223333795, 4753.667243292936, 4795.20879054966, 4884.12085824555, 4966.354373931365, 4984.252362145708, 5023.773930173078, 5111.207762796773, 5118.104331741856, 5127.282180494659, 5151.871203219949, 5173.991071740975, 4836.153673107263, 4837.830675926326, 4872.269159626085, 4877.6829506081995, 4915.3855768029, 4711.458182309078, 4750.477447480705, 4759.3336932830125, 4824.300476430968, 4888.951110488992, 4756.310335001474, 4786.1624215762795, 4797.880052998703, 4826.251930950708, 4844.903101938012, 4772.809087636595, 4882.731449770296, 4886.486918873467, 4896.2410826321975, 4923.064617722621, 4713.363695901009, 4741.644376671695, 4746.0745154694505, 4761.4762376137905, 4775.617950564016], "value": 4614.182471042032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.4459906991614, 571.6027360984118, 571.70557163061, 573.480999695276, 573.5182446744734, 28029.859850700745, 30728.84635576822, 30803.0, 37680.246395072085, 38414.0, 39894.401583976265, 40350.59649403505, 40452.19095618086, 40468.59531404685, 40510.18979620406, 7580.090389153309, 7719.0, 7724.07311122666, 7783.455158138932, 7786.0, 7609.0869095708595, 7705.922940770604, 7710.421718371116, 7716.305532502074, 7724.0, 7744.651490682904, 7756.689732410697, 7773.183815699355, 7776.611169441505, 7778.261065198797, 7686.423518236126, 7718.807029824243, 7719.575423351714, 7728.343090837286, 7737.72917947872, 7641.503302285334, 7702.768916932501, 7708.537487750753, 7708.922910770877, 7709.807254818675, 36830.4475432866, 37148.257034859154, 37163.0, 37224.62775372239, 37227.62772372269, 2833.0, 2894.1462268630803, 2959.615250017484, 3184.9044528663944, 3465.3415850988486, 28069.71930280712, 28148.296292592644, 28313.433731325258, 28597.57103643447, 31580.526292105405, 3492.0571445709516, 3534.4874993125854, 3538.097785064818, 3554.449060395643, 3577.6780089791782, 245393.0, 245432.0, 246122.0, 246939.0, 248064.0, 52529.47470525246, 52922.67693307698, 52958.73520632372, 53002.469975300526, 53027.469725303024, 31354.0, 32351.676483235336, 32394.190145246084, 34179.316413671586, 34253.657463425545, 13885.791713124312, 13915.721685566434, 13941.372638231303, 13950.162990220619, 13973.09174903628, 10486.947565262124, 10580.947095264475, 10606.257561970742, 10617.0, 10617.097546708615, 17303.91348043252, 17312.567185820204, 17406.651866962842, 17414.39049633282, 17505.912470437564, 6762.222344430355, 6807.591544507345, 6868.519203655696, 6877.518573699793, 6971.198312194061, 762.5500954436798, 846.4794151596724, 863.6415887406656, 903.9728808135767, 920.3695468604028, 25630.74369256321, 27089.1873243803, 27257.727422725915, 28117.859410703226, 28123.718762812518, 892.7589550821242, 909.7043460875242, 913.3789023464108, 916.9954150229339, 938.5964035464816, 14085.295735213198, 14374.640633984025, 14627.8947316132, 14765.48320808788, 14826.0, 365217.0, 368351.0, 368510.0, 369831.0, 371042.0, 47769.76115119402, 48147.27779083316, 48259.5174048255, 48290.5170948286, 48300.0, 1024.948752562369, 1083.3012706803909, 1083.6586475260426, 1144.0961640304233, 1175.735459521601, 27028.864855675594, 28068.71931280661, 29381.85309073441, 30386.0, 31666.841665791522, 45887.54112458833, 46569.30146047744, 46592.53407465882, 46609.0, 46664.0, 350472.0, 353698.0, 354117.0, 354646.0, 355296.91733908735, 36497.63502365049, 36582.59804534142, 37167.6283237175, 37243.62756372402, 37286.813565931996, 40304.59695403009, 40912.0, 40966.1806763869, 41535.376969346085, 41606.37590436085, 34300.14249643779, 34672.30655386828, 34728.826355868056, 34904.65095349014, 34959.65040349666, 34704.65295347014, 34992.65007349996, 35043.64956350404, 35192.64807351894, 35217.47173792446, 25482.872585636953, 30339.544906825973, 30639.2340191497, 35057.82471087628, 35390.0, 28027.85986070138, 32207.677923221407, 32359.776959831463, 32477.0, 32594.51108233331, 23909.0, 24922.626160607244, 24963.375915602257, 25074.49851002933, 25425.0], "value": 17102.520929279628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.796570023686, 349.47055211354797, 350.3850741947883, 361.391056070521, 367.2434784344251, 15659.530214093582, 15826.050436973776, 16740.330386784528, 16841.326346946138, 16979.83020169801, 14456.349464274106, 15125.470608528703, 15207.46773862915, 15456.381744730197, 15820.920895395508, 4545.704529205607, 4749.548792864673, 5078.5175408336145, 5097.541221290083, 5103.821366252182, 4980.726060066695, 5037.5214354636255, 5044.2937988681615, 5046.798128074873, 5049.141645920184, 4827.300041493982, 4928.457869634337, 4937.481564435737, 4959.305697202394, 5029.1199040168, 4533.614642755353, 4561.29299958507, 4569.948911750299, 4571.3600095986585, 4572.382728331682, 4122.113745544692, 4168.645665118469, 4175.185838761443, 4361.389405483234, 4481.229914183879, 12223.816642750366, 12241.571544995972, 12384.8142277865, 12409.75180496385, 12413.131080824345, 1743.1894169211378, 1746.0745804723517, 1805.3230038735473, 1879.1543805287674, 1882.7552418185685, 9003.234725048378, 9223.584938677775, 9224.123708247706, 9404.05959404061, 9540.713778586654, 1662.5095596798974, 1676.79040119985, 1695.9745603815952, 1760.6654735600323, 1805.0794095011508, 63156.68421657862, 63195.0, 63343.29910308094, 63484.682576587285, 63877.68061159665, 8030.678772849021, 8517.318614510825, 8521.57392130391, 8654.87017694735, 9815.263855210746, 10760.838587421194, 10815.459227038617, 10817.0, 10843.240973131962, 10844.783104337868, 6293.905591416133, 6445.355464453611, 6485.967570162119, 6596.208454985433, 6634.601923884582, 6455.677216139175, 6471.320511346335, 6667.499937504706, 6669.0, 6711.261761206263, 3288.8848890288723, 3429.763505497105, 3446.638102999199, 3452.6202117767025, 3478.617352091268, 1667.1330907927809, 1721.5782133377402, 1734.3582874336576, 1759.894406335624, 1785.8392744653045, 825.9297959673495, 833.5123952487742, 858.9141085891486, 897.3354427536956, 940.5062342270363, 16195.514134575982, 16468.341266349453, 16571.25429355682, 16736.414225502293, 17428.82571174272, 839.9706010289733, 843.4812590256947, 856.0412338181277, 877.929765618749, 927.452802846324, 8997.955010225038, 9494.667686630935, 9572.282078844115, 9605.855912161323, 9685.370450920667, 357417.0, 363070.0, 368723.0, 370425.0, 371454.0, 77305.61347193229, 78074.21925780782, 78377.0, 81199.0, 82347.41314671333, 848.1476116502876, 866.3112825303898, 910.8314961732101, 919.2232563483846, 923.7459698582809, 14125.0, 14925.776113358526, 15661.37354505807, 16004.87782936582, 17082.829171708123, 38229.61770382261, 38311.23377532378, 39367.80316098401, 39612.60387396089, 40647.0, 50346.244806328665, 50918.0, 50953.745231273606, 51231.0, 51301.0, 6309.0, 6521.608703477807, 6861.176658800976, 6955.721771129098, 7078.433725302067, 8919.910800891908, 11479.598214062467, 11631.0, 11855.110866684861, 11881.287122772661, 9828.4102953823, 9962.452065136487, 10216.233782466195, 10229.43738094412, 10251.077403033763, 4782.736949467673, 6261.874762504815, 9902.653407130716, 10276.0, 10316.865144833911, 9741.561629726537, 9775.560099795384, 10005.0, 10162.695119146438, 10285.2800303978, 6431.935680643133, 6940.930590694028, 7137.1435427749, 7180.640967951686, 7346.191918888811, 8846.443581000673, 10114.797704046025, 10136.746581335525, 10281.897181028095, 10552.630657926935], "value": 7589.93513392685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.6562562482497, 1345.8115863779067, 1376.2499437806393, 1423.6298562373786, 1680.8403201695842, 6343.587666801661, 7109.537880037794, 7314.0, 7349.338559529635, 7567.962160189205, 7346.228645992161, 7400.333969942704, 7411.110666719987, 7419.295166959144, 7419.888701669466, 2031.918723251072, 2039.9796002039939, 2041.6018876319124, 2049.3442098528476, 2055.8869262190574, 2026.6048120616485, 2044.8364130869495, 2050.364387040015, 2069.368842503036, 2070.5858828234336, 2052.7126202331688, 2053.4147767886157, 2057.341650671786, 2058.9176432942663, 2061.4846288427893, 2045.2125931516325, 2052.8768273903615, 2053.1376821734907, 2053.774084850665, 2055.1676570988775, 1960.0591715976411, 1975.8518111141723, 1988.67186914159, 1992.0, 1993.6810110382269, 7112.110986126734, 7306.525075870051, 7497.212792656747, 7602.657880395395, 7603.7718868433485, 4244.045089854789, 4422.601965823092, 4427.535108813592, 4431.180231657154, 4434.578715022068, 2771.794269492757, 2909.141803168049, 2947.3957838643028, 2959.215807810932, 2965.644122705268, 983.3657291047234, 985.9211263098935, 999.8550210219478, 1002.1531805624236, 1013.5084484025242, 9287.674931377369, 9290.72127836166, 9327.11392417726, 9396.248300135972, 9400.62397504099, 3615.6565126312958, 3672.2839046385698, 3747.512823333004, 3810.599887011879, 3851.056491159628, 7622.199669034782, 7625.6568454419685, 7630.847383052308, 7637.15991240963, 7641.694332226649, 4242.936355954663, 4243.8090285937205, 4245.61789438952, 4246.639035682002, 4246.766427846498, 3464.2205503761957, 3496.2483066140394, 3597.5323207982797, 3975.1453437510495, 3980.5820388859333, 2935.1488068460335, 3302.653221411765, 3326.1185785766793, 3330.533725278463, 3345.7825241359233, 976.1068622210598, 1018.9643362482277, 1021.2391768132788, 1027.2552399510444, 1031.7730099378125, 696.9024336592881, 804.2359758229705, 819.2626636027504, 825.9008918929646, 841.9536925469158, 4937.7777999990085, 5056.84829455117, 5063.164577844688, 5183.896322073538, 5296.947030529645, 377.8620803406737, 383.93856982883165, 384.33126360133724, 388.76673995602414, 396.1621171222843, 3227.322262324891, 3342.08092774489, 3357.1942733744213, 3361.8487168077495, 3436.1581412554083, 8941.687040953535, 9299.256059515357, 9382.812343753087, 9409.153176214173, 9411.482368469662, 9271.814563708687, 9274.165325120772, 9353.579088941015, 9376.578053987587, 9378.249740020781, 7052.823679407953, 7092.538984966064, 7131.072960515204, 7134.143902731602, 7135.215126336099, 4768.809247630056, 4910.729909854992, 4950.851474455772, 4963.280324353021, 5088.491150884882, 8460.0, 8473.57632118404, 8634.438761480484, 8649.654013839376, 8678.82642347162, 7879.921200787919, 8617.784555386166, 8825.955870220865, 8835.33734969867, 8877.511736854534, 5465.699386533779, 5980.730867111078, 6193.938060619516, 6195.628262304276, 6332.0, 7199.604021778852, 7213.495055346076, 7264.418846492374, 7268.636568171464, 7278.454115941219, 6580.440662543738, 6604.438622717123, 6720.764773232913, 6725.798226053226, 6759.729610815512, 6424.775132870327, 6542.313057128933, 6542.771003014872, 6576.671166441754, 6625.271220165681, 6033.155358249761, 6063.151158837854, 6145.293291271561, 6193.194884664965, 6214.067889816563, 4324.0, 4347.978260108805, 4410.470743510799, 4437.290033594739, 4486.484054333793, 4587.311903214544, 4594.517575654641, 4625.259958406638, 4718.103560323528, 4734.952650473451], "value": 3828.2271291769694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.6259531311637, 291.2238883375804, 295.2971926814182, 297.1057118074595, 300.30779054279884, 4792.209285467902, 4797.784099715513, 4820.228763397857, 4824.0, 4824.1316563018645, 4715.269133284346, 4718.57532822046, 4756.38398880616, 4758.2862570614425, 4763.714177149365, 3743.5320584926885, 3756.192418629994, 3756.69946404287, 3761.755485893422, 3762.9811850940705, 3650.8357123929354, 3763.397856342972, 3778.716596255278, 3810.5998870118656, 3822.7132965027595, 3740.45763364312, 3742.401215805458, 3760.0787806987328, 3764.6235376462273, 3785.413260944558, 3726.8384337084426, 3728.6084961079237, 3738.3831667774784, 3747.6627103560672, 3753.2305877295225, 3096.380723855238, 3318.4192766266046, 3323.11937336606, 3326.1518312830317, 3331.1505566080737, 4538.614217791492, 4539.614132798716, 4593.517680643517, 4638.234691275969, 4652.534746525354, 4201.306784380604, 4220.620144187038, 4233.280342341778, 4235.322348424268, 4237.237297286487, 4637.884052898671, 4928.778204980748, 4929.359183306147, 4942.87642808929, 4968.254761785725, 3364.562606861117, 3455.481677748333, 3567.7502574819773, 3600.981995090034, 3609.8917032489067, 5122.718250496221, 5122.871928201825, 5135.6918584885025, 5140.9668295705715, 5143.871403214912, 3667.9816600916824, 3674.540682414698, 3682.606305901186, 3691.4093745000673, 3707.925841483155, 3630.9092272692865, 3724.65912271582, 3725.906852328659, 3742.794146321924, 3770.0, 4233.5131459882505, 4241.130568233505, 4245.936310955338, 4247.3628955656895, 4257.93428731313, 4956.596050915303, 4969.751512424365, 4977.90044199114, 4979.800807967641, 5002.124628190052, 1244.4897591987242, 1297.6172029251393, 1304.7847105227531, 1316.6774140335679, 1317.5059352742721, 837.4933165434946, 849.7068511363569, 862.5557837713583, 865.4071960706935, 866.2204016385303, 3886.0867696091395, 3895.06598335683, 3897.7661340319673, 3952.8418863245147, 3954.7429417087797, 4448.888777780581, 4453.332000199931, 4454.732716037048, 4499.77501124949, 4513.232750432434, 3904.5314562252142, 3911.8435262589746, 3911.9804400977814, 3916.4712763777097, 3958.6239307265764, 2433.6349547568007, 2443.1920378919826, 2525.861077640711, 2710.4037111835364, 2732.0, 4535.0, 4758.857874110188, 4760.166970780099, 4776.665633405698, 4783.736894470768, 5067.97466012675, 5098.260752190911, 5109.897802043938, 5112.821051263262, 5230.895382092337, 4753.524647535219, 4770.185590501621, 4775.283707443911, 4782.665213435096, 4786.856394308106, 4988.201887697951, 5109.492699653537, 5116.2395639204415, 5119.180931051014, 5175.81884634036, 4979.5269449403695, 5025.145725226794, 5028.547430731252, 5049.065922804293, 5070.366204224472, 4743.596794272526, 4759.524047595212, 4769.879078416639, 4806.2310030394965, 4809.134355815987, 3493.2010014841867, 3589.2821435713486, 3596.8021758803516, 3599.8740044099377, 3614.4457883110513, 5041.269015992587, 5072.61587054084, 5075.720835353944, 5084.694918304914, 5091.694498330112, 4848.3454733610515, 4856.95143048565, 4858.295547145573, 4860.78126484302, 4884.9511504884495, 4611.723296602215, 4852.102361063074, 4862.027594481188, 4869.6347773917805, 4884.438289596742, 4771.188897887437, 4775.257031183663, 4784.952150478451, 4789.640776941813, 4791.209450440778, 4862.781174847069, 4872.512748725099, 4878.56092951636, 4886.853394398174, 4896.338994235733, 4633.675642705113, 4765.285207218945, 4777.522247775334, 4781.0, 4783.497732738012], "value": 3699.6558310314604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.7610684046901, 664.2394458345192, 666.8032930285565, 671.9126513553238, 784.2667106255651, 12709.745805083892, 13105.148165369244, 13761.174329540223, 13774.793378099337, 13777.862221377809, 13560.796588051187, 13582.25297608631, 13679.794803077937, 13715.862841371583, 13734.519291824789, 605.9303180134275, 617.7714245729087, 739.3493725521547, 757.3675980556242, 762.9618519074052, 729.773770131261, 756.7237958145292, 762.9084509858825, 765.5521519910831, 765.7013764631798, 793.9047314322261, 796.8127490039836, 797.6689673785401, 798.0901771979948, 800.8318253166842, 634.1882390540115, 790.0164295452199, 792.9048514178278, 798.5767543202141, 800.1238643685156, 461.38405229018963, 562.2437821130613, 570.6576054367388, 581.1979468333715, 584.8742520358144, 13099.476020959246, 13119.344032798323, 13131.343432828417, 13138.737225255538, 13149.21104733719, 12359.938200308941, 12617.432215550321, 12975.480980760758, 13134.408951597201, 13292.40184191704, 11902.761944761143, 11945.343006134659, 11955.760884782256, 12483.937580312131, 12640.178388404724, 4108.322126849066, 4111.342185250345, 4172.5410204877435, 4180.3102488089735, 4257.638100761439, 62822.0, 63548.0, 64614.35385646178, 64655.3534464654, 66124.0, 9973.202143828476, 10236.33463824864, 10332.328398654063, 10410.739731506774, 10663.786724265627, 19503.609927801364, 19544.31594894172, 19548.804511954982, 19552.90223548873, 19563.315283964992, 6735.629540375228, 6741.528093033538, 6767.966160169168, 6998.335158159966, 7013.684384202723, 3510.8946731598094, 3673.8714145004797, 3707.5550933887566, 3717.4795528626014, 3745.7752534847996, 2683.195041487585, 2762.033288349062, 2763.1434255380495, 2769.8338099714083, 2771.362586605052, 461.6560662306603, 464.3638215644589, 466.64534953435634, 472.68094036525207, 472.7777944366142, 373.908392443853, 447.9260921947842, 471.7924113390166, 489.47626040136714, 508.5346907579523, 7344.926550734531, 7486.737964171337, 7951.006124234471, 8003.079645840687, 8023.077346105156, 434.9543297953669, 473.3113320119218, 478.72712553843974, 490.2107606753125, 542.4223202289628, 3927.626875446828, 3948.763074215556, 4002.8598999034893, 4148.875533733993, 4149.8962525937095, 57264.427355726744, 57337.42662573404, 57412.0, 58460.70769646124, 71512.0, 85131.0, 85265.14734852697, 86959.0, 89507.55246223728, 91343.73552599453, 77514.6124269375, 78286.60856695793, 78296.60851695706, 79034.6048269755, 79991.2000880007, 6857.657117144223, 7050.048243487064, 7138.286171383028, 7529.924700752922, 7533.616225331925, 40861.591384085776, 41080.38379424371, 42573.78713106415, 42807.785961069996, 43848.123037539706, 40156.0, 40560.79719601383, 59695.40304596898, 60537.09194362, 65128.3948642049, 8974.0, 9201.171894529525, 9317.39436936597, 9527.809443811224, 9857.35927164732, 9861.0, 10117.342372745748, 10135.898641013791, 10147.492625368553, 10749.0, 9308.674196403093, 10071.546780394754, 10097.697069087939, 10196.490175491048, 10591.682249532527, 10898.400587967737, 10917.23579349438, 11186.10511159089, 11482.36846973391, 11576.430435257076, 10349.643398523654, 10848.132149428184, 10903.236773425784, 10976.286541374786, 11078.113750899747, 8507.659693612186, 8518.275946544365, 8685.088065753258, 8788.340874434316, 9545.952270238882, 9564.187044101329, 9693.563789629343, 9804.705858824247, 9830.557624906753, 9929.304948653526], "value": 6222.6824755506095, "unit": "score"}], "name": "dromaeo_css", "value": 6124.870644511428, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 114.0, 115.0, 114.0, 116.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 124.0, 165.0, 129.0, 130.0, 124.0, 124.0, 156.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 106.0, 78.0, 76.0, 75.0, 76.0, 113.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 115.0, 83.0, 83.0, 84.0, 108.0, 84.0, 84.0, 117.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 62.0, 63.0, 64.0, 70.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 70.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 91.0, 82.0, 88.0, 82.0, 83.0, 83.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 144.0, 143.0, 143.0, 143.0, 155.0, 137.0, 187.0, 136.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 175.0, 176.0, 174.0, 175.0, 177.0, 174.0, 173.0, 173.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 70.0, 69.0, 71.0, 70.0, 71.0, 68.0, 67.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1547.5, "alertThreshold": 2.0}]} 14:33:50 INFO - Return code: 0 14:33:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:33:51 INFO - # TBPL SUCCESS # 14:33:51 INFO - Running post-action listener: _resource_record_post_action 14:33:51 INFO - [mozharness: 2016-09-28 21:33:51.045891Z] Finished run-tests step (success) 14:33:51 INFO - Running post-run listener: _resource_record_post_run 14:33:51 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401350656; Read time: 8; Write time: 424120 14:33:51 INFO - TinderboxPrint: CPU usage
13.0% 14:33:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:33:51 INFO - TinderboxPrint: I/O write bytes / time
401,350,656 / 424,120 14:33:51 INFO - TinderboxPrint: CPU idle
8,346.0 (86.9%) 14:33:51 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 14:33:51 INFO - TinderboxPrint: Swap in / out
0 / 0 14:33:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110448640; Read time: 0; Write time: 117828 14:33:51 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 289955840; Read time: 0; Write time: 306264 14:33:51 INFO - Running post-run listener: _upload_blobber_files 14:33:51 INFO - Blob upload gear active. 14:33:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:33:51 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 14:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:33:52 INFO - (blobuploader) - INFO - Open directory for files ... 14:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:52 INFO - (blobuploader) - INFO - Done attempting. 14:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:56 INFO - (blobuploader) - INFO - Done attempting. 14:33:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:33:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:56 INFO - (blobuploader) - INFO - Done attempting. 14:33:56 INFO - (blobuploader) - INFO - Iteration through files over. 14:33:57 INFO - Return code: 0 14:33:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:33:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:33:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3ee55aa709b8375436b45b76b957635aee5f4c91d88219064ab7908d55c0bdafe38c6b3dd017fb595c54aaaba2b02f041ebb582a150d67c7ddf5bb873019cc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0895a33a7cb9a246a8d879a1e7b34c03a05095340474edd37da714118f89d08741e2ea595d1b1b77edc08a6fd04e7de4b13eedf542412296d5dbaa4a6dcb5beb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aec224d5a6f5cbe696151fd9e3348f3bee67eef10a286faf03b7b85dc6cec878ddc2e149d1e4054c77ce63c89e4703dde28be03ed9ebb3e7d65ffbf9359cf0fa"} 14:33:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:33:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:33:57 INFO - Contents: 14:33:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3ee55aa709b8375436b45b76b957635aee5f4c91d88219064ab7908d55c0bdafe38c6b3dd017fb595c54aaaba2b02f041ebb582a150d67c7ddf5bb873019cc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0895a33a7cb9a246a8d879a1e7b34c03a05095340474edd37da714118f89d08741e2ea595d1b1b77edc08a6fd04e7de4b13eedf542412296d5dbaa4a6dcb5beb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aec224d5a6f5cbe696151fd9e3348f3bee67eef10a286faf03b7b85dc6cec878ddc2e149d1e4054c77ce63c89e4703dde28be03ed9ebb3e7d65ffbf9359cf0fa"} 14:33:57 INFO - Running post-run listener: copy_logs_to_upload_dir 14:33:57 INFO - Copying logs to upload dir... 14:33:57 INFO - mkdir: /builds/slave/test/build/upload/logs 14:33:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.425553 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-28 14:33:55.864548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 14:33:55.868286) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3ee55aa709b8375436b45b76b957635aee5f4c91d88219064ab7908d55c0bdafe38c6b3dd017fb595c54aaaba2b02f041ebb582a150d67c7ddf5bb873019cc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0895a33a7cb9a246a8d879a1e7b34c03a05095340474edd37da714118f89d08741e2ea595d1b1b77edc08a6fd04e7de4b13eedf542412296d5dbaa4a6dcb5beb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aec224d5a6f5cbe696151fd9e3348f3bee67eef10a286faf03b7b85dc6cec878ddc2e149d1e4054c77ce63c89e4703dde28be03ed9ebb3e7d65ffbf9359cf0fa"} build_url:https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/XMWsFkmoRaq_jZ1wRPgGLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3ee55aa709b8375436b45b76b957635aee5f4c91d88219064ab7908d55c0bdafe38c6b3dd017fb595c54aaaba2b02f041ebb582a150d67c7ddf5bb873019cc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0895a33a7cb9a246a8d879a1e7b34c03a05095340474edd37da714118f89d08741e2ea595d1b1b77edc08a6fd04e7de4b13eedf542412296d5dbaa4a6dcb5beb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/aec224d5a6f5cbe696151fd9e3348f3bee67eef10a286faf03b7b85dc6cec878ddc2e149d1e4054c77ce63c89e4703dde28be03ed9ebb3e7d65ffbf9359cf0fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 14:33:55.894892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 14:33:55.895266) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475094544.213531-1712221554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 14:33:55.977951) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 14:33:55.978273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 14:33:55.978579) ========= ========= Total master_lag: 0.16 =========