builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1475554975.27 results: success (0) buildid: 20161003183003 builduid: 66423013fcb243159a4e399cb0803752 revision: 1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.273345) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.273783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.274059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.304642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.305023) ========= 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=cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 21:22:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-10-03 21:22:56 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.439422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.439746) ========= 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=cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019858 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.506654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 21:22:55.507350) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e --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 1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e --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=cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 21:22:57,120 truncating revision to first 12 chars 2016-10-03 21:22:57,120 Setting DEBUG logging. 2016-10-03 21:22:57,121 attempt 1/10 2016-10-03 21:22:57,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1bbd6e5a697c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 21:22:58,228 unpacking tar archive at: autoland-1bbd6e5a697c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.440113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 21:22:56.962897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:56.963171) ========= script_repo_revision: 1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:56.963594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:56.963883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:56.972542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-03 21:22:56.972846) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:22:58 INFO - MultiFileLogger online at 20161003 21:22:58 in /builds/slave/test 21:22:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:22:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:58 INFO - {'append_to_log': False, 21:22:58 INFO - 'base_work_dir': '/builds/slave/test', 21:22:58 INFO - 'blob_upload_branch': 'Autoland', 21:22:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:58 INFO - 'branch': 'Autoland', 21:22:58 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:58 INFO - 'config_files': ('talos/linux_config.py',), 21:22:58 INFO - 'default_actions': ('clobber', 21:22:58 INFO - 'read-buildbot-config', 21:22:58 INFO - 'download-and-extract', 21:22:58 INFO - 'populate-webroot', 21:22:58 INFO - 'create-virtualenv', 21:22:58 INFO - 'install', 21:22:58 INFO - 'run-tests'), 21:22:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:58 INFO - 'download_minidump_stackwalk': True, 21:22:58 INFO - 'download_symbols': 'ondemand', 21:22:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:58 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:58 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:58 INFO - 'installer_path': 'installer.exe', 21:22:58 INFO - 'log_level': 'info', 21:22:58 INFO - 'log_name': 'talos', 21:22:58 INFO - 'log_to_console': True, 21:22:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:22:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:22:58 INFO - 'opt_config_files': (), 21:22:58 INFO - 'pip_index': False, 21:22:58 INFO - 'sps_profile': False, 21:22:58 INFO - 'sps_profile_interval': 0, 21:22:58 INFO - 'suite': 'dromaeojs', 21:22:58 INFO - 'system_bits': '32', 21:22:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:58 INFO - 'title': 'talos-linux64-ix-054', 21:22:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:58 INFO - 'use_talos_json': True, 21:22:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:58 INFO - 'work_dir': 'build'} 21:22:58 INFO - [mozharness: 2016-10-04 04:22:58.685838Z] Running clobber step. 21:22:58 INFO - Running pre-action listener: _resource_record_pre_action 21:22:58 INFO - Running main action method: clobber 21:22:58 INFO - rmtree: /builds/slave/test/build 21:22:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:22:59 INFO - Running post-action listener: _resource_record_post_action 21:22:59 INFO - [mozharness: 2016-10-04 04:22:59.655564Z] Finished clobber step (success) 21:22:59 INFO - [mozharness: 2016-10-04 04:22:59.655662Z] Running read-buildbot-config step. 21:22:59 INFO - Running pre-action listener: _resource_record_pre_action 21:22:59 INFO - Running main action method: read_buildbot_config 21:22:59 INFO - Using buildbot properties: 21:22:59 INFO - { 21:22:59 INFO - "project": "", 21:22:59 INFO - "product": "firefox", 21:22:59 INFO - "script_repo_revision": "production", 21:22:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:22:59 INFO - "repository": "", 21:22:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:22:59 INFO - "buildid": "20161003183003", 21:22:59 INFO - "pgo_build": "True", 21:22:59 INFO - "basedir": "/builds/slave/test", 21:22:59 INFO - "buildnumber": 286, 21:22:59 INFO - "slavename": "talos-linux64-ix-054", 21:22:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:22:59 INFO - "platform": "ubuntu64_hw", 21:22:59 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:22:59 INFO - "branch": "autoland", 21:22:59 INFO - "repo_path": "integration/autoland", 21:22:59 INFO - "revision": "1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e", 21:22:59 INFO - "stage_platform": "linux64-pgo", 21:22:59 INFO - "builduid": "66423013fcb243159a4e399cb0803752", 21:22:59 INFO - "slavebuilddir": "test" 21:22:59 INFO - } 21:22:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:22:59 INFO - Running post-action listener: _resource_record_post_action 21:22:59 INFO - [mozharness: 2016-10-04 04:22:59.658078Z] Finished read-buildbot-config step (success) 21:22:59 INFO - [mozharness: 2016-10-04 04:22:59.658166Z] Running download-and-extract step. 21:22:59 INFO - Running pre-action listener: _resource_record_pre_action 21:22:59 INFO - Running main action method: download_and_extract 21:22:59 INFO - mkdir: /builds/slave/test/build/tests 21:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:59 INFO - trying https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:22:59 INFO - Downloading https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/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 21:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/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 21:23:00 INFO - Downloaded 1361 bytes. 21:23:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:23:00 INFO - Using the following test package requirements: 21:23:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:23:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:23:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:23:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'jsshell-linux-x86_64.zip'], 21:23:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:23:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:23:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:23:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:23:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:23:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:23:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:23:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:23:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:23:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:23:00 INFO - Fetch https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:23:00 INFO - Http code: 200 21:23:00 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 21:23:00 INFO - x-amz-cf-id: 1WOV2ZhqiDGR3lC1AViVraY5dBV1PAuIB40cZrqJHhF5G7UWx0twLA== 21:23:00 INFO - x-amz-version-id: TNe5.pztb1cqwJDD85MI_qw7AKuLUsPi 21:23:01 INFO - Expected file size: 21991990 21:23:01 INFO - Obtained file size: 21991990 21:23:05 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 21:23:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:23:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:23:05 INFO - Fetch https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:23:05 INFO - Http code: 200 21:23:05 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 21:23:05 INFO - x-amz-cf-id: F3FYJ-muub6EDRDJ_jrDrEENvMs8jpnv09K4aFKpOoFIaVophcrVmw== 21:23:05 INFO - x-amz-version-id: TNe5.pztb1cqwJDD85MI_qw7AKuLUsPi 21:23:05 INFO - Expected file size: 21991990 21:23:05 INFO - Obtained file size: 21991990 21:23:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:23:10 INFO - Fetch https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:23:11 INFO - Http code: 200 21:23:11 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:23:11 INFO - x-amz-cf-id: rn0LcfbRJZ3PA4tq85v0H1u4HPvzuUHPTu22rCyeKUcZ7mhLbPcJLA== 21:23:11 INFO - x-amz-version-id: qnhmCtCrglVJXMsxWOQ36JB9242Q0oq1 21:23:11 INFO - Expected file size: 14408522 21:23:11 INFO - Obtained file size: 14408522 21:23:11 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')]} 21:23:11 INFO - trying https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:23:11 INFO - Downloading https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/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 21:23:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/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 21:23:12 INFO - Downloaded 59685106 bytes. 21:23:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:23:12 INFO - mkdir: /builds/slave/test/properties 21:23:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:23:12 INFO - Writing to file /builds/slave/test/properties/build_url 21:23:12 INFO - Contents: 21:23:12 INFO - build_url:https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:23:13 INFO - Running post-action listener: _resource_record_post_action 21:23:13 INFO - Running post-action listener: set_extra_try_arguments 21:23:13 INFO - [mozharness: 2016-10-04 04:23:13.640739Z] Finished download-and-extract step (success) 21:23:13 INFO - [mozharness: 2016-10-04 04:23:13.640964Z] Running populate-webroot step. 21:23:13 INFO - Running pre-action listener: _resource_record_pre_action 21:23:13 INFO - Running main action method: populate_webroot 21:23:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:23:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:23:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:23:13 INFO - '--tppagecycles', 21:23:13 INFO - '7'], 21:23:13 INFO - 'tests': ['tsvgm']}}, 21:23:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:23:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:23:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:23:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:23:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['damp', 'tps']}, 21:23:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'tests': ['damp', 'tps']}, 21:23:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['dromaeo_dom']}, 21:23:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:23:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['basic_compositor_video']}, 21:23:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:23:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['a11yr', 21:23:13 INFO - 'ts_paint', 21:23:13 INFO - 'tpaint', 21:23:13 INFO - 'sessionrestore', 21:23:13 INFO - 'sessionrestore_no_auto_restore', 21:23:13 INFO - 'tabpaint']}, 21:23:13 INFO - 'other-e10s': {'tests': ['a11yr', 21:23:13 INFO - 'ts_paint', 21:23:13 INFO - 'tpaint', 21:23:13 INFO - 'sessionrestore', 21:23:13 INFO - 'sessionrestore_no_auto_restore', 21:23:13 INFO - 'tabpaint']}, 21:23:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:23:13 INFO - 'ts_paint', 21:23:13 INFO - 'tpaint', 21:23:13 INFO - 'sessionrestore', 21:23:13 INFO - 'sessionrestore_no_auto_restore', 21:23:13 INFO - 'tabpaint']}, 21:23:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:23:13 INFO - 'ts_paint', 21:23:13 INFO - 'tpaint', 21:23:13 INFO - 'sessionrestore', 21:23:13 INFO - 'sessionrestore_no_auto_restore', 21:23:13 INFO - 'tabpaint']}, 21:23:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['a11yr', 21:23:13 INFO - 'ts_paint', 21:23:13 INFO - 'tpaint', 21:23:13 INFO - 'sessionrestore', 21:23:13 INFO - 'sessionrestore_no_auto_restore', 21:23:13 INFO - 'tabpaint']}, 21:23:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['a11yr', 21:23:13 INFO - 'ts_paint', 21:23:13 INFO - 'tpaint', 21:23:13 INFO - 'sessionrestore', 21:23:13 INFO - 'sessionrestore_no_auto_restore', 21:23:13 INFO - 'tabpaint']}, 21:23:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['tsvgx', 21:23:13 INFO - 'tsvgr_opacity', 21:23:13 INFO - 'tart', 21:23:13 INFO - 'tscrollx', 21:23:13 INFO - 'cart']}, 21:23:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:23:13 INFO - 'tsvgr_opacity', 21:23:13 INFO - 'tart', 21:23:13 INFO - 'tscrollx', 21:23:13 INFO - 'cart']}, 21:23:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'talos_options': ['--disable-e10s'], 21:23:13 INFO - 'tests': ['tp5o']}, 21:23:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'tests': ['tp5o']}, 21:23:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'talos_options': ['--disable-e10s', 21:23:13 INFO - '--xperf_path', 21:23:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:13 INFO - 'tests': ['tp5n']}, 21:23:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:13 INFO - 'talos_options': ['--xperf_path', 21:23:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:13 INFO - 'tests': ['tp5n']}}, 21:23:13 INFO - 'talos.zip': {'path': '', 21:23:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:23:13 INFO - Running post-action listener: _resource_record_post_action 21:23:13 INFO - [mozharness: 2016-10-04 04:23:13.658053Z] Finished populate-webroot step (success) 21:23:13 INFO - [mozharness: 2016-10-04 04:23:13.658141Z] Running create-virtualenv step. 21:23:13 INFO - Running pre-action listener: _resource_record_pre_action 21:23:13 INFO - Running main action method: create_virtualenv 21:23:13 INFO - Creating virtualenv /builds/slave/test/build/venv 21:23:13 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 21:23:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:23:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:23:13 INFO - Using real prefix '/usr' 21:23:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:23:14 INFO - Installing distribute.............................................................................................................................................................................................done. 21:23:16 INFO - Installing pip.................done. 21:23:16 INFO - Return code: 0 21:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:23:16 INFO - Reading from file tmpfile_stdout 21:23:16 INFO - Output received: 21:23:16 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) 21:23:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:23:16 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')]} 21:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:16 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')]} 21:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:16 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:16 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 21:23:16 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 21:23:16 INFO - Using env: {'DISPLAY': ':0', 21:23:16 INFO - 'HOME': '/home/cltbld', 21:23:16 INFO - 'LANG': 'en_US.UTF-8', 21:23:16 INFO - 'LANGUAGE': 'en_US:en', 21:23:16 INFO - 'LOGNAME': 'cltbld', 21:23:16 INFO - 'MAIL': '/var/mail/cltbld', 21:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:16 INFO - 'MOZ_NO_REMOTE': '1', 21:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:16 INFO - 'NO_EM_RESTART': '1', 21:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:16 INFO - 'PWD': '/builds/slave/test', 21:23:16 INFO - 'SHELL': '/bin/bash', 21:23:16 INFO - 'SHLVL': '1', 21:23:16 INFO - 'TERM': 'linux', 21:23:16 INFO - 'TMOUT': '86400', 21:23:16 INFO - 'USER': 'cltbld', 21:23:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:16 INFO - '_': '/tools/buildbot/bin/python'} 21:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:16 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 21:23:16 INFO - Cleaning up... 21:23:16 INFO - Return code: 0 21:23:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:23:16 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')]} 21:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:16 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')]} 21:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:16 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:16 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 21:23:16 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 21:23:16 INFO - Using env: {'DISPLAY': ':0', 21:23:16 INFO - 'HOME': '/home/cltbld', 21:23:16 INFO - 'LANG': 'en_US.UTF-8', 21:23:16 INFO - 'LANGUAGE': 'en_US:en', 21:23:16 INFO - 'LOGNAME': 'cltbld', 21:23:16 INFO - 'MAIL': '/var/mail/cltbld', 21:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:16 INFO - 'MOZ_NO_REMOTE': '1', 21:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:16 INFO - 'NO_EM_RESTART': '1', 21:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:16 INFO - 'PWD': '/builds/slave/test', 21:23:16 INFO - 'SHELL': '/bin/bash', 21:23:16 INFO - 'SHLVL': '1', 21:23:16 INFO - 'TERM': 'linux', 21:23:16 INFO - 'TMOUT': '86400', 21:23:16 INFO - 'USER': 'cltbld', 21:23:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:16 INFO - '_': '/tools/buildbot/bin/python'} 21:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:16 INFO - Downloading/unpacking psutil>=3.1.1 21:23:16 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 21:23:16 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 21:23:16 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 21:23:16 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 21:23:16 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 21:23:16 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 21:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:23:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:18 INFO - Installing collected packages: psutil 21:23:18 INFO - Running setup.py install for psutil 21:23:18 INFO - building 'psutil._psutil_linux' extension 21:23:18 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 21:23:19 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 21:23:19 INFO - building 'psutil._psutil_posix' extension 21:23:19 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 21:23:19 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 21:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:19 INFO - Successfully installed psutil 21:23:19 INFO - Cleaning up... 21:23:19 INFO - Return code: 0 21:23:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:23:19 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')]} 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 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')]} 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:19 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 21:23:19 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 21:23:19 INFO - Using env: {'DISPLAY': ':0', 21:23:19 INFO - 'HOME': '/home/cltbld', 21:23:19 INFO - 'LANG': 'en_US.UTF-8', 21:23:19 INFO - 'LANGUAGE': 'en_US:en', 21:23:19 INFO - 'LOGNAME': 'cltbld', 21:23:19 INFO - 'MAIL': '/var/mail/cltbld', 21:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:19 INFO - 'MOZ_NO_REMOTE': '1', 21:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:19 INFO - 'NO_EM_RESTART': '1', 21:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:19 INFO - 'PWD': '/builds/slave/test', 21:23:19 INFO - 'SHELL': '/bin/bash', 21:23:19 INFO - 'SHLVL': '1', 21:23:19 INFO - 'TERM': 'linux', 21:23:19 INFO - 'TMOUT': '86400', 21:23:19 INFO - 'USER': 'cltbld', 21:23:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:19 INFO - '_': '/tools/buildbot/bin/python'} 21:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:23:19 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 21:23:19 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 21:23:19 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 21:23:19 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 21:23:19 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 21:23:19 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 21:23:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:21 INFO - Installing collected packages: mozsystemmonitor 21:23:21 INFO - Running setup.py install for mozsystemmonitor 21:23:21 INFO - Successfully installed mozsystemmonitor 21:23:21 INFO - Cleaning up... 21:23:21 INFO - Return code: 0 21:23:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:21 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:21 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 21:23:21 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 21:23:21 INFO - Using env: {'DISPLAY': ':0', 21:23:21 INFO - 'HOME': '/home/cltbld', 21:23:21 INFO - 'LANG': 'en_US.UTF-8', 21:23:21 INFO - 'LANGUAGE': 'en_US:en', 21:23:21 INFO - 'LOGNAME': 'cltbld', 21:23:21 INFO - 'MAIL': '/var/mail/cltbld', 21:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:21 INFO - 'MOZ_NO_REMOTE': '1', 21:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:21 INFO - 'NO_EM_RESTART': '1', 21:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:21 INFO - 'PWD': '/builds/slave/test', 21:23:21 INFO - 'SHELL': '/bin/bash', 21:23:21 INFO - 'SHLVL': '1', 21:23:21 INFO - 'TERM': 'linux', 21:23:21 INFO - 'TMOUT': '86400', 21:23:21 INFO - 'USER': 'cltbld', 21:23:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:21 INFO - '_': '/tools/buildbot/bin/python'} 21:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:23:21 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 21:23:21 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 21:23:21 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 21:23:21 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 21:23:21 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 21:23:21 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 21:23:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:24 INFO - warning: no files found matching '*.txt' 21:23:24 INFO - no previously-included directories found matching 'build' 21:23:24 INFO - no previously-included directories found matching 'dist' 21:23:24 INFO - no previously-included directories found matching '.git*' 21:23:24 INFO - Installing collected packages: jsonschema, functools32 21:23:24 INFO - Running setup.py install for functools32 21:23:24 INFO - warning: no files found matching '*.txt' 21:23:24 INFO - no previously-included directories found matching 'build' 21:23:24 INFO - no previously-included directories found matching 'dist' 21:23:24 INFO - no previously-included directories found matching '.git*' 21:23:24 INFO - Successfully installed jsonschema functools32 21:23:24 INFO - Cleaning up... 21:23:24 INFO - Return code: 0 21:23:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:23:29 INFO - Using env: {'DISPLAY': ':0', 21:23:29 INFO - 'HOME': '/home/cltbld', 21:23:29 INFO - 'LANG': 'en_US.UTF-8', 21:23:29 INFO - 'LANGUAGE': 'en_US:en', 21:23:29 INFO - 'LOGNAME': 'cltbld', 21:23:29 INFO - 'MAIL': '/var/mail/cltbld', 21:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:29 INFO - 'MOZ_NO_REMOTE': '1', 21:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:29 INFO - 'NO_EM_RESTART': '1', 21:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:29 INFO - 'PWD': '/builds/slave/test', 21:23:29 INFO - 'SHELL': '/bin/bash', 21:23:29 INFO - 'SHLVL': '1', 21:23:29 INFO - 'TERM': 'linux', 21:23:29 INFO - 'TMOUT': '86400', 21:23:29 INFO - 'USER': 'cltbld', 21:23:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:29 INFO - '_': '/tools/buildbot/bin/python'} 21:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:23:29 INFO - Cleaning up... 21:23:29 INFO - Return code: 0 21:23:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:23:29 INFO - Using env: {'DISPLAY': ':0', 21:23:29 INFO - 'HOME': '/home/cltbld', 21:23:29 INFO - 'LANG': 'en_US.UTF-8', 21:23:29 INFO - 'LANGUAGE': 'en_US:en', 21:23:29 INFO - 'LOGNAME': 'cltbld', 21:23:29 INFO - 'MAIL': '/var/mail/cltbld', 21:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:29 INFO - 'MOZ_NO_REMOTE': '1', 21:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:29 INFO - 'NO_EM_RESTART': '1', 21:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:29 INFO - 'PWD': '/builds/slave/test', 21:23:29 INFO - 'SHELL': '/bin/bash', 21:23:29 INFO - 'SHLVL': '1', 21:23:29 INFO - 'TERM': 'linux', 21:23:29 INFO - 'TMOUT': '86400', 21:23:29 INFO - 'USER': 'cltbld', 21:23:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:29 INFO - '_': '/tools/buildbot/bin/python'} 21:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:29 INFO - Downloading/unpacking blobuploader==1.2.4 21:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:31 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:32 INFO - Downloading docopt-0.6.1.tar.gz 21:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:32 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:32 INFO - Running setup.py install for blobuploader 21:23:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:32 INFO - Running setup.py install for requests 21:23:32 INFO - Running setup.py install for docopt 21:23:33 INFO - Successfully installed blobuploader requests docopt 21:23:33 INFO - Cleaning up... 21:23:33 INFO - Return code: 0 21:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:33 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:33 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 21:23:33 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 21:23:33 INFO - Using env: {'DISPLAY': ':0', 21:23:33 INFO - 'HOME': '/home/cltbld', 21:23:33 INFO - 'LANG': 'en_US.UTF-8', 21:23:33 INFO - 'LANGUAGE': 'en_US:en', 21:23:33 INFO - 'LOGNAME': 'cltbld', 21:23:33 INFO - 'MAIL': '/var/mail/cltbld', 21:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:33 INFO - 'MOZ_NO_REMOTE': '1', 21:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:33 INFO - 'NO_EM_RESTART': '1', 21:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:33 INFO - 'PWD': '/builds/slave/test', 21:23:33 INFO - 'SHELL': '/bin/bash', 21:23:33 INFO - 'SHLVL': '1', 21:23:33 INFO - 'TERM': 'linux', 21:23:33 INFO - 'TMOUT': '86400', 21:23:33 INFO - 'USER': 'cltbld', 21:23:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:33 INFO - '_': '/tools/buildbot/bin/python'} 21:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:33 INFO - Running setup.py (path:/tmp/pip-wulbrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:33 INFO - Running setup.py (path:/tmp/pip-5BYyVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:33 INFO - Running setup.py (path:/tmp/pip-u69erv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:33 INFO - Running setup.py (path:/tmp/pip-JyWLzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:33 INFO - Running setup.py (path:/tmp/pip-jX2584-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:33 INFO - Running setup.py (path:/tmp/pip-GUxax0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:33 INFO - Running setup.py (path:/tmp/pip-gle8EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:33 INFO - Running setup.py (path:/tmp/pip-Yx_Cfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:33 INFO - Running setup.py (path:/tmp/pip-stnSxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:34 INFO - Running setup.py (path:/tmp/pip-hC8eJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:34 INFO - Running setup.py (path:/tmp/pip-gi8WVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:34 INFO - Running setup.py (path:/tmp/pip-GuC81a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:34 INFO - Running setup.py (path:/tmp/pip-KZBGiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:34 INFO - Running setup.py (path:/tmp/pip-MwKzcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:34 INFO - Running setup.py (path:/tmp/pip-ankMSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:34 INFO - Running setup.py (path:/tmp/pip-0o2eAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:34 INFO - Running setup.py (path:/tmp/pip-Y8a_55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:34 INFO - Running setup.py install for manifestparser 21:23:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Running setup.py install for mozcrash 21:23:34 INFO - Running setup.py install for mozdebug 21:23:34 INFO - Running setup.py install for mozdevice 21:23:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozfile 21:23:35 INFO - Running setup.py install for mozhttpd 21:23:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozinfo 21:23:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozInstall 21:23:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozleak 21:23:35 INFO - Running setup.py install for mozlog 21:23:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for moznetwork 21:23:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozprocess 21:23:35 INFO - Running setup.py install for mozprofile 21:23:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozrunner 21:23:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:36 INFO - Running setup.py install for mozscreenshot 21:23:36 INFO - Running setup.py install for moztest 21:23:36 INFO - Running setup.py install for mozversion 21:23:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:36 INFO - Cleaning up... 21:23:36 INFO - Return code: 0 21:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:36 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:36 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 21:23:36 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 21:23:36 INFO - Using env: {'DISPLAY': ':0', 21:23:36 INFO - 'HOME': '/home/cltbld', 21:23:36 INFO - 'LANG': 'en_US.UTF-8', 21:23:36 INFO - 'LANGUAGE': 'en_US:en', 21:23:36 INFO - 'LOGNAME': 'cltbld', 21:23:36 INFO - 'MAIL': '/var/mail/cltbld', 21:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:36 INFO - 'MOZ_NO_REMOTE': '1', 21:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:36 INFO - 'NO_EM_RESTART': '1', 21:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:36 INFO - 'PWD': '/builds/slave/test', 21:23:36 INFO - 'SHELL': '/bin/bash', 21:23:36 INFO - 'SHLVL': '1', 21:23:36 INFO - 'TERM': 'linux', 21:23:36 INFO - 'TMOUT': '86400', 21:23:36 INFO - 'USER': 'cltbld', 21:23:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:36 INFO - '_': '/tools/buildbot/bin/python'} 21:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:36 INFO - Running setup.py (path:/tmp/pip-BGIVtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:36 INFO - Running setup.py (path:/tmp/pip-n7PxrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:36 INFO - Running setup.py (path:/tmp/pip-TbR1Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:36 INFO - Running setup.py (path:/tmp/pip-VarslS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:36 INFO - Running setup.py (path:/tmp/pip-fRkZlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:36 INFO - Running setup.py (path:/tmp/pip-OZk8_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:37 INFO - Running setup.py (path:/tmp/pip-9IoFFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:37 INFO - Running setup.py (path:/tmp/pip-WRaWug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:37 INFO - Running setup.py (path:/tmp/pip-hzmALg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:37 INFO - Running setup.py (path:/tmp/pip-RenGBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:37 INFO - Running setup.py (path:/tmp/pip-vewqYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:37 INFO - Running setup.py (path:/tmp/pip-yYaGnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:37 INFO - Running setup.py (path:/tmp/pip-18PdDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:37 INFO - Running setup.py (path:/tmp/pip-mJLcUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:37 INFO - Running setup.py (path:/tmp/pip-1O5Lyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:37 INFO - Running setup.py (path:/tmp/pip-NKs53u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:37 INFO - Running setup.py (path:/tmp/pip-zJnWkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:39 INFO - Downloading blessings-1.6.tar.gz 21:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:39 INFO - Installing collected packages: blessings 21:23:39 INFO - Running setup.py install for blessings 21:23:39 INFO - Successfully installed blessings 21:23:39 INFO - Cleaning up... 21:23:40 INFO - Return code: 0 21:23:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:40 INFO - Reading from file tmpfile_stdout 21:23:40 INFO - Current package versions: 21:23:40 INFO - argparse == 1.2.1 21:23:40 INFO - blessings == 1.6 21:23:40 INFO - blobuploader == 1.2.4 21:23:40 INFO - docopt == 0.6.1 21:23:40 INFO - functools32 == 3.2.3-2 21:23:40 INFO - jsonschema == 2.5.1 21:23:40 INFO - manifestparser == 1.1 21:23:40 INFO - mozInstall == 1.12 21:23:40 INFO - mozcrash == 0.17 21:23:40 INFO - mozdebug == 0.1 21:23:40 INFO - mozdevice == 0.48 21:23:40 INFO - mozfile == 1.2 21:23:40 INFO - mozhttpd == 0.7 21:23:40 INFO - mozinfo == 0.9 21:23:40 INFO - mozleak == 0.1 21:23:40 INFO - mozlog == 3.4 21:23:40 INFO - moznetwork == 0.27 21:23:40 INFO - mozprocess == 0.23 21:23:40 INFO - mozprofile == 0.28 21:23:40 INFO - mozrunner == 6.12 21:23:40 INFO - mozscreenshot == 0.1 21:23:40 INFO - mozsystemmonitor == 0.3 21:23:40 INFO - moztest == 0.7 21:23:40 INFO - mozversion == 1.4 21:23:40 INFO - psutil == 3.1.1 21:23:40 INFO - requests == 1.2.3 21:23:40 INFO - wsgiref == 0.1.2 21:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:40 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:40 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 21:23:40 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 21:23:40 INFO - Using env: {'DISPLAY': ':0', 21:23:40 INFO - 'HOME': '/home/cltbld', 21:23:40 INFO - 'LANG': 'en_US.UTF-8', 21:23:40 INFO - 'LANGUAGE': 'en_US:en', 21:23:40 INFO - 'LOGNAME': 'cltbld', 21:23:40 INFO - 'MAIL': '/var/mail/cltbld', 21:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:40 INFO - 'MOZ_NO_REMOTE': '1', 21:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:40 INFO - 'NO_EM_RESTART': '1', 21:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:40 INFO - 'PWD': '/builds/slave/test', 21:23:40 INFO - 'SHELL': '/bin/bash', 21:23:40 INFO - 'SHLVL': '1', 21:23:40 INFO - 'TERM': 'linux', 21:23:40 INFO - 'TMOUT': '86400', 21:23:40 INFO - 'USER': 'cltbld', 21:23:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:40 INFO - '_': '/tools/buildbot/bin/python'} 21:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 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)) 21:23:40 INFO - Cleaning up... 21:23:40 INFO - Return code: 0 21:23:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:40 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 0x7fdc57b97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', '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 21:23:40 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 21:23:40 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 21:23:40 INFO - Using env: {'DISPLAY': ':0', 21:23:40 INFO - 'HOME': '/home/cltbld', 21:23:40 INFO - 'LANG': 'en_US.UTF-8', 21:23:40 INFO - 'LANGUAGE': 'en_US:en', 21:23:40 INFO - 'LOGNAME': 'cltbld', 21:23:40 INFO - 'MAIL': '/var/mail/cltbld', 21:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:40 INFO - 'MOZ_NO_REMOTE': '1', 21:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:40 INFO - 'NO_EM_RESTART': '1', 21:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:40 INFO - 'PWD': '/builds/slave/test', 21:23:40 INFO - 'SHELL': '/bin/bash', 21:23:40 INFO - 'SHLVL': '1', 21:23:40 INFO - 'TERM': 'linux', 21:23:40 INFO - 'TMOUT': '86400', 21:23:40 INFO - 'USER': 'cltbld', 21:23:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:40 INFO - '_': '/tools/buildbot/bin/python'} 21:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:40 INFO - Cleaning up... 21:23:40 INFO - Return code: 0 21:23:40 INFO - Running post-action listener: _resource_record_post_action 21:23:40 INFO - Running post-action listener: _start_resource_monitoring 21:23:40 INFO - Starting resource monitoring. 21:23:40 INFO - [mozharness: 2016-10-04 04:23:40.784487Z] Finished create-virtualenv step (success) 21:23:40 INFO - [mozharness: 2016-10-04 04:23:40.784952Z] Running install step. 21:23:40 INFO - Running pre-action listener: _resource_record_pre_action 21:23:40 INFO - Running main action method: install 21:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:40 INFO - Reading from file tmpfile_stdout 21:23:40 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:41 INFO - Reading from file tmpfile_stdout 21:23:41 INFO - Output received: 21:23:41 INFO - Usage: mozinstall [options] installer 21:23:41 INFO - Options: 21:23:41 INFO - -h, --help show this help message and exit 21:23:41 INFO - -d DEST, --destination=DEST 21:23:41 INFO - Directory to install application into. [default: 21:23:41 INFO - "/builds/slave/test"] 21:23:41 INFO - --app=APP Application being installed. [default: firefox] 21:23:41 INFO - mkdir: /builds/slave/test/build/application 21:23:41 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'] 21:23:41 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 21:23:58 INFO - Reading from file tmpfile_stdout 21:23:58 INFO - Output received: 21:23:58 INFO - /builds/slave/test/build/application/firefox/firefox 21:23:58 INFO - Running post-action listener: _resource_record_post_action 21:23:58 INFO - [mozharness: 2016-10-04 04:23:58.108578Z] Finished install step (success) 21:23:58 INFO - [mozharness: 2016-10-04 04:23:58.108823Z] Running run-tests step. 21:23:58 INFO - Running pre-action listener: _resource_record_pre_action 21:23:58 INFO - Running main action method: run_tests 21:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:23:58 INFO - Python 2.7.3 21:23:58 INFO - Return code: 0 21:23:58 INFO - grabbing minidump binary from tooltool 21:23:58 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')]} 21:23:58 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 0x140a930>, '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 0x140b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140bcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:23:58 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 21:23:58 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 21:23:58 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 21:23:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:58 INFO - Return code: 0 21:23:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:23:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:23:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:23:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:23:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 21:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 21:23:58 INFO - Using env: {'DISPLAY': ':0', 21:23:58 INFO - 'HOME': '/home/cltbld', 21:23:58 INFO - 'LANG': 'en_US.UTF-8', 21:23:58 INFO - 'LANGUAGE': 'en_US:en', 21:23:58 INFO - 'LOGNAME': 'cltbld', 21:23:58 INFO - 'MAIL': '/var/mail/cltbld', 21:23:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:58 INFO - 'MOZ_NO_REMOTE': '1', 21:23:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:58 INFO - 'NO_EM_RESTART': '1', 21:23:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:58 INFO - 'PWD': '/builds/slave/test', 21:23:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:58 INFO - 'SHELL': '/bin/bash', 21:23:58 INFO - 'SHLVL': '1', 21:23:58 INFO - 'TERM': 'linux', 21:23:58 INFO - 'TMOUT': '86400', 21:23:58 INFO - 'USER': 'cltbld', 21:23:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061', 21:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:58 INFO - '_': '/tools/buildbot/bin/python'} 21:23:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 21:23:58 INFO - mozversion application_buildid: 20161003183003 21:23:58 INFO - mozversion application_changeset: 1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e 21:23:58 INFO - mozversion application_display_name: Nightly 21:23:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:58 INFO - mozversion application_name: Firefox 21:23:58 INFO - mozversion application_remotingname: firefox 21:23:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:23:58 INFO - mozversion application_vendor: Mozilla 21:23:58 INFO - mozversion application_version: 52.0a1 21:23:58 INFO - mozversion platform_buildid: 20161003183003 21:23:58 INFO - mozversion platform_changeset: 1bbd6e5a697ca8a7fefb31e91e7dd095d8dc9c4e 21:23:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:23:58 INFO - mozversion platform_version: 52.0a1 21:23:58 INFO - using testdate: 1475555038 21:23:58 INFO - actual date: 1475555038 21:23:58 INFO - starting webserver on 'localhost:36884' 21:23:58 INFO - SUITE-START | Running 2 tests 21:23:58 INFO - TEST-START | dromaeo_css 21:23:58 INFO - operating with platform_type : linux_ 21:23:58 INFO - Initialising browser for dromaeo_css test... 21:23:58 INFO - TEST-INFO | started process 32448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyEDABJ/profile http://localhost:36884/getInfo.html) 21:24:03 INFO - PROCESS | 32448 | __metrics Screen width/height:1600/1200 21:24:03 INFO - PROCESS | 32448 | colorDepth:24 21:24:03 INFO - PROCESS | 32448 | Browser inner width/height: 1024/697 21:24:03 INFO - PROCESS | 32448 | __metrics 21:24:03 INFO - PROCESS | 32448 | 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" 21:24:03 INFO - PROCESS | 32448 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:24:04 INFO - PROCESS | 32448 | console.error: PushService: 21:24:04 INFO - PROCESS | 32448 | stateChangeProcessEnqueue: Error transitioning state 21:24:04 INFO - PROCESS | 32448 | UnknownError 21:24:05 INFO - TEST-INFO | 32448: exit 0 21:24:05 INFO - Browser initialized. 21:24:05 INFO - Running cycle 1/1 for dromaeo_css test... 21:24:05 INFO - TEST-INFO | started process 32531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyEDABJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:17 INFO - PROCESS | 32531 | RSS: Main: 173674496 21:24:17 INFO - PROCESS | 32531 | 21:25:08 INFO - PROCESS | 32531 | 1475555108276 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] 21:27:19 INFO - PROCESS | 32531 | Cycle 1(1): loaded http://localhost:36884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36884/tests/dromaeo/cssquery-ext.html) 21:27:20 INFO - PROCESS | 32531 | RSS: Main: 320413696 21:27:20 INFO - PROCESS | 32531 | 21:30:23 INFO - PROCESS | 32531 | Cycle 1(1): loaded http://localhost:36884/tests/dromaeo/cssquery-ext.html (next: http://localhost:36884/tests/dromaeo/cssquery-jquery.html) 21:30:23 INFO - PROCESS | 32531 | RSS: Main: 280125440 21:30:23 INFO - PROCESS | 32531 | 21:33:25 INFO - PROCESS | 32531 | Cycle 1(1): loaded http://localhost:36884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36884/tests/dromaeo/cssquery-mootools.html) 21:33:26 INFO - PROCESS | 32531 | RSS: Main: 215564288 21:33:26 INFO - PROCESS | 32531 | 21:36:28 INFO - PROCESS | 32531 | Cycle 1(1): loaded http://localhost:36884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36884/tests/dromaeo/cssquery-prototype.html) 21:36:29 INFO - PROCESS | 32531 | RSS: Main: 217260032 21:36:29 INFO - PROCESS | 32531 | 21:39:31 INFO - PROCESS | 32531 | Cycle 1(1): loaded http://localhost:36884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36884/tests/dromaeo/cssquery-yui.html) 21:39:32 INFO - PROCESS | 32531 | RSS: Main: 215171072 21:39:32 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | Cycle 1(1): loaded http://localhost:36884/tests/dromaeo/cssquery-yui.html (next: http://localhost:36884/tests/dromaeo/cssquery-dojo.html) 21:42:35 INFO - PROCESS | 32531 | RSS: Main: 305623040 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | __start_tp_report 21:42:35 INFO - PROCESS | 32531 | _x_x_mozilla_page_load 21:42:35 INFO - PROCESS | 32531 | _x_x_mozilla_page_load_details 21:42:35 INFO - PROCESS | 32531 | |i|pagename|runs| 21:42:35 INFO - PROCESS | 32531 | |0;dojo.html;2987.1934577664033;3018.6377634683827;3019.3810268894877;3045.086474057782;3067.7699172562047;5088.033273677998;5135;5174.586033117351;5257.737113144347;5275.525202731754;5217.582593392529;5223.947760522394;5316.707581083039;5365;5409.918851217235;4747.1929771938685;4783.593394561466;4842.806287748504;4850.757462126897;4865.391826021747;4897.730624815634;4937.185364414867;4938.506149385069;4939.555440010398;4977.55202031817;4630.050839577879;4680.789364478606;4684.0866031123605;4933.383327084114;4940.827071052496;4743.193657078271;4744.478107408182;4746.572808447222;4748.596369308613;4750.50119737426;4654.185517534418;4676.766161691936;4678.157931572316;4680.625549955996;4684.297355396684;5048.29323894655;5060.342155519759;5122.590192784568;5124.436312005676;5141.948580514184;5495.862603434906;5530.972345138289;5577.079781835992;5578.414266501999;5590.8043218487155;5536.501714845684;5627.2684551008515;5633.915491267634;5638.520725738276;5640.464155905182;5193.043598794079;5203.973980130113;5238.240455134022;5251.10731175701;5316.680999139987;5548.69482178476;5600.523955463831;5614.157876318585;5634.690092044895;5675.517581005661;5436.836894893159;5453.972730136404;5461.535769459561;5462.2079798429;5462.6995515247045;5549.639273447213;5554.08357620988;5557.638753481011;5558.249636299129;5628.352739434936;5408.296921400193;5483.314585676791;5520.1167813150505;5559.360673522597;5583.972080139573;5620.4660557247;5622.128570071645;5622.91565626516;5682.261306030189;5682.687452190086;4365.170617582649;4366.3013917773005;4370.016746232072;4373.234683930299;4425.026494171278;3718.3492888744363;3740.0836794985403;3766.5668448128267;3803.82882770276;3830.559485659129;5367.865803354947;5369.40936496985;5371.543418809367;5400.270963419966;5411.702356370437;5605.7197140142825;5646.2942132233475;5656.179853921159;5658.264425624642;5665.858353541194;5137.743112844343;5247.711375874287;5248.475152484721;5308.893822123536;5416;4892.828750993698;4898.951010489921;4902.3872015998;4921.680090794087;4959.82640607577;5790.971045144747;5793.855153621109;5799.594028417971;5807.680577568274;5864.9706751467675;5417.918731218956;5459.317585301837;5467.808626698046;5554.1391084381985;5562.499375056264;5701.942980570141;5719.685417302088;5779.988502012216;5843.590948633555;5846.386129456346;5562.972185139049;5569.944300557105;5572.9968605651375;5573.3869274380595;5640.464155905182;5633.8309850704545;5648.265725455664;5682.857928551819;5698.629589076862;5700.372958974426;5308.708021058879;5360.946390536044;5421.078416669096;5463.207834864002;5563.7774489019985;5517.69652669107;5521.723913804374;5524.198991146181;5559.16612508127;5585.636933599303;5427.050266203478;5439.945600543944;5441.21102440136;5446.1558458439;5449.455054494519;5221.190715439113;5348.331458567679;5447.645903016291;5532.529734972572;5591.692456914909;5330.253764472899;5383.300170977748;5417.997670430983;5471.835844924659;5478.452154784649 21:42:35 INFO - PROCESS | 32531 | |1;ext.html;545.6207935484837;603.4900509069836;614.8923938310797;615.639850687348;631.9462845658119;33058.50412243815;41285.17429651405;42419.78790106053;42572.14855702888;46244;43706.562934370646;43981.56018439815;44134.55865441345;44138.55861441392;44376.77811610945;8182.549959752211;9019.143181397756;9172.266218702487;9181.632734690638;9186.265098792113;8124.715634952778;10563.894361056406;10847.240693151483;10849.457527123652;11252.887471125267;11073.114150867912;11134.721631959184;11144.275622084579;11151.944240278828;11153.386563738992;10839;10914.836277455805;10919.890801092046;10920.672379828618;10928.125749939985;10758.784824303548;10815.18886083547;10826.350418974887;10827.404492752896;10835.83746243799;41533.37699934503;41768.37347439791;41905.3904070552;41919.58080419187;41997.160056798995;3508.789472631625;3645.5078564394;3695.5380577427823;3823.3500304948225;4009.3985902114623;31414.528782068286;31627.52558711621;32039.51940720891;32045.679543204504;33815;4031.97984010081;4171.436856024428;4182;4312.331588603772;4331.7834108294455;318728;320111;321214.9999999977;321316;321541;54406;54783;54786;54834.45165548293;54884;35864.64135358665;58504.70747646235;58515.70742146347;58558.414415855295;58605.12092318619;14942.70114597702;15681.372745090068;15688.843111568967;15724.60688482797;15730;10784.352938823695;10800.891991080145;10871.67384978452;11087.113030957504;11722.76554468923;18150.727739083923;18566.72149917752;18662.626747464976;18781.530461738566;18816.811831881507;5774.595778295479;7054.6472676365975;7064.540804847668;7389.556626602421;7442.553446793209;919.2186641354929;1056.8203405421098;1056.8467572202142;1059.3908502610875;1133.6712353417417;29883.252918677208;30090.84954575213;31185.688143118277;32159.67840321567;32210.516842247383;1069.652362982034;1111.6442738323658;1147.2370873369282;1162.1167912386647;1162.8023236049892;16602.75095873563;16698.83301166997;16707.49877503677;16839.415730561403;16840.915795420944;517911;523909;524071;525254;527101;56399.43600564024;56861.715691421276;56910.430895691345;57122;57135;1196.8264601632713;1240.193873981919;1282.1089342906591;1327.555268984901;1334.339501946562;29301.85349073241;32317.192070198435;32339.51490727688;32501.34997300088;32943.34113317768;48147.5185248143;48757;48761.5123848757;48818.5118148814;48830.75584622054;372108;372750;373009;373641;374187;27077.86461067682;27772.166834994983;27901.302467438476;28049.859750701115;28230.43539129165;37550.624493754716;38502.6149738499;44258.33612495751;45512.54487455083;46887.531124688314;38758.4186237201;39273;39873.2025359497;40310;41658;40042.1991560173;40759.1848163041;41195.29670219985;41535.169296614506;41757.37363939483;39619.405708913815;39934;41019.1796164081;41156.79421602873;41166.58833411628;32116.270117040312;36083.63916360803;36159.908840565695;36665.63334366729;36830;26916.865415672797;27185;27322.726772732018;27431.314217144733;27479.244868071546 21:42:35 INFO - PROCESS | 32531 | |2;jquery.html;379.3645643547058;383.6336298834613;391.2507548045492;398.6651212981095;418.4079527468632;14026;14148.646283842909;17566.47300580983;19158.616827663456;19182.712259316104;14837.85162148381;17503.649927001454;17814.732779008293;18857.90571047143;19296.324628638;5687.857803554903;5844.941550584483;5906.586538942276;5910.734016969225;5914.615549989237;5663.943360566383;5805.361410244891;5822.796202132926;5830.4169583041785;5845.941540584604;5541.113421852504;5796.5652576056755;5797.072468405056;5797.797077102302;5799.623024503394;5718.056520674084;5753.510951569101;5767.106098554731;5795.9420405796245;5807.941920580783;5030.547250747451;5226.843194704165;5231.633785635007;5233.502817232356;5289.338832645919;12921.67695807603;12967.546135885294;13143.53997610079;13179.341032948314;18586;2123.437289118385;2314.2131675230335;2339.3683705399617;2361.303415492434;2481.2928315430017;9788.314817962746;9834.459104749307;9927.602895884229;10367.585296588128;10527.947360263226;1757.9736303955451;1786.7409225662336;1901.5056085417752;1939.1467754188252;2040.0819631166034;80977;82725;83169.58415207946;85196.57401712952;87233.12766872313;10520.894791051991;10761.730956725987;10813.459327033617;10823.296485728402;10972.615958441416;15042.548723538312;15156.772648410282;15162.772558411632;15173.924130379277;15176.620584485476;7599.0123456790125;7756.340711039625;7860.9213907860185;8020.598970051474;8032.15662355456;6733.3266673333255;7040.2607726189035;7061.926743001015;7296.015037969913;7656.540607563453;4466.57567531084;4481.5070342262325;4522.208613492691;4613.677042606985;4858.271259311132;1813.4468986959105;1822.772153480815;1850.5651171974575;1876.7372567840514;1940.8932508712157;869.3132425384002;952.0812416018437;980.4508278475905;1047.0838016735356;1056.0759335581367;17766.289348426177;18142.274309027754;18151.273949042155;18255.72616410755;18419.907900460414;954.0459540459541;955.4171955107379;957;965.1795973422535;979.5249304087512;9407.388519746195;9640.71077867665;9894.406335619886;9985.900140998643;10069.899301007043;331117;335924;339375;454094;499447;92556;96517;97077;97731;99435.50282248542;909.2362415570952;925.7130289610243;938.2728385501291;959.4627008875052;961.2694352292308;15711.450099246471;16385.180740963144;16511.587210319838;16950.66098677995;16953.91523042377;42168.36747448729;42252;42674;43277.56722432735;44580.33129503125;55249;55432;56215.43784562102;56655.43344566502;60636.696816515636;7562.987514641102;7659.272369124924;7716.498427602188;7784.104827944859;7940.960295198487;8495.8725619117;10908.290961087503;11184.217104802585;11529.135314851588;11798.941005294919;5772.913406298993;10335.116166626043;10657.520411581343;10815;11238.83141752858;9674.7581310465;10588.311759735592;10700.41147736882;10822.458877056273;11081.72295692582;10376.481175941022;10596.735081623021;10649.201309901633;10900.509477073709;10909.836352454879;7512.361449276873;7816.804579885548;7886.003318738843;8017;8205.58972051407;10459.110975567162;10489.632862849763;10499.842502362624;10703.19726020536;10806.459677016275 21:42:35 INFO - PROCESS | 32531 | |3;mootools.html;1340.0753480098738;1462.6782107936253;1496.2369191712228;1620.1737114071827;1805.8555315574756;7627.351675107616;8690.782730431734;8916.286697064235;8934.329925255608;9231.261499080074;8999.865002024959;9073;9080.455172689642;9082.046385129566;9085.227755640763;2360.3509035015422;2366.5621859955963;2385.057902128658;2387.844790088647;2392.5095355452177;2315.1086831569883;2336.9883150584224;2369.1944738788807;2370.182287110944;2373.4541055557233;2231.4979129695853;2268.160780511205;2280.737715162761;2301.631738921773;2308.319045881469;2246.4159318577126;2274.7270327560714;2279.1453205048106;2280.247518318959;2281.281396360158;2233.463968647513;2245.7641947595594;2246.528229071897;2250.414892128042;2251.0883092347626;8822.823543529157;8884.11158884113;8884.378093533454;8910.86633700495;9009.684661036898;5355.785768569292;5634.211210430543;5646.378898321182;5654.293213348332;5658.830235092953;3434.759566830323;3480.286541259036;3537.6992955598803;3543.0965103898598;3573.0531409176588;1082.107261509258;1105.8285965675334;1107.7729065541544;1129.1926272715048;1133.0369186191754;12689.23864568129;12696.619101426972;12772.936135319356;12784.872151278461;12851.228926264454;4379.277419225856;4710.69380490267;4749.26386410107;4765.8093676252565;4846.200376937766;10038.849417258602;10039.34744241622;10039.69880903574;10047.497625118714;10055.597776088875;5469.507744303032;5481.424450432727;5492.505674489315;5496.560275177976;5497.615166938276;4315.762633055149;4399.494058183286;4782.689125206851;4859.757012149449;5082.847514574569;3699.445083237536;3722.9441558376648;3753.6246375362243;3835.463035175078;3837.2325534893134;1185.3539820797687;1198.0475521960063;1200.8138738495547;1206.7043574324346;1210.4552951171831;913.4701872913694;923.9122283383068;934.5233930695395;938.483833891357;948.0661548374845;5745.1825028104;5820.738066787005;5979.850503737442;6137.171481849982;6172.105044768573;427.09242858924785;427.3013622726864;431.3012919071125;439.25984715754055;443.76480465353416;3839.539255289383;3964.1278918637854;3982.7056206732927;3996.8401263949117;4052.1287923096675;11256.718582035352;11569.942150289195;11685.532578696926;11693;11694.76610467786;11545.653630391102;11644.941775291069;11653.41732913351;11658.06735461161;11665.825012624817;8252.133525979805;8320.66717331312;8440.66237350499;8474.322054235647;8523.105073967145;5668.404817494104;5693.4875861172695;5819.127130930395;5829;5867.32525759526;10385.221108416748;10396.792064158522;10434.530446129791;10505.212109092;10658.467076646291;10313.381197128196;10579.418132002813;10849.728756781144;10856.45717714127;10882.727931801768;6710.664466776544;6875.3812156906115;6878.55289406187;7425.257474252531;7541.2458754124145;7959.681612735426;8006.959965200137;8320.791980200544;8430;8571.357148213785;7637.618119094134;7661.425393095652;7767.92232077672;7876.09424916119;8086.393520485869;7401.555906645618;7527.661255243418;7607.23927607257;7780.84438311242;7877.6455059523605;7022.508424410242;7127.607981561064;7141.82145446368;7144.85710285781;7145.749898753519;4998.925016124688;5004.198488544049;5007.173816320412;5084.161113416245;5247.763850626655;5048.469910659474;5074.695518268915;5100.719460429712;5141.177411614124;5218.66078704883 21:42:35 INFO - PROCESS | 32531 | |4;prototype.html;318.5031351092296;339.29088205650214;341.1028993746445;343.5276494819623;345.0442274898531;5189.728516513454;5261.473852614737;5268.525832675058;5279.86800329991;5304.177852432879;5142.357205349332;5159.561437277826;5216.504432078956;5236.633435659496;5260.763265653045;3877.9806100969454;4112.362583799516;4128.256913755516;4162.875113746577;4168.312228482297;4108.630223279904;4112.712110152291;4135.27632664284;4142.896427589304;4150.460440142777;4067.877963661095;4068.572799856017;4083.5712250213746;4093.8362465501345;4113.547509773923;3890.3775395936796;3906.511686039245;3986.3223252047223;4002.2195671844;4100.118474527976;3520.2255503789124;3524.9823750881083;3532.6290739472242;3532.858685652571;3535.4520049392386;5023.598112151019;5043.924341134886;5066.771995260222;5075.365579302587;5102.209157580543;4372.956270437287;4431.357453169272;4604.125216208943;4622.6301895848255;4644.7213167210075;5295.391030031557;5320.600954928396;5325.866853328659;5328.866778330573;5340.786368545292;3962.366021436585;3966.7619942803235;3981.223661386002;3986.681065514752;3989.202159568098;5407.837314977299;5602.411746766572;5605.971970140164;5645.459543205574;5648.293963254593;3902.9609703903166;3932.410138479251;3943.428202910562;3946.2699400610977;3964.643182113566;4006.579309172553;4018.4374187613757;4020.4170395292517;4025.1949610077518;4027.597240275949;4477.104579084196;4569.771511424416;4607.424071991001;4607.792649330721;4618.792154352995;5366.892662146735;5369.4630536946;5370.388883334984;5422.15956526739;5451.454854514596;1404.2487269311073;1410.05526297381;1411.9011669183265;1417.6030711400824;1419.5741277616673;839.1440730454901;912.7946212102224;913.5569248914271;921.8615010462074;932.5943214701626;4564.338170965258;4571.588557029883;4618.198902428056;4620.643471829391;4633.374494443207;4844.4186697596515;4861.319415281863;4887.828925987574;4972.085746987436;4979.402471703419;4382.37851994764;4692.671512994126;4716.740579268173;4719.9292010619865;4737.8104875805275;2585.935351616187;2595.493878693637;2609.908653197167;2614.75159859813;2622.9246009136164;4973.477784832613;4989.550940415307;5036.84889453317;5063.949360506348;5064.82273120439;4767.73777442244;4928.8170838998385;4943.615787579483;4948.529889660476;5013.974930125326;4937.580305673986;4959.181735013683;5005.299258103868;5006.274090256819;5010.574101201439;4851.937926381344;4856.975715121402;4884.242942343943;4901.828436004723;4906.681065730716;4488.573585509372;4816.627261230673;4837.95162048375;4863.3434486343895;4895.583875370633;4869.659123861437;5016.423111342242;5037.622178336566;5064.569511591556;5082.796688132434;3713.85144594224;3733.8879833605033;3753.5495740511315;3754.6433088856515;3766.6798322142927;4959.925601115914;4991.9500804991485;5000.849974500771;5003.374578177728;5227.3465816772905;5339.385970613429;5371.946280537145;5433.347998240079;5457.945420545744;5464.289642346628;5424.18289872897;5452.427495112956;5454.8909021818545;5475.479829416199;5501.972490137524;5218.504242096995;5346.144616861284;5377.892442151213;5391.946080539301;5449.5640348772795;5216.921746173734;5339.439358867263;5370.731463426891;5427.701476418677;5494.27492356581;5364.812231572032;5372.247885295984;5388.892222155613;5390.730463476889;5409.459054094559 21:42:35 INFO - PROCESS | 32531 | |5;yui.html;737.6680493777801;739.3641468337231;768.7117331000875;802.2258520527689;812;16193.676126477463;16894.324227030906;17082.743758843626;17084.48746537604;17137.314507419705;14385.1368917865;14583.34374953127;14614;14615.561533153996;14647.267636618153;655.2595567009297;669.2470970158572;672.2235817630644;785.5247575216982;806.2864365036926;668.5320275806955;669.0967194287697;766.7508059880533;787.0712559180165;787.5117427195147;839.6515446089866;847.7117779954814;850.3749743938231;850.7660393391805;850.9234168924795;842.2672275120684;842.8651415773478;842.9747107586721;843.2958479669453;843.4981186194266;509.91586388246265;523.6491550661028;601.3445344574391;615.1818081950994;615.5844804756816;14328.570142895729;15035.924820375938;15091.39634414622;15103.773443398359;15118.470853520184;13365.732685346336;13651.522196723066;13860.4455821767;14130.576082717433;14276.357563909649;11914.623439367806;12208.511659533608;12226.938865305705;12541.372931353395;12625.179363341445;4256.957430425687;4304.978475107604;4327.7619730914785;4333.718308309982;4475.865724028285;78736.60631696862;79182;80396;85545.57227213948;85546.57226713827;11139.665810025712;11336;11653.825192622118;11670.772105665485;11777.764444711058;21055.263065792624;21097.78902210989;21114.472138196666;21126.78873211279;21235.362939111852;8594.441361311494;8672.26285765717;8710.346723995726;9019.819603607892;9030.322725795591;4696.694714843524;4708.4349878014855;4711.411073615798;4765.404324459442;4911.533404326583;3459.9654003460146;3553.307105114478;3555.040139162463;3558.1994051338243;3558.822058897045;633.7465013994439;639.8752243312509;651.371426573359;660.2901880478505;668.5353679193012;562.6146089928412;571.5256337240164;648.7307767276621;654.107143748789;659.8383396067994;7620.161782203953;7984.161663025415;8216.424850260544;8828.514431706319;9023.458592484472;576.4149388370807;603.0231025738332;603.1766638538363;635.972769616619;652.9804105876831;4134.297169481196;4238.406623072772;4346.152500262482;4360.825566977349;4418.558144185556;101172;116789;129224.35387823;131466.34266828795;131774;103973.48013259885;105368.47315763525;108278;110945.44527277474;111927;93412;94648;95898;96143;97635;7967.203279671987;7989.560574168477;8148.348132149533;8331.750047498585;8501.234888859784;52416.68958276074;52576.21135683044;52733.7363313181;53794.19308710294;56605.71697141488;72673.63663181651;73945.26054739383;79487.20512794798;81487.18512814796;85321.57339213512;10890.564377424815;11144.442777861237;11402.315861048031;11545.538178472767;11637.127215459044;11665;11698.532058717556;11920.523179073087;11969.880301196876;12002.75994480123;10479.94760026195;10628.320731266753;10738.302010369613;10850.186236032172;11340.94329528347;10962.616308429167;11163.162762792985;11167.497462614365;11243.156763242627;11252.549898004316;10633.840492392776;10649.969413789047;10744;10924.672259832218;11013.614523491638;9246.398984066283;9369.625214991323;9516.476593787409;9604.471754053315;9649.324547281623;8811.515366654896;9233.769155770891;9419.529023548932;9505.441932783093;9800.607975681178 21:42:35 INFO - PROCESS | 32531 | __end_tp_report 21:42:35 INFO - PROCESS | 32531 | __start_cc_report 21:42:35 INFO - PROCESS | 32531 | _x_x_mozilla_cycle_collect,1363 21:42:35 INFO - PROCESS | 32531 | __end_cc_report 21:42:35 INFO - PROCESS | 32531 | __startTimestamp1475556155618__endTimestamp 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | ------- Summary: start ------- 21:42:35 INFO - PROCESS | 32531 | Number of tests: 6 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | [#0] dojo.html Cycles:165 Average:5204.17 Median:5417.92 stddev:584.43 (10.8%) stddev-sans-first:559.75 21:42:35 INFO - PROCESS | 32531 | Values: 2987.2 3018.6 3019.4 3045.1 3067.8 5088.0 5135.0 5174.6 5257.7 5275.5 5217.6 5223.9 5316.7 5365.0 5409.9 4747.2 4783.6 4842.8 4850.8 4865.4 4897.7 4937.2 4938.5 4939.6 4977.6 4630.1 4680.8 4684.1 4933.4 4940.8 4743.2 4744.5 4746.6 4748.6 4750.5 4654.2 4676.8 4678.2 4680.6 4684.3 5048.3 5060.3 5122.6 5124.4 5141.9 5495.9 5531.0 5577.1 5578.4 5590.8 5536.5 5627.3 5633.9 5638.5 5640.5 5193.0 5204.0 5238.2 5251.1 5316.7 5548.7 5600.5 5614.2 5634.7 5675.5 5436.8 5454.0 5461.5 5462.2 5462.7 5549.6 5554.1 5557.6 5558.2 5628.4 5408.3 5483.3 5520.1 5559.4 5584.0 5620.5 5622.1 5622.9 5682.3 5682.7 4365.2 4366.3 4370.0 4373.2 4425.0 3718.3 3740.1 3766.6 3803.8 3830.6 5367.9 5369.4 5371.5 5400.3 5411.7 5605.7 5646.3 5656.2 5658.3 5665.9 5137.7 5247.7 5248.5 5308.9 5416.0 4892.8 4899.0 4902.4 4921.7 4959.8 5791.0 5793.9 5799.6 5807.7 5865.0 5417.9 5459.3 5467.8 5554.1 5562.5 5701.9 5719.7 5780.0 5843.6 5846.4 5563.0 5569.9 5573.0 5573.4 5640.5 5633.8 5648.3 5682.9 5698.6 5700.4 5308.7 5360.9 5421.1 5463.2 5563.8 5517.7 5521.7 5524.2 5559.2 5585.6 5427.1 5439.9 5441.2 5446.2 5449.5 5221.2 5348.3 5447.6 5532.5 5591.7 5330.3 5383.3 5418.0 5471.8 5478.5 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | [#1] ext.html Cycles:180 Average:56712.68 Median:36747.82 stddev:109802.55 (298.8%) stddev-sans-first:110029.59 21:42:35 INFO - PROCESS | 32531 | Values: 545.6 603.5 614.9 615.6 631.9 33058.5 41285.2 42419.8 42572.1 46244.0 43706.6 43981.6 44134.6 44138.6 44376.8 8182.5 9019.1 9172.3 9181.6 9186.3 8124.7 10563.9 10847.2 10849.5 11252.9 11073.1 11134.7 11144.3 11151.9 11153.4 10839.0 10914.8 10919.9 10920.7 10928.1 10758.8 10815.2 10826.4 10827.4 10835.8 41533.4 41768.4 41905.4 41919.6 41997.2 3508.8 3645.5 3695.5 3823.4 4009.4 31414.5 31627.5 32039.5 32045.7 33815.0 4032.0 4171.4 4182.0 4312.3 4331.8 318728.0 320111.0 321215.0 321316.0 321541.0 54406.0 54783.0 54786.0 54834.5 54884.0 35864.6 58504.7 58515.7 58558.4 58605.1 14942.7 15681.4 15688.8 15724.6 15730.0 10784.4 10800.9 10871.7 11087.1 11722.8 18150.7 18566.7 18662.6 18781.5 18816.8 5774.6 7054.6 7064.5 7389.6 7442.6 919.2 1056.8 1056.8 1059.4 1133.7 29883.3 30090.8 31185.7 32159.7 32210.5 1069.7 1111.6 1147.2 1162.1 1162.8 16602.8 16698.8 16707.5 16839.4 16840.9 517911.0 523909.0 524071.0 525254.0 527101.0 56399.4 56861.7 56910.4 57122.0 57135.0 1196.8 1240.2 1282.1 1327.6 1334.3 29301.9 32317.2 32339.5 32501.3 32943.3 48147.5 48757.0 48761.5 48818.5 48830.8 372108.0 372750.0 373009.0 373641.0 374187.0 27077.9 27772.2 27901.3 28049.9 28230.4 37550.6 38502.6 44258.3 45512.5 46887.5 38758.4 39273.0 39873.2 40310.0 41658.0 40042.2 40759.2 41195.3 41535.2 41757.4 39619.4 39934.0 41019.2 41156.8 41166.6 32116.3 36083.6 36159.9 36665.6 36830.0 26916.9 27185.0 27322.7 27431.3 27479.2 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | [#2] jquery.html Cycles:180 Average:25743.61 Median:4474.04 stddev:66688.26 (1490.6%) stddev-sans-first:66848.14 21:42:35 INFO - PROCESS | 32531 | Values: 379.4 383.6 391.3 398.7 418.4 14026.0 14148.6 17566.5 19158.6 19182.7 14837.9 17503.6 17814.7 18857.9 19296.3 5687.9 5844.9 5906.6 5910.7 5914.6 5663.9 5805.4 5822.8 5830.4 5845.9 5541.1 5796.6 5797.1 5797.8 5799.6 5718.1 5753.5 5767.1 5795.9 5807.9 5030.5 5226.8 5231.6 5233.5 5289.3 12921.7 12967.5 13143.5 13179.3 18586.0 2123.4 2314.2 2339.4 2361.3 2481.3 9788.3 9834.5 9927.6 10367.6 10527.9 1758.0 1786.7 1901.5 1939.1 2040.1 80977.0 82725.0 83169.6 85196.6 87233.1 10520.9 10761.7 10813.5 10823.3 10972.6 15042.5 15156.8 15162.8 15173.9 15176.6 7599.0 7756.3 7860.9 8020.6 8032.2 6733.3 7040.3 7061.9 7296.0 7656.5 4466.6 4481.5 4522.2 4613.7 4858.3 1813.4 1822.8 1850.6 1876.7 1940.9 869.3 952.1 980.5 1047.1 1056.1 17766.3 18142.3 18151.3 18255.7 18419.9 954.0 955.4 957.0 965.2 979.5 9407.4 9640.7 9894.4 9985.9 10069.9 331117.0 335924.0 339375.0 454094.0 499447.0 92556.0 96517.0 97077.0 97731.0 99435.5 909.2 925.7 938.3 959.5 961.3 15711.5 16385.2 16511.6 16950.7 16953.9 42168.4 42252.0 42674.0 43277.6 44580.3 55249.0 55432.0 56215.4 56655.4 60636.7 7563.0 7659.3 7716.5 7784.1 7941.0 8495.9 10908.3 11184.2 11529.1 11798.9 5772.9 10335.1 10657.5 10815.0 11238.8 9674.8 10588.3 10700.4 10822.5 11081.7 10376.5 10596.7 10649.2 10900.5 10909.8 7512.4 7816.8 7886.0 8017.0 8205.6 10459.1 10489.6 10499.8 10703.2 10806.5 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | [#3] mootools.html Cycles:180 Average:5848.08 Median:2419.38 stddev:3440.74 (142.2%) stddev-sans-first:3433.71 21:42:35 INFO - PROCESS | 32531 | Values: 1340.1 1462.7 1496.2 1620.2 1805.9 7627.4 8690.8 8916.3 8934.3 9231.3 8999.9 9073.0 9080.5 9082.0 9085.2 2360.4 2366.6 2385.1 2387.8 2392.5 2315.1 2337.0 2369.2 2370.2 2373.5 2231.5 2268.2 2280.7 2301.6 2308.3 2246.4 2274.7 2279.1 2280.2 2281.3 2233.5 2245.8 2246.5 2250.4 2251.1 8822.8 8884.1 8884.4 8910.9 9009.7 5355.8 5634.2 5646.4 5654.3 5658.8 3434.8 3480.3 3537.7 3543.1 3573.1 1082.1 1105.8 1107.8 1129.2 1133.0 12689.2 12696.6 12772.9 12784.9 12851.2 4379.3 4710.7 4749.3 4765.8 4846.2 10038.8 10039.3 10039.7 10047.5 10055.6 5469.5 5481.4 5492.5 5496.6 5497.6 4315.8 4399.5 4782.7 4859.8 5082.8 3699.4 3722.9 3753.6 3835.5 3837.2 1185.4 1198.0 1200.8 1206.7 1210.5 913.5 923.9 934.5 938.5 948.1 5745.2 5820.7 5979.9 6137.2 6172.1 427.1 427.3 431.3 439.3 443.8 3839.5 3964.1 3982.7 3996.8 4052.1 11256.7 11569.9 11685.5 11693.0 11694.8 11545.7 11644.9 11653.4 11658.1 11665.8 8252.1 8320.7 8440.7 8474.3 8523.1 5668.4 5693.5 5819.1 5829.0 5867.3 10385.2 10396.8 10434.5 10505.2 10658.5 10313.4 10579.4 10849.7 10856.5 10882.7 6710.7 6875.4 6878.6 7425.3 7541.2 7959.7 8007.0 8320.8 8430.0 8571.4 7637.6 7661.4 7767.9 7876.1 8086.4 7401.6 7527.7 7607.2 7780.8 7877.6 7022.5 7127.6 7141.8 7144.9 7145.7 4998.9 5004.2 5007.2 5084.2 5247.8 5048.5 5074.7 5100.7 5141.2 5218.7 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | [#4] prototype.html Cycles:180 Average:4374.40 Median:4886.04 stddev:1248.14 (25.5%) stddev-sans-first:1213.95 21:42:35 INFO - PROCESS | 32531 | Values: 318.5 339.3 341.1 343.5 345.0 5189.7 5261.5 5268.5 5279.9 5304.2 5142.4 5159.6 5216.5 5236.6 5260.8 3878.0 4112.4 4128.3 4162.9 4168.3 4108.6 4112.7 4135.3 4142.9 4150.5 4067.9 4068.6 4083.6 4093.8 4113.5 3890.4 3906.5 3986.3 4002.2 4100.1 3520.2 3525.0 3532.6 3532.9 3535.5 5023.6 5043.9 5066.8 5075.4 5102.2 4373.0 4431.4 4604.1 4622.6 4644.7 5295.4 5320.6 5325.9 5328.9 5340.8 3962.4 3966.8 3981.2 3986.7 3989.2 5407.8 5602.4 5606.0 5645.5 5648.3 3903.0 3932.4 3943.4 3946.3 3964.6 4006.6 4018.4 4020.4 4025.2 4027.6 4477.1 4569.8 4607.4 4607.8 4618.8 5366.9 5369.5 5370.4 5422.2 5451.5 1404.2 1410.1 1411.9 1417.6 1419.6 839.1 912.8 913.6 921.9 932.6 4564.3 4571.6 4618.2 4620.6 4633.4 4844.4 4861.3 4887.8 4972.1 4979.4 4382.4 4692.7 4716.7 4719.9 4737.8 2585.9 2595.5 2609.9 2614.8 2622.9 4973.5 4989.6 5036.8 5063.9 5064.8 4767.7 4928.8 4943.6 4948.5 5014.0 4937.6 4959.2 5005.3 5006.3 5010.6 4851.9 4857.0 4884.2 4901.8 4906.7 4488.6 4816.6 4838.0 4863.3 4895.6 4869.7 5016.4 5037.6 5064.6 5082.8 3713.9 3733.9 3753.5 3754.6 3766.7 4959.9 4992.0 5000.8 5003.4 5227.3 5339.4 5371.9 5433.3 5457.9 5464.3 5424.2 5452.4 5454.9 5475.5 5502.0 5218.5 5346.1 5377.9 5391.9 5449.6 5216.9 5339.4 5370.7 5427.7 5494.3 5364.8 5372.2 5388.9 5390.7 5409.5 21:42:35 INFO - PROCESS | 32531 | 21:42:35 INFO - PROCESS | 32531 | [#5] yui.html Cycles:180 Average:21344.65 Median:516.78 stddev:32578.71 (6304.1%) stddev-sans-first:32633.36 21:42:35 INFO - PROCESS | 32531 | Values: 737.7 739.4 768.7 802.2 812.0 16193.7 16894.3 17082.7 17084.5 17137.3 14385.1 14583.3 14614.0 14615.6 14647.3 655.3 669.2 672.2 785.5 806.3 668.5 669.1 766.8 787.1 787.5 839.7 847.7 850.4 850.8 850.9 842.3 842.9 843.0 843.3 843.5 509.9 523.6 601.3 615.2 615.6 14328.6 15035.9 15091.4 15103.8 15118.5 13365.7 13651.5 13860.4 14130.6 14276.4 11914.6 12208.5 12226.9 12541.4 12625.2 4257.0 4305.0 4327.8 4333.7 4475.9 78736.6 79182.0 80396.0 85545.6 85546.6 11139.7 11336.0 11653.8 11670.8 11777.8 21055.3 21097.8 21114.5 21126.8 21235.4 8594.4 8672.3 8710.3 9019.8 9030.3 4696.7 4708.4 4711.4 4765.4 4911.5 3460.0 3553.3 3555.0 3558.2 3558.8 633.7 639.9 651.4 660.3 668.5 562.6 571.5 648.7 654.1 659.8 7620.2 7984.2 8216.4 8828.5 9023.5 576.4 603.0 603.2 636.0 653.0 4134.3 4238.4 4346.2 4360.8 4418.6 101172.0 116789.0 129224.4 131466.3 131774.0 103973.5 105368.5 108278.0 110945.4 111927.0 93412.0 94648.0 95898.0 96143.0 97635.0 7967.2 7989.6 8148.3 8331.8 8501.2 52416.7 52576.2 52733.7 53794.2 56605.7 72673.6 73945.3 79487.2 81487.2 85321.6 10890.6 11144.4 11402.3 11545.5 11637.1 11665.0 11698.5 11920.5 11969.9 12002.8 10479.9 10628.3 10738.3 10850.2 11340.9 10962.6 11163.2 11167.5 11243.2 11252.5 10633.8 10650.0 10744.0 10924.7 11013.6 9246.4 9369.6 9516.5 9604.5 9649.3 8811.5 9233.8 9419.5 9505.4 9800.6 21:42:35 INFO - PROCESS | 32531 | -------- Summary: end -------- 21:42:35 INFO - PROCESS | 32531 | 21:42:36 INFO - TEST-INFO | 32531: exit 0 21:42:36 INFO - TEST-OK | dromaeo_css | took 1118225ms 21:42:36 INFO - TEST-START | kraken 21:42:36 INFO - operating with platform_type : linux_ 21:42:36 INFO - Initialising browser for kraken test... 21:42:36 INFO - TEST-INFO | started process 369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8EB9w8/profile http://localhost:36884/getInfo.html) 21:42:41 INFO - PROCESS | 369 | __metrics Screen width/height:1600/1200 21:42:41 INFO - PROCESS | 369 | colorDepth:24 21:42:41 INFO - PROCESS | 369 | Browser inner width/height: 1024/697 21:42:41 INFO - PROCESS | 369 | __metrics 21:42:41 INFO - PROCESS | 369 | 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" 21:42:41 INFO - PROCESS | 369 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:42 INFO - PROCESS | 369 | console.error: PushService: 21:42:42 INFO - PROCESS | 369 | stateChangeProcessEnqueue: Error transitioning state 21:42:42 INFO - PROCESS | 369 | UnknownError 21:42:43 INFO - TEST-INFO | 369: exit 0 21:42:43 INFO - Browser initialized. 21:42:43 INFO - Running cycle 1/1 for kraken test... 21:42:43 INFO - TEST-INFO | started process 452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8EB9w8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:55 INFO - PROCESS | 452 | RSS: Main: 173760512 21:42:55 INFO - PROCESS | 452 | 21:42:57 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36884/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:58 INFO - PROCESS | 452 | RSS: Main: 232534016 21:42:58 INFO - PROCESS | 452 | 21:43:01 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36884/tests/kraken/driver.html?testName=audio-dft) 21:43:01 INFO - PROCESS | 452 | RSS: Main: 217608192 21:43:01 INFO - PROCESS | 452 | 21:43:05 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36884/tests/kraken/driver.html?testName=audio-fft) 21:43:05 INFO - PROCESS | 452 | RSS: Main: 299626496 21:43:05 INFO - PROCESS | 452 | 21:43:07 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36884/tests/kraken/driver.html?testName=audio-oscillator) 21:43:08 INFO - PROCESS | 452 | RSS: Main: 210141184 21:43:08 INFO - PROCESS | 452 | 21:43:10 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:43:11 INFO - PROCESS | 452 | RSS: Main: 213348352 21:43:11 INFO - PROCESS | 452 | 21:43:14 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36884/tests/kraken/driver.html?testName=imaging-darkroom) 21:43:14 INFO - PROCESS | 452 | RSS: Main: 249393152 21:43:14 INFO - PROCESS | 452 | 21:43:18 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36884/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:18 INFO - PROCESS | 452 | RSS: Main: 248348672 21:43:18 INFO - PROCESS | 452 | 21:43:21 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36884/tests/kraken/driver.html?testName=json-parse-financial) 21:43:22 INFO - PROCESS | 452 | RSS: Main: 248274944 21:43:22 INFO - PROCESS | 452 | 21:43:23 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:24 INFO - PROCESS | 452 | RSS: Main: 210751488 21:43:24 INFO - PROCESS | 452 | 21:43:25 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:26 INFO - PROCESS | 452 | RSS: Main: 217853952 21:43:26 INFO - PROCESS | 452 | 21:43:28 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:29 INFO - PROCESS | 452 | RSS: Main: 226877440 21:43:29 INFO - PROCESS | 452 | 21:43:31 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:32 INFO - PROCESS | 452 | RSS: Main: 235675648 21:43:32 INFO - PROCESS | 452 | 21:43:35 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:36 INFO - PROCESS | 452 | RSS: Main: 232677376 21:43:36 INFO - PROCESS | 452 | 21:43:37 INFO - PROCESS | 452 | Cycle 1(1): loaded http://localhost:36884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36884/tests/kraken/driver.html?testName=ai-astar) 21:43:38 INFO - PROCESS | 452 | RSS: Main: 284643328 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | __start_tp_report 21:43:38 INFO - PROCESS | 452 | _x_x_mozilla_page_load 21:43:38 INFO - PROCESS | 452 | _x_x_mozilla_page_load_details 21:43:38 INFO - PROCESS | 452 | |i|pagename|runs| 21:43:38 INFO - PROCESS | 452 | |0;ai-astar;111;112;113;112;113;114;112;114;115;112 21:43:38 INFO - PROCESS | 452 | |1;audio-beat-detection;147;124;124;168;129;129;121;121;156;130 21:43:38 INFO - PROCESS | 452 | |2;audio-dft;161;159;161;161;161;162;162;162;162;161 21:43:38 INFO - PROCESS | 452 | |3;audio-fft;75;75;76;116;76;76;75;77;98;75 21:43:38 INFO - PROCESS | 452 | |4;audio-oscillator;83;82;124;82;82;83;104;83;82;111 21:43:38 INFO - PROCESS | 452 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;116;117;117 21:43:38 INFO - PROCESS | 452 | |6;imaging-darkroom;147;147;147;148;146;145;146;145;146;146 21:43:38 INFO - PROCESS | 452 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;94 21:43:38 INFO - PROCESS | 452 | |8;json-parse-financial;52;51;52;51;52;52;56;53;52;53 21:43:38 INFO - PROCESS | 452 | |9;json-stringify-tinderbox;61;61;61;61;62;62;61;62;61;61 21:43:38 INFO - PROCESS | 452 | |10;stanford-crypto-aes;80;81;80;81;83;80;80;80;81;87 21:43:38 INFO - PROCESS | 452 | |11;stanford-crypto-ccm;133;130;133;141;131;132;128;128;172;127 21:43:38 INFO - PROCESS | 452 | |12;stanford-crypto-pbkdf2;175;176;171;175;171;172;168;168;170;170 21:43:38 INFO - PROCESS | 452 | |13;stanford-crypto-sha256-iterative;67;73;67;67;66;67;66;68;66;66 21:43:38 INFO - PROCESS | 452 | __end_tp_report 21:43:38 INFO - PROCESS | 452 | __start_cc_report 21:43:38 INFO - PROCESS | 452 | _x_x_mozilla_cycle_collect,1651 21:43:38 INFO - PROCESS | 452 | __end_cc_report 21:43:38 INFO - PROCESS | 452 | __startTimestamp1475556218003__endTimestamp 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | ------- Summary: start ------- 21:43:38 INFO - PROCESS | 452 | Number of tests: 14 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.23 (1.1%) stddev-sans-first:1.12 21:43:38 INFO - PROCESS | 452 | Values: 111.0 112.0 113.0 112.0 113.0 114.0 112.0 114.0 115.0 112.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:129.50 stddev:16.35 (12.6%) stddev-sans-first:16.74 21:43:38 INFO - PROCESS | 452 | Values: 147.0 124.0 124.0 168.0 129.0 129.0 121.0 121.0 156.0 130.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.92 (0.6%) stddev-sans-first:0.97 21:43:38 INFO - PROCESS | 452 | Values: 161.0 159.0 161.0 161.0 161.0 162.0 162.0 162.0 162.0 161.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.91 (18.3%) stddev-sans-first:14.53 21:43:38 INFO - PROCESS | 452 | Values: 75.0 75.0 76.0 116.0 76.0 76.0 75.0 77.0 98.0 75.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:15.53 (18.9%) stddev-sans-first:16.16 21:43:38 INFO - PROCESS | 452 | Values: 83.0 82.0 124.0 82.0 82.0 83.0 104.0 83.0 82.0 111.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:43:38 INFO - PROCESS | 452 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 21:43:38 INFO - PROCESS | 452 | Values: 147.0 147.0 147.0 148.0 146.0 145.0 146.0 145.0 146.0 146.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 21:43:38 INFO - PROCESS | 452 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:1.43 (2.7%) stddev-sans-first:1.51 21:43:38 INFO - PROCESS | 452 | Values: 52.0 51.0 52.0 51.0 52.0 52.0 56.0 53.0 52.0 53.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 21:43:38 INFO - PROCESS | 452 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 61.0 61.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.21 (2.7%) stddev-sans-first:2.30 21:43:38 INFO - PROCESS | 452 | Values: 80.0 81.0 80.0 81.0 83.0 80.0 80.0 80.0 81.0 87.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:132.50 stddev:13.43 (10.1%) stddev-sans-first:14.21 21:43:38 INFO - PROCESS | 452 | Values: 133.0 130.0 133.0 141.0 131.0 132.0 128.0 128.0 172.0 127.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:2.88 (1.7%) stddev-sans-first:2.77 21:43:38 INFO - PROCESS | 452 | Values: 175.0 176.0 171.0 175.0 171.0 172.0 168.0 168.0 170.0 170.0 21:43:38 INFO - PROCESS | 452 | 21:43:38 INFO - PROCESS | 452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.11 (3.2%) stddev-sans-first:2.24 21:43:38 INFO - PROCESS | 452 | Values: 67.0 73.0 67.0 67.0 66.0 67.0 66.0 68.0 66.0 66.0 21:43:38 INFO - PROCESS | 452 | -------- Summary: end -------- 21:43:38 INFO - PROCESS | 452 | 21:43:39 INFO - TEST-INFO | 452: exit 0 21:43:39 INFO - TEST-OK | kraken | took 62701ms 21:43:39 INFO - SUITE-END | took 1180s 21:43:39 INFO - Completed test suite (00:19:41) 21:43:39 INFO - javascript benchmark 21:43:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.1934577664033, 3018.6377634683827, 3019.3810268894877, 3045.086474057782, 3067.7699172562047, 5088.033273677998, 5135.0, 5174.586033117351, 5257.737113144347, 5275.525202731754, 5217.582593392529, 5223.947760522394, 5316.707581083039, 5365.0, 5409.918851217235, 4747.1929771938685, 4783.593394561466, 4842.806287748504, 4850.757462126897, 4865.391826021747, 4897.730624815634, 4937.185364414867, 4938.506149385069, 4939.555440010398, 4977.55202031817, 4630.050839577879, 4680.789364478606, 4684.0866031123605, 4933.383327084114, 4940.827071052496, 4743.193657078271, 4744.478107408182, 4746.572808447222, 4748.596369308613, 4750.50119737426, 4654.185517534418, 4676.766161691936, 4678.157931572316, 4680.625549955996, 4684.297355396684, 5048.29323894655, 5060.342155519759, 5122.590192784568, 5124.436312005676, 5141.948580514184, 5495.862603434906, 5530.972345138289, 5577.079781835992, 5578.414266501999, 5590.8043218487155, 5536.501714845684, 5627.2684551008515, 5633.915491267634, 5638.520725738276, 5640.464155905182, 5193.043598794079, 5203.973980130113, 5238.240455134022, 5251.10731175701, 5316.680999139987, 5548.69482178476, 5600.523955463831, 5614.157876318585, 5634.690092044895, 5675.517581005661, 5436.836894893159, 5453.972730136404, 5461.535769459561, 5462.2079798429, 5462.6995515247045, 5549.639273447213, 5554.08357620988, 5557.638753481011, 5558.249636299129, 5628.352739434936, 5408.296921400193, 5483.314585676791, 5520.1167813150505, 5559.360673522597, 5583.972080139573, 5620.4660557247, 5622.128570071645, 5622.91565626516, 5682.261306030189, 5682.687452190086, 4365.170617582649, 4366.3013917773005, 4370.016746232072, 4373.234683930299, 4425.026494171278, 3718.3492888744363, 3740.0836794985403, 3766.5668448128267, 3803.82882770276, 3830.559485659129, 5367.865803354947, 5369.40936496985, 5371.543418809367, 5400.270963419966, 5411.702356370437, 5605.7197140142825, 5646.2942132233475, 5656.179853921159, 5658.264425624642, 5665.858353541194, 5137.743112844343, 5247.711375874287, 5248.475152484721, 5308.893822123536, 5416.0, 4892.828750993698, 4898.951010489921, 4902.3872015998, 4921.680090794087, 4959.82640607577, 5790.971045144747, 5793.855153621109, 5799.594028417971, 5807.680577568274, 5864.9706751467675, 5417.918731218956, 5459.317585301837, 5467.808626698046, 5554.1391084381985, 5562.499375056264, 5701.942980570141, 5719.685417302088, 5779.988502012216, 5843.590948633555, 5846.386129456346, 5562.972185139049, 5569.944300557105, 5572.9968605651375, 5573.3869274380595, 5640.464155905182, 5633.8309850704545, 5648.265725455664, 5682.857928551819, 5698.629589076862, 5700.372958974426, 5308.708021058879, 5360.946390536044, 5421.078416669096, 5463.207834864002, 5563.7774489019985, 5517.69652669107, 5521.723913804374, 5524.198991146181, 5559.16612508127, 5585.636933599303, 5427.050266203478, 5439.945600543944, 5441.21102440136, 5446.1558458439, 5449.455054494519, 5221.190715439113, 5348.331458567679, 5447.645903016291, 5532.529734972572, 5591.692456914909, 5330.253764472899, 5383.300170977748, 5417.997670430983, 5471.835844924659, 5478.452154784649], "value": 5164.914774218227, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.6207935484837, 603.4900509069836, 614.8923938310797, 615.639850687348, 631.9462845658119, 33058.50412243815, 41285.17429651405, 42419.78790106053, 42572.14855702888, 46244.0, 43706.562934370646, 43981.56018439815, 44134.55865441345, 44138.55861441392, 44376.77811610945, 8182.549959752211, 9019.143181397756, 9172.266218702487, 9181.632734690638, 9186.265098792113, 8124.715634952778, 10563.894361056406, 10847.240693151483, 10849.457527123652, 11252.887471125267, 11073.114150867912, 11134.721631959184, 11144.275622084579, 11151.944240278828, 11153.386563738992, 10839.0, 10914.836277455805, 10919.890801092046, 10920.672379828618, 10928.125749939985, 10758.784824303548, 10815.18886083547, 10826.350418974887, 10827.404492752896, 10835.83746243799, 41533.37699934503, 41768.37347439791, 41905.3904070552, 41919.58080419187, 41997.160056798995, 3508.789472631625, 3645.5078564394, 3695.5380577427823, 3823.3500304948225, 4009.3985902114623, 31414.528782068286, 31627.52558711621, 32039.51940720891, 32045.679543204504, 33815.0, 4031.97984010081, 4171.436856024428, 4182.0, 4312.331588603772, 4331.7834108294455, 318728.0, 320111.0, 321214.9999999977, 321316.0, 321541.0, 54406.0, 54783.0, 54786.0, 54834.45165548293, 54884.0, 35864.64135358665, 58504.70747646235, 58515.70742146347, 58558.414415855295, 58605.12092318619, 14942.70114597702, 15681.372745090068, 15688.843111568967, 15724.60688482797, 15730.0, 10784.352938823695, 10800.891991080145, 10871.67384978452, 11087.113030957504, 11722.76554468923, 18150.727739083923, 18566.72149917752, 18662.626747464976, 18781.530461738566, 18816.811831881507, 5774.595778295479, 7054.6472676365975, 7064.540804847668, 7389.556626602421, 7442.553446793209, 919.2186641354929, 1056.8203405421098, 1056.8467572202142, 1059.3908502610875, 1133.6712353417417, 29883.252918677208, 30090.84954575213, 31185.688143118277, 32159.67840321567, 32210.516842247383, 1069.652362982034, 1111.6442738323658, 1147.2370873369282, 1162.1167912386647, 1162.8023236049892, 16602.75095873563, 16698.83301166997, 16707.49877503677, 16839.415730561403, 16840.915795420944, 517911.0, 523909.0, 524071.0, 525254.0, 527101.0, 56399.43600564024, 56861.715691421276, 56910.430895691345, 57122.0, 57135.0, 1196.8264601632713, 1240.193873981919, 1282.1089342906591, 1327.555268984901, 1334.339501946562, 29301.85349073241, 32317.192070198435, 32339.51490727688, 32501.34997300088, 32943.34113317768, 48147.5185248143, 48757.0, 48761.5123848757, 48818.5118148814, 48830.75584622054, 372108.0, 372750.0, 373009.0, 373641.0, 374187.0, 27077.86461067682, 27772.166834994983, 27901.302467438476, 28049.859750701115, 28230.43539129165, 37550.624493754716, 38502.6149738499, 44258.33612495751, 45512.54487455083, 46887.531124688314, 38758.4186237201, 39273.0, 39873.2025359497, 40310.0, 41658.0, 40042.1991560173, 40759.1848163041, 41195.29670219985, 41535.169296614506, 41757.37363939483, 39619.405708913815, 39934.0, 41019.1796164081, 41156.79421602873, 41166.58833411628, 32116.270117040312, 36083.63916360803, 36159.908840565695, 36665.63334366729, 36830.0, 26916.865415672797, 27185.0, 27322.726772732018, 27431.314217144733, 27479.244868071546], "value": 19936.145984034658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3645643547058, 383.6336298834613, 391.2507548045492, 398.6651212981095, 418.4079527468632, 14026.0, 14148.646283842909, 17566.47300580983, 19158.616827663456, 19182.712259316104, 14837.85162148381, 17503.649927001454, 17814.732779008293, 18857.90571047143, 19296.324628638, 5687.857803554903, 5844.941550584483, 5906.586538942276, 5910.734016969225, 5914.615549989237, 5663.943360566383, 5805.361410244891, 5822.796202132926, 5830.4169583041785, 5845.941540584604, 5541.113421852504, 5796.5652576056755, 5797.072468405056, 5797.797077102302, 5799.623024503394, 5718.056520674084, 5753.510951569101, 5767.106098554731, 5795.9420405796245, 5807.941920580783, 5030.547250747451, 5226.843194704165, 5231.633785635007, 5233.502817232356, 5289.338832645919, 12921.67695807603, 12967.546135885294, 13143.53997610079, 13179.341032948314, 18586.0, 2123.437289118385, 2314.2131675230335, 2339.3683705399617, 2361.303415492434, 2481.2928315430017, 9788.314817962746, 9834.459104749307, 9927.602895884229, 10367.585296588128, 10527.947360263226, 1757.9736303955451, 1786.7409225662336, 1901.5056085417752, 1939.1467754188252, 2040.0819631166034, 80977.0, 82725.0, 83169.58415207946, 85196.57401712952, 87233.12766872313, 10520.894791051991, 10761.730956725987, 10813.459327033617, 10823.296485728402, 10972.615958441416, 15042.548723538312, 15156.772648410282, 15162.772558411632, 15173.924130379277, 15176.620584485476, 7599.0123456790125, 7756.340711039625, 7860.9213907860185, 8020.598970051474, 8032.15662355456, 6733.3266673333255, 7040.2607726189035, 7061.926743001015, 7296.015037969913, 7656.540607563453, 4466.57567531084, 4481.5070342262325, 4522.208613492691, 4613.677042606985, 4858.271259311132, 1813.4468986959105, 1822.772153480815, 1850.5651171974575, 1876.7372567840514, 1940.8932508712157, 869.3132425384002, 952.0812416018437, 980.4508278475905, 1047.0838016735356, 1056.0759335581367, 17766.289348426177, 18142.274309027754, 18151.273949042155, 18255.72616410755, 18419.907900460414, 954.0459540459541, 955.4171955107379, 957.0, 965.1795973422535, 979.5249304087512, 9407.388519746195, 9640.71077867665, 9894.406335619886, 9985.900140998643, 10069.899301007043, 331117.0, 335924.0, 339375.0, 454094.0, 499447.0, 92556.0, 96517.0, 97077.0, 97731.0, 99435.50282248542, 909.2362415570952, 925.7130289610243, 938.2728385501291, 959.4627008875052, 961.2694352292308, 15711.450099246471, 16385.180740963144, 16511.587210319838, 16950.66098677995, 16953.91523042377, 42168.36747448729, 42252.0, 42674.0, 43277.56722432735, 44580.33129503125, 55249.0, 55432.0, 56215.43784562102, 56655.43344566502, 60636.696816515636, 7562.987514641102, 7659.272369124924, 7716.498427602188, 7784.104827944859, 7940.960295198487, 8495.8725619117, 10908.290961087503, 11184.217104802585, 11529.135314851588, 11798.941005294919, 5772.913406298993, 10335.116166626043, 10657.520411581343, 10815.0, 11238.83141752858, 9674.7581310465, 10588.311759735592, 10700.41147736882, 10822.458877056273, 11081.72295692582, 10376.481175941022, 10596.735081623021, 10649.201309901633, 10900.509477073709, 10909.836352454879, 7512.361449276873, 7816.804579885548, 7886.003318738843, 8017.0, 8205.58972051407, 10459.110975567162, 10489.632862849763, 10499.842502362624, 10703.19726020536, 10806.459677016275], "value": 8642.70887886908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.0753480098738, 1462.6782107936253, 1496.2369191712228, 1620.1737114071827, 1805.8555315574756, 7627.351675107616, 8690.782730431734, 8916.286697064235, 8934.329925255608, 9231.261499080074, 8999.865002024959, 9073.0, 9080.455172689642, 9082.046385129566, 9085.227755640763, 2360.3509035015422, 2366.5621859955963, 2385.057902128658, 2387.844790088647, 2392.5095355452177, 2315.1086831569883, 2336.9883150584224, 2369.1944738788807, 2370.182287110944, 2373.4541055557233, 2231.4979129695853, 2268.160780511205, 2280.737715162761, 2301.631738921773, 2308.319045881469, 2246.4159318577126, 2274.7270327560714, 2279.1453205048106, 2280.247518318959, 2281.281396360158, 2233.463968647513, 2245.7641947595594, 2246.528229071897, 2250.414892128042, 2251.0883092347626, 8822.823543529157, 8884.11158884113, 8884.378093533454, 8910.86633700495, 9009.684661036898, 5355.785768569292, 5634.211210430543, 5646.378898321182, 5654.293213348332, 5658.830235092953, 3434.759566830323, 3480.286541259036, 3537.6992955598803, 3543.0965103898598, 3573.0531409176588, 1082.107261509258, 1105.8285965675334, 1107.7729065541544, 1129.1926272715048, 1133.0369186191754, 12689.23864568129, 12696.619101426972, 12772.936135319356, 12784.872151278461, 12851.228926264454, 4379.277419225856, 4710.69380490267, 4749.26386410107, 4765.8093676252565, 4846.200376937766, 10038.849417258602, 10039.34744241622, 10039.69880903574, 10047.497625118714, 10055.597776088875, 5469.507744303032, 5481.424450432727, 5492.505674489315, 5496.560275177976, 5497.615166938276, 4315.762633055149, 4399.494058183286, 4782.689125206851, 4859.757012149449, 5082.847514574569, 3699.445083237536, 3722.9441558376648, 3753.6246375362243, 3835.463035175078, 3837.2325534893134, 1185.3539820797687, 1198.0475521960063, 1200.8138738495547, 1206.7043574324346, 1210.4552951171831, 913.4701872913694, 923.9122283383068, 934.5233930695395, 938.483833891357, 948.0661548374845, 5745.1825028104, 5820.738066787005, 5979.850503737442, 6137.171481849982, 6172.105044768573, 427.09242858924785, 427.3013622726864, 431.3012919071125, 439.25984715754055, 443.76480465353416, 3839.539255289383, 3964.1278918637854, 3982.7056206732927, 3996.8401263949117, 4052.1287923096675, 11256.718582035352, 11569.942150289195, 11685.532578696926, 11693.0, 11694.76610467786, 11545.653630391102, 11644.941775291069, 11653.41732913351, 11658.06735461161, 11665.825012624817, 8252.133525979805, 8320.66717331312, 8440.66237350499, 8474.322054235647, 8523.105073967145, 5668.404817494104, 5693.4875861172695, 5819.127130930395, 5829.0, 5867.32525759526, 10385.221108416748, 10396.792064158522, 10434.530446129791, 10505.212109092, 10658.467076646291, 10313.381197128196, 10579.418132002813, 10849.728756781144, 10856.45717714127, 10882.727931801768, 6710.664466776544, 6875.3812156906115, 6878.55289406187, 7425.257474252531, 7541.2458754124145, 7959.681612735426, 8006.959965200137, 8320.791980200544, 8430.0, 8571.357148213785, 7637.618119094134, 7661.425393095652, 7767.92232077672, 7876.09424916119, 8086.393520485869, 7401.555906645618, 7527.661255243418, 7607.23927607257, 7780.84438311242, 7877.6455059523605, 7022.508424410242, 7127.607981561064, 7141.82145446368, 7144.85710285781, 7145.749898753519, 4998.925016124688, 5004.198488544049, 5007.173816320412, 5084.161113416245, 5247.763850626655, 5048.469910659474, 5074.695518268915, 5100.719460429712, 5141.177411614124, 5218.66078704883], "value": 4549.887062185059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.5031351092296, 339.29088205650214, 341.1028993746445, 343.5276494819623, 345.0442274898531, 5189.728516513454, 5261.473852614737, 5268.525832675058, 5279.86800329991, 5304.177852432879, 5142.357205349332, 5159.561437277826, 5216.504432078956, 5236.633435659496, 5260.763265653045, 3877.9806100969454, 4112.362583799516, 4128.256913755516, 4162.875113746577, 4168.312228482297, 4108.630223279904, 4112.712110152291, 4135.27632664284, 4142.896427589304, 4150.460440142777, 4067.877963661095, 4068.572799856017, 4083.5712250213746, 4093.8362465501345, 4113.547509773923, 3890.3775395936796, 3906.511686039245, 3986.3223252047223, 4002.2195671844, 4100.118474527976, 3520.2255503789124, 3524.9823750881083, 3532.6290739472242, 3532.858685652571, 3535.4520049392386, 5023.598112151019, 5043.924341134886, 5066.771995260222, 5075.365579302587, 5102.209157580543, 4372.956270437287, 4431.357453169272, 4604.125216208943, 4622.6301895848255, 4644.7213167210075, 5295.391030031557, 5320.600954928396, 5325.866853328659, 5328.866778330573, 5340.786368545292, 3962.366021436585, 3966.7619942803235, 3981.223661386002, 3986.681065514752, 3989.202159568098, 5407.837314977299, 5602.411746766572, 5605.971970140164, 5645.459543205574, 5648.293963254593, 3902.9609703903166, 3932.410138479251, 3943.428202910562, 3946.2699400610977, 3964.643182113566, 4006.579309172553, 4018.4374187613757, 4020.4170395292517, 4025.1949610077518, 4027.597240275949, 4477.104579084196, 4569.771511424416, 4607.424071991001, 4607.792649330721, 4618.792154352995, 5366.892662146735, 5369.4630536946, 5370.388883334984, 5422.15956526739, 5451.454854514596, 1404.2487269311073, 1410.05526297381, 1411.9011669183265, 1417.6030711400824, 1419.5741277616673, 839.1440730454901, 912.7946212102224, 913.5569248914271, 921.8615010462074, 932.5943214701626, 4564.338170965258, 4571.588557029883, 4618.198902428056, 4620.643471829391, 4633.374494443207, 4844.4186697596515, 4861.319415281863, 4887.828925987574, 4972.085746987436, 4979.402471703419, 4382.37851994764, 4692.671512994126, 4716.740579268173, 4719.9292010619865, 4737.8104875805275, 2585.935351616187, 2595.493878693637, 2609.908653197167, 2614.75159859813, 2622.9246009136164, 4973.477784832613, 4989.550940415307, 5036.84889453317, 5063.949360506348, 5064.82273120439, 4767.73777442244, 4928.8170838998385, 4943.615787579483, 4948.529889660476, 5013.974930125326, 4937.580305673986, 4959.181735013683, 5005.299258103868, 5006.274090256819, 5010.574101201439, 4851.937926381344, 4856.975715121402, 4884.242942343943, 4901.828436004723, 4906.681065730716, 4488.573585509372, 4816.627261230673, 4837.95162048375, 4863.3434486343895, 4895.583875370633, 4869.659123861437, 5016.423111342242, 5037.622178336566, 5064.569511591556, 5082.796688132434, 3713.85144594224, 3733.8879833605033, 3753.5495740511315, 3754.6433088856515, 3766.6798322142927, 4959.925601115914, 4991.9500804991485, 5000.849974500771, 5003.374578177728, 5227.3465816772905, 5339.385970613429, 5371.946280537145, 5433.347998240079, 5457.945420545744, 5464.289642346628, 5424.18289872897, 5452.427495112956, 5454.8909021818545, 5475.479829416199, 5501.972490137524, 5218.504242096995, 5346.144616861284, 5377.892442151213, 5391.946080539301, 5449.5640348772795, 5216.921746173734, 5339.439358867263, 5370.731463426891, 5427.701476418677, 5494.27492356581, 5364.812231572032, 5372.247885295984, 5388.892222155613, 5390.730463476889, 5409.459054094559], "value": 3985.474863768321, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.6680493777801, 739.3641468337231, 768.7117331000875, 802.2258520527689, 812.0, 16193.676126477463, 16894.324227030906, 17082.743758843626, 17084.48746537604, 17137.314507419705, 14385.1368917865, 14583.34374953127, 14614.0, 14615.561533153996, 14647.267636618153, 655.2595567009297, 669.2470970158572, 672.2235817630644, 785.5247575216982, 806.2864365036926, 668.5320275806955, 669.0967194287697, 766.7508059880533, 787.0712559180165, 787.5117427195147, 839.6515446089866, 847.7117779954814, 850.3749743938231, 850.7660393391805, 850.9234168924795, 842.2672275120684, 842.8651415773478, 842.9747107586721, 843.2958479669453, 843.4981186194266, 509.91586388246265, 523.6491550661028, 601.3445344574391, 615.1818081950994, 615.5844804756816, 14328.570142895729, 15035.924820375938, 15091.39634414622, 15103.773443398359, 15118.470853520184, 13365.732685346336, 13651.522196723066, 13860.4455821767, 14130.576082717433, 14276.357563909649, 11914.623439367806, 12208.511659533608, 12226.938865305705, 12541.372931353395, 12625.179363341445, 4256.957430425687, 4304.978475107604, 4327.7619730914785, 4333.718308309982, 4475.865724028285, 78736.60631696862, 79182.0, 80396.0, 85545.57227213948, 85546.57226713827, 11139.665810025712, 11336.0, 11653.825192622118, 11670.772105665485, 11777.764444711058, 21055.263065792624, 21097.78902210989, 21114.472138196666, 21126.78873211279, 21235.362939111852, 8594.441361311494, 8672.26285765717, 8710.346723995726, 9019.819603607892, 9030.322725795591, 4696.694714843524, 4708.4349878014855, 4711.411073615798, 4765.404324459442, 4911.533404326583, 3459.9654003460146, 3553.307105114478, 3555.040139162463, 3558.1994051338243, 3558.822058897045, 633.7465013994439, 639.8752243312509, 651.371426573359, 660.2901880478505, 668.5353679193012, 562.6146089928412, 571.5256337240164, 648.7307767276621, 654.107143748789, 659.8383396067994, 7620.161782203953, 7984.161663025415, 8216.424850260544, 8828.514431706319, 9023.458592484472, 576.4149388370807, 603.0231025738332, 603.1766638538363, 635.972769616619, 652.9804105876831, 4134.297169481196, 4238.406623072772, 4346.152500262482, 4360.825566977349, 4418.558144185556, 101172.0, 116789.0, 129224.35387823, 131466.34266828795, 131774.0, 103973.48013259885, 105368.47315763525, 108278.0, 110945.44527277474, 111927.0, 93412.0, 94648.0, 95898.0, 96143.0, 97635.0, 7967.203279671987, 7989.560574168477, 8148.348132149533, 8331.750047498585, 8501.234888859784, 52416.68958276074, 52576.21135683044, 52733.7363313181, 53794.19308710294, 56605.71697141488, 72673.63663181651, 73945.26054739383, 79487.20512794798, 81487.18512814796, 85321.57339213512, 10890.564377424815, 11144.442777861237, 11402.315861048031, 11545.538178472767, 11637.127215459044, 11665.0, 11698.532058717556, 11920.523179073087, 11969.880301196876, 12002.75994480123, 10479.94760026195, 10628.320731266753, 10738.302010369613, 10850.186236032172, 11340.94329528347, 10962.616308429167, 11163.162762792985, 11167.497462614365, 11243.156763242627, 11252.549898004316, 10633.840492392776, 10649.969413789047, 10744.0, 10924.672259832218, 11013.614523491638, 9246.398984066283, 9369.625214991323, 9516.476593787409, 9604.471754053315, 9649.324547281623, 8811.515366654896, 9233.769155770891, 9419.529023548932, 9505.441932783093, 9800.607975681178], "value": 7220.369992100728, "unit": "score"}], "name": "dromaeo_css", "value": 6988.871207646294, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 112.0, 113.0, 114.0, 112.0, 114.0, 115.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 124.0, 168.0, 129.0, 129.0, 121.0, 121.0, 156.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 116.0, 76.0, 76.0, 75.0, 77.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 124.0, 82.0, 82.0, 83.0, 104.0, 83.0, 82.0, 111.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 52.0, 52.0, 56.0, 53.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 81.0, 83.0, 80.0, 80.0, 80.0, 81.0, 87.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 133.0, 141.0, 131.0, 132.0, 128.0, 128.0, 172.0, 127.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 171.0, 175.0, 171.0, 172.0, 168.0, 168.0, 170.0, 170.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 67.0, 67.0, 66.0, 67.0, 66.0, 68.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1509.8999999999999, "alertThreshold": 2.0}]} 21:43:39 INFO - Return code: 0 21:43:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:43:39 INFO - # TBPL SUCCESS # 21:43:39 INFO - Running post-action listener: _resource_record_post_action 21:43:39 INFO - [mozharness: 2016-10-04 04:43:39.801319Z] Finished run-tests step (success) 21:43:39 INFO - Running post-run listener: _resource_record_post_run 21:43:39 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392753152; Read time: 20; Write time: 334012 21:43:39 INFO - TinderboxPrint: CPU usage
13.1% 21:43:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 21:43:39 INFO - TinderboxPrint: I/O write bytes / time
392,753,152 / 334,012 21:43:39 INFO - TinderboxPrint: CPU idle
8,303.4 (86.9%) 21:43:39 INFO - TinderboxPrint: CPU user
1,205.8 (12.6%) 21:43:39 INFO - TinderboxPrint: Swap in / out
0 / 0 21:43:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104415232; Read time: 0; Write time: 100440 21:43:39 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288337920; Read time: 0; Write time: 233572 21:43:40 INFO - Running post-run listener: _upload_blobber_files 21:43:40 INFO - Blob upload gear active. 21:43:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:43:40 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:43:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:41 INFO - (blobuploader) - INFO - Done attempting. 21:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:44 INFO - (blobuploader) - INFO - Done attempting. 21:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:45 INFO - (blobuploader) - INFO - Done attempting. 21:43:45 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:45 INFO - Return code: 0 21:43:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/504b949d007f22666d187f1a9b98765314902097b2610df7c888253150129676770e1b0d4a45f4eee64bbc738d2f011b382a41a198aa6af46dce62baa7d6576a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6f6d74caa62e152164c0f74e0481f07d81d406bd484d5011938d1d2309b4d510d95906484f443ac14e27a0e7268a7638db54b7fc445dc2234ded310b215c9bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/009285f69a8ef0db65d10c027f85c9571b305d453e3164b6f5f9dc2a6cebf657104e37f0f26249592afff8d49a71c4641815b97a32e08011948b30bda768bc6b"} 21:43:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:45 INFO - Contents: 21:43:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/504b949d007f22666d187f1a9b98765314902097b2610df7c888253150129676770e1b0d4a45f4eee64bbc738d2f011b382a41a198aa6af46dce62baa7d6576a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6f6d74caa62e152164c0f74e0481f07d81d406bd484d5011938d1d2309b4d510d95906484f443ac14e27a0e7268a7638db54b7fc445dc2234ded310b215c9bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/009285f69a8ef0db65d10c027f85c9571b305d453e3164b6f5f9dc2a6cebf657104e37f0f26249592afff8d49a71c4641815b97a32e08011948b30bda768bc6b"} 21:43:45 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:45 INFO - Copying logs to upload dir... 21:43:45 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.222398 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-03 21:43:44.226595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 21:43:44.231028) ========= 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=cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061 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/sha512/504b949d007f22666d187f1a9b98765314902097b2610df7c888253150129676770e1b0d4a45f4eee64bbc738d2f011b382a41a198aa6af46dce62baa7d6576a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6f6d74caa62e152164c0f74e0481f07d81d406bd484d5011938d1d2309b4d510d95906484f443ac14e27a0e7268a7638db54b7fc445dc2234ded310b215c9bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/009285f69a8ef0db65d10c027f85c9571b305d453e3164b6f5f9dc2a6cebf657104e37f0f26249592afff8d49a71c4641815b97a32e08011948b30bda768bc6b"} build_url:https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/KjQd_9UVQb6i_YYVwW7L0g/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/sha512/504b949d007f22666d187f1a9b98765314902097b2610df7c888253150129676770e1b0d4a45f4eee64bbc738d2f011b382a41a198aa6af46dce62baa7d6576a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c6f6d74caa62e152164c0f74e0481f07d81d406bd484d5011938d1d2309b4d510d95906484f443ac14e27a0e7268a7638db54b7fc445dc2234ded310b215c9bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/009285f69a8ef0db65d10c027f85c9571b305d453e3164b6f5f9dc2a6cebf657104e37f0f26249592afff8d49a71c4641815b97a32e08011948b30bda768bc6b"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 21:43:44.333475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:43:44.333877) ========= 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=cbe409c6de289db6ac707de3000001d4-1475553344.609948-969420061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:43:44.464924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 21:43:44.465230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 21:43:44.465501) ========= ========= Total master_lag: 0.33 =========