builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1475485978.73 results: success (0) buildid: 20161003005354 builduid: 12d8521c28474818a6d5417444b4d365 revision: 2b6868859c21af4e24651be7e308fe96f66680cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.733883) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.734364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.734693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.779794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.780119) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 02:13:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-10-03 02:13:00 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.891124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.891906) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022354 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.954038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:58.954394) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2b6868859c21af4e24651be7e308fe96f66680cf --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 2b6868859c21af4e24651be7e308fe96f66680cf --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=97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 02:13:00,889 truncating revision to first 12 chars 2016-10-03 02:13:00,890 Setting DEBUG logging. 2016-10-03 02:13:00,890 attempt 1/10 2016-10-03 02:13:00,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2b6868859c21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 02:13:01,183 unpacking tar archive at: autoland-2b6868859c21/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:59.572767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:59.573091) ========= script_repo_revision: 2b6868859c21af4e24651be7e308fe96f66680cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:59.573558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:59.573863) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 02:12:59.587455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-03 02:12:59.587818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:13:01 INFO - MultiFileLogger online at 20161003 02:13:01 in /builds/slave/test 02:13:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 02:13:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:01 INFO - {'append_to_log': False, 02:13:01 INFO - 'base_work_dir': '/builds/slave/test', 02:13:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:13:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:01 INFO - 'branch': 'Autoland-Non-PGO', 02:13:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:01 INFO - 'config_files': ('talos/linux_config.py',), 02:13:01 INFO - 'default_actions': ('clobber', 02:13:01 INFO - 'read-buildbot-config', 02:13:01 INFO - 'download-and-extract', 02:13:01 INFO - 'populate-webroot', 02:13:01 INFO - 'create-virtualenv', 02:13:01 INFO - 'install', 02:13:01 INFO - 'run-tests'), 02:13:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:01 INFO - 'download_minidump_stackwalk': True, 02:13:01 INFO - 'download_symbols': 'ondemand', 02:13:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:01 INFO - 'installer_path': 'installer.exe', 02:13:01 INFO - 'log_level': 'info', 02:13:01 INFO - 'log_name': 'talos', 02:13:01 INFO - 'log_to_console': True, 02:13:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:13:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:13:01 INFO - 'opt_config_files': (), 02:13:01 INFO - 'pip_index': False, 02:13:01 INFO - 'sps_profile': False, 02:13:01 INFO - 'sps_profile_interval': 0, 02:13:01 INFO - 'suite': 'dromaeojs', 02:13:01 INFO - 'system_bits': '32', 02:13:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:01 INFO - 'title': 'talos-linux64-ix-068', 02:13:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:01 INFO - 'use_talos_json': True, 02:13:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:01 INFO - 'work_dir': 'build'} 02:13:01 INFO - [mozharness: 2016-10-03 09:13:01.622610Z] Running clobber step. 02:13:01 INFO - Running pre-action listener: _resource_record_pre_action 02:13:01 INFO - Running main action method: clobber 02:13:01 INFO - rmtree: /builds/slave/test/build 02:13:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:02 INFO - Running post-action listener: _resource_record_post_action 02:13:02 INFO - [mozharness: 2016-10-03 09:13:02.087849Z] Finished clobber step (success) 02:13:02 INFO - [mozharness: 2016-10-03 09:13:02.087950Z] Running read-buildbot-config step. 02:13:02 INFO - Running pre-action listener: _resource_record_pre_action 02:13:02 INFO - Running main action method: read_buildbot_config 02:13:02 INFO - Using buildbot properties: 02:13:02 INFO - { 02:13:02 INFO - "project": "", 02:13:02 INFO - "product": "firefox", 02:13:02 INFO - "script_repo_revision": "production", 02:13:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:13:02 INFO - "repository": "", 02:13:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 02:13:02 INFO - "buildid": "20161003005354", 02:13:02 INFO - "pgo_build": "False", 02:13:02 INFO - "basedir": "/builds/slave/test", 02:13:02 INFO - "buildnumber": 607, 02:13:02 INFO - "slavename": "talos-linux64-ix-068", 02:13:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:13:02 INFO - "platform": "ubuntu64_hw", 02:13:02 INFO - "scheduler": "tests-autoland-linux64-talos", 02:13:02 INFO - "branch": "autoland", 02:13:02 INFO - "repo_path": "integration/autoland", 02:13:02 INFO - "revision": "2b6868859c21af4e24651be7e308fe96f66680cf", 02:13:02 INFO - "stage_platform": "linux64", 02:13:02 INFO - "builduid": "12d8521c28474818a6d5417444b4d365", 02:13:02 INFO - "slavebuilddir": "test" 02:13:02 INFO - } 02:13:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:13:02 INFO - Running post-action listener: _resource_record_post_action 02:13:02 INFO - [mozharness: 2016-10-03 09:13:02.090516Z] Finished read-buildbot-config step (success) 02:13:02 INFO - [mozharness: 2016-10-03 09:13:02.090604Z] Running download-and-extract step. 02:13:02 INFO - Running pre-action listener: _resource_record_pre_action 02:13:02 INFO - Running main action method: download_and_extract 02:13:02 INFO - mkdir: /builds/slave/test/build/tests 02:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:02 INFO - trying https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:13:02 INFO - Downloading https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/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 02:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/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 02:13:02 INFO - Downloaded 1361 bytes. 02:13:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:13:02 INFO - Using the following test package requirements: 02:13:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:13:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:13:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:13:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'jsshell-linux-x86_64.zip'], 02:13:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:13:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:13:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:13:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:13:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:13:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:13:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:13:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:13:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:13:02 INFO - Fetch https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:13:03 INFO - Http code: 200 02:13:03 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 02:13:03 INFO - x-amz-cf-id: 1kSpbZzffrYeLcVve8HWsyqt3XJkclsePxyzcHC0fHbd1YDsREs6Ag== 02:13:03 INFO - x-amz-version-id: KQ6z3m93aLgSiAg.JiNc.y.horlrgaRz 02:13:03 INFO - Expected file size: 20420680 02:13:03 INFO - Obtained file size: 20420680 02:13:07 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 02:13:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:13:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:13:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:13:08 INFO - Http code: 200 02:13:08 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 02:13:08 INFO - x-amz-cf-id: oNlQsbhQzCo1jvk2u5E3Lbc4KwYIrddraxay3o5U-uq0qu1xKKgXPg== 02:13:08 INFO - x-amz-version-id: KQ6z3m93aLgSiAg.JiNc.y.horlrgaRz 02:13:08 INFO - Expected file size: 20420680 02:13:08 INFO - Obtained file size: 20420680 02:13:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:13:12 INFO - Fetch https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:13:13 INFO - Http code: 200 02:13:13 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 02:13:13 INFO - x-amz-cf-id: 3XNprOxtMHvVuJAKcFDEIJpoudNBpuu89_1VQnHkLM8twvrI3Sx7RA== 02:13:13 INFO - x-amz-version-id: qLyKi7RvlZ3UDjLDuCBGeNjmKutiS33. 02:13:14 INFO - Expected file size: 14408522 02:13:14 INFO - Obtained file size: 14408522 02:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:14 INFO - trying https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:14 INFO - Downloading https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/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 02:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/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 02:13:16 INFO - Downloaded 55816421 bytes. 02:13:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:16 INFO - mkdir: /builds/slave/test/properties 02:13:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:16 INFO - Contents: 02:13:16 INFO - build_url:https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:17 INFO - Running post-action listener: _resource_record_post_action 02:13:17 INFO - Running post-action listener: set_extra_try_arguments 02:13:17 INFO - [mozharness: 2016-10-03 09:13:17.157932Z] Finished download-and-extract step (success) 02:13:17 INFO - [mozharness: 2016-10-03 09:13:17.158157Z] Running populate-webroot step. 02:13:17 INFO - Running pre-action listener: _resource_record_pre_action 02:13:17 INFO - Running main action method: populate_webroot 02:13:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:17 INFO - '--tppagecycles', 02:13:17 INFO - '7'], 02:13:17 INFO - 'tests': ['tsvgm']}}, 02:13:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['damp', 'tps']}, 02:13:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'tests': ['damp', 'tps']}, 02:13:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['dromaeo_dom']}, 02:13:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['basic_compositor_video']}, 02:13:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:13:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['a11yr', 02:13:17 INFO - 'ts_paint', 02:13:17 INFO - 'tpaint', 02:13:17 INFO - 'sessionrestore', 02:13:17 INFO - 'sessionrestore_no_auto_restore', 02:13:17 INFO - 'tabpaint']}, 02:13:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:17 INFO - 'ts_paint', 02:13:17 INFO - 'tpaint', 02:13:17 INFO - 'sessionrestore', 02:13:17 INFO - 'sessionrestore_no_auto_restore', 02:13:17 INFO - 'tabpaint']}, 02:13:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:17 INFO - 'ts_paint', 02:13:17 INFO - 'tpaint', 02:13:17 INFO - 'sessionrestore', 02:13:17 INFO - 'sessionrestore_no_auto_restore', 02:13:17 INFO - 'tabpaint']}, 02:13:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:17 INFO - 'ts_paint', 02:13:17 INFO - 'tpaint', 02:13:17 INFO - 'sessionrestore', 02:13:17 INFO - 'sessionrestore_no_auto_restore', 02:13:17 INFO - 'tabpaint']}, 02:13:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['a11yr', 02:13:17 INFO - 'ts_paint', 02:13:17 INFO - 'tpaint', 02:13:17 INFO - 'sessionrestore', 02:13:17 INFO - 'sessionrestore_no_auto_restore', 02:13:17 INFO - 'tabpaint']}, 02:13:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['a11yr', 02:13:17 INFO - 'ts_paint', 02:13:17 INFO - 'tpaint', 02:13:17 INFO - 'sessionrestore', 02:13:17 INFO - 'sessionrestore_no_auto_restore', 02:13:17 INFO - 'tabpaint']}, 02:13:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['tsvgx', 02:13:17 INFO - 'tsvgr_opacity', 02:13:17 INFO - 'tart', 02:13:17 INFO - 'tscrollx', 02:13:17 INFO - 'cart']}, 02:13:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:17 INFO - 'tsvgr_opacity', 02:13:17 INFO - 'tart', 02:13:17 INFO - 'tscrollx', 02:13:17 INFO - 'cart']}, 02:13:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'talos_options': ['--disable-e10s'], 02:13:17 INFO - 'tests': ['tp5o']}, 02:13:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'tests': ['tp5o']}, 02:13:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'talos_options': ['--disable-e10s', 02:13:17 INFO - '--xperf_path', 02:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:17 INFO - 'tests': ['tp5n']}, 02:13:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:17 INFO - 'talos_options': ['--xperf_path', 02:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:17 INFO - 'tests': ['tp5n']}}, 02:13:17 INFO - 'talos.zip': {'path': '', 02:13:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:17 INFO - Running post-action listener: _resource_record_post_action 02:13:17 INFO - [mozharness: 2016-10-03 09:13:17.174475Z] Finished populate-webroot step (success) 02:13:17 INFO - [mozharness: 2016-10-03 09:13:17.174562Z] Running create-virtualenv step. 02:13:17 INFO - Running pre-action listener: _resource_record_pre_action 02:13:17 INFO - Running main action method: create_virtualenv 02:13:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:13:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:17 INFO - Using real prefix '/usr' 02:13:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:19 INFO - Installing pip.................done. 02:13:19 INFO - Return code: 0 02:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:13:19 INFO - Reading from file tmpfile_stdout 02:13:19 INFO - Output received: 02:13:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:13:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13: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', 'pip>=1.5'] in /builds/slave/test/build 02:13: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 pip>=1.5 02:13:19 INFO - Using env: {'DISPLAY': ':0', 02:13:19 INFO - 'HOME': '/home/cltbld', 02:13:19 INFO - 'LANG': 'en_US.UTF-8', 02:13:19 INFO - 'LANGUAGE': 'en_US:en', 02:13:19 INFO - 'LOGNAME': 'cltbld', 02:13:19 INFO - 'MAIL': '/var/mail/cltbld', 02:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:19 INFO - 'MOZ_NO_REMOTE': '1', 02:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:19 INFO - 'NO_EM_RESTART': '1', 02:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:19 INFO - 'PWD': '/builds/slave/test', 02:13:19 INFO - 'SHELL': '/bin/bash', 02:13:19 INFO - 'SHLVL': '1', 02:13:19 INFO - 'TERM': 'linux', 02:13:19 INFO - 'TMOUT': '86400', 02:13:19 INFO - 'USER': 'cltbld', 02:13:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:19 INFO - '_': '/tools/buildbot/bin/python'} 02:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:13:20 INFO - Cleaning up... 02:13:20 INFO - Return code: 0 02:13:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:20 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:13:20 INFO - Using env: {'DISPLAY': ':0', 02:13:20 INFO - 'HOME': '/home/cltbld', 02:13:20 INFO - 'LANG': 'en_US.UTF-8', 02:13:20 INFO - 'LANGUAGE': 'en_US:en', 02:13:20 INFO - 'LOGNAME': 'cltbld', 02:13:20 INFO - 'MAIL': '/var/mail/cltbld', 02:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:20 INFO - 'MOZ_NO_REMOTE': '1', 02:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:20 INFO - 'NO_EM_RESTART': '1', 02:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:20 INFO - 'PWD': '/builds/slave/test', 02:13:20 INFO - 'SHELL': '/bin/bash', 02:13:20 INFO - 'SHLVL': '1', 02:13:20 INFO - 'TERM': 'linux', 02:13:20 INFO - 'TMOUT': '86400', 02:13:20 INFO - 'USER': 'cltbld', 02:13:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:20 INFO - '_': '/tools/buildbot/bin/python'} 02:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:20 INFO - Downloading/unpacking psutil>=3.1.1 02:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:22 INFO - Installing collected packages: psutil 02:13:22 INFO - Running setup.py install for psutil 02:13:22 INFO - building 'psutil._psutil_linux' extension 02:13:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:13:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:13:22 INFO - building 'psutil._psutil_posix' extension 02:13:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:13:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:22 INFO - Successfully installed psutil 02:13:22 INFO - Cleaning up... 02:13:22 INFO - Return code: 0 02:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:22 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:13:22 INFO - Using env: {'DISPLAY': ':0', 02:13:22 INFO - 'HOME': '/home/cltbld', 02:13:22 INFO - 'LANG': 'en_US.UTF-8', 02:13:22 INFO - 'LANGUAGE': 'en_US:en', 02:13:22 INFO - 'LOGNAME': 'cltbld', 02:13:22 INFO - 'MAIL': '/var/mail/cltbld', 02:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:22 INFO - 'MOZ_NO_REMOTE': '1', 02:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:22 INFO - 'NO_EM_RESTART': '1', 02:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:22 INFO - 'PWD': '/builds/slave/test', 02:13:22 INFO - 'SHELL': '/bin/bash', 02:13:22 INFO - 'SHLVL': '1', 02:13:22 INFO - 'TERM': 'linux', 02:13:22 INFO - 'TMOUT': '86400', 02:13:22 INFO - 'USER': 'cltbld', 02:13:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:22 INFO - '_': '/tools/buildbot/bin/python'} 02:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:13:25 INFO - Installing collected packages: mozsystemmonitor 02:13:25 INFO - Running setup.py install for mozsystemmonitor 02:13:25 INFO - Successfully installed mozsystemmonitor 02:13:25 INFO - Cleaning up... 02:13:25 INFO - Return code: 0 02:13:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:25 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:13:25 INFO - Using env: {'DISPLAY': ':0', 02:13:25 INFO - 'HOME': '/home/cltbld', 02:13:25 INFO - 'LANG': 'en_US.UTF-8', 02:13:25 INFO - 'LANGUAGE': 'en_US:en', 02:13:25 INFO - 'LOGNAME': 'cltbld', 02:13:25 INFO - 'MAIL': '/var/mail/cltbld', 02:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:25 INFO - 'MOZ_NO_REMOTE': '1', 02:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:25 INFO - 'NO_EM_RESTART': '1', 02:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:25 INFO - 'PWD': '/builds/slave/test', 02:13:25 INFO - 'SHELL': '/bin/bash', 02:13:25 INFO - 'SHLVL': '1', 02:13:25 INFO - 'TERM': 'linux', 02:13:25 INFO - 'TMOUT': '86400', 02:13:25 INFO - 'USER': 'cltbld', 02:13:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:25 INFO - '_': '/tools/buildbot/bin/python'} 02:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:25 INFO - Downloading/unpacking jsonschema==2.5.1 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:13:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:13:27 INFO - warning: no files found matching '*.txt' 02:13:27 INFO - no previously-included directories found matching 'build' 02:13:27 INFO - no previously-included directories found matching 'dist' 02:13:27 INFO - no previously-included directories found matching '.git*' 02:13:27 INFO - Installing collected packages: jsonschema, functools32 02:13:27 INFO - Running setup.py install for functools32 02:13:27 INFO - warning: no files found matching '*.txt' 02:13:27 INFO - no previously-included directories found matching 'build' 02:13:27 INFO - no previously-included directories found matching 'dist' 02:13:27 INFO - no previously-included directories found matching '.git*' 02:13:27 INFO - Successfully installed jsonschema functools32 02:13:27 INFO - Cleaning up... 02:13:27 INFO - Return code: 0 02:13:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:27 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:13:27 INFO - Using env: {'DISPLAY': ':0', 02:13:27 INFO - 'HOME': '/home/cltbld', 02:13:27 INFO - 'LANG': 'en_US.UTF-8', 02:13:27 INFO - 'LANGUAGE': 'en_US:en', 02:13:27 INFO - 'LOGNAME': 'cltbld', 02:13:27 INFO - 'MAIL': '/var/mail/cltbld', 02:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:27 INFO - 'MOZ_NO_REMOTE': '1', 02:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:27 INFO - 'NO_EM_RESTART': '1', 02:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:27 INFO - 'PWD': '/builds/slave/test', 02:13:27 INFO - 'SHELL': '/bin/bash', 02:13:27 INFO - 'SHLVL': '1', 02:13:27 INFO - 'TERM': 'linux', 02:13:27 INFO - 'TMOUT': '86400', 02:13:27 INFO - 'USER': 'cltbld', 02:13:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:27 INFO - '_': '/tools/buildbot/bin/python'} 02:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:13:28 INFO - Cleaning up... 02:13:28 INFO - Return code: 0 02:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:13:28 INFO - Using env: {'DISPLAY': ':0', 02:13:28 INFO - 'HOME': '/home/cltbld', 02:13:28 INFO - 'LANG': 'en_US.UTF-8', 02:13:28 INFO - 'LANGUAGE': 'en_US:en', 02:13:28 INFO - 'LOGNAME': 'cltbld', 02:13:28 INFO - 'MAIL': '/var/mail/cltbld', 02:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:28 INFO - 'MOZ_NO_REMOTE': '1', 02:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:28 INFO - 'NO_EM_RESTART': '1', 02:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:28 INFO - 'PWD': '/builds/slave/test', 02:13:28 INFO - 'SHELL': '/bin/bash', 02:13:28 INFO - 'SHLVL': '1', 02:13:28 INFO - 'TERM': 'linux', 02:13:28 INFO - 'TMOUT': '86400', 02:13:28 INFO - 'USER': 'cltbld', 02:13:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:28 INFO - '_': '/tools/buildbot/bin/python'} 02:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:30 INFO - Downloading docopt-0.6.1.tar.gz 02:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:31 INFO - Running setup.py install for blobuploader 02:13:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:31 INFO - Running setup.py install for requests 02:13:31 INFO - Running setup.py install for docopt 02:13:31 INFO - Successfully installed blobuploader requests docopt 02:13:31 INFO - Cleaning up... 02:13:31 INFO - Return code: 0 02:13:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:31 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:13:31 INFO - Using env: {'DISPLAY': ':0', 02:13:31 INFO - 'HOME': '/home/cltbld', 02:13:31 INFO - 'LANG': 'en_US.UTF-8', 02:13:31 INFO - 'LANGUAGE': 'en_US:en', 02:13:31 INFO - 'LOGNAME': 'cltbld', 02:13:31 INFO - 'MAIL': '/var/mail/cltbld', 02:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:31 INFO - 'MOZ_NO_REMOTE': '1', 02:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:31 INFO - 'NO_EM_RESTART': '1', 02:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:31 INFO - 'PWD': '/builds/slave/test', 02:13:31 INFO - 'SHELL': '/bin/bash', 02:13:31 INFO - 'SHLVL': '1', 02:13:31 INFO - 'TERM': 'linux', 02:13:31 INFO - 'TMOUT': '86400', 02:13:31 INFO - 'USER': 'cltbld', 02:13:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:31 INFO - '_': '/tools/buildbot/bin/python'} 02:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:31 INFO - Running setup.py (path:/tmp/pip-M1wy4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:31 INFO - Running setup.py (path:/tmp/pip-z3Xt0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:32 INFO - Running setup.py (path:/tmp/pip-40p0ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:32 INFO - Running setup.py (path:/tmp/pip-zCAwb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:32 INFO - Running setup.py (path:/tmp/pip-HPXZ7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:32 INFO - Running setup.py (path:/tmp/pip-0IZCcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:32 INFO - Running setup.py (path:/tmp/pip-d8axgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:32 INFO - Running setup.py (path:/tmp/pip-Iw061B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:32 INFO - Running setup.py (path:/tmp/pip-1hcwMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:32 INFO - Running setup.py (path:/tmp/pip-kzlnPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:32 INFO - Running setup.py (path:/tmp/pip-Sah8J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:32 INFO - Running setup.py (path:/tmp/pip-HWwpla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:32 INFO - Running setup.py (path:/tmp/pip-rP7PKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:32 INFO - Running setup.py (path:/tmp/pip-0wOvOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:32 INFO - Running setup.py (path:/tmp/pip-uA8zXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:32 INFO - Running setup.py (path:/tmp/pip-YRLnoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:33 INFO - Running setup.py (path:/tmp/pip-9aEjUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:33 INFO - Running setup.py install for manifestparser 02:13:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Running setup.py install for mozcrash 02:13:33 INFO - Running setup.py install for mozdebug 02:13:33 INFO - Running setup.py install for mozdevice 02:13:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Running setup.py install for mozfile 02:13:33 INFO - Running setup.py install for mozhttpd 02:13:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Running setup.py install for mozinfo 02:13:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Running setup.py install for mozInstall 02:13:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:33 INFO - Running setup.py install for mozleak 02:13:33 INFO - Running setup.py install for mozlog 02:13:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Running setup.py install for moznetwork 02:13:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Running setup.py install for mozprocess 02:13:34 INFO - Running setup.py install for mozprofile 02:13:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Running setup.py install for mozrunner 02:13:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Running setup.py install for mozscreenshot 02:13:34 INFO - Running setup.py install for moztest 02:13:34 INFO - Running setup.py install for mozversion 02:13:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:34 INFO - Cleaning up... 02:13:34 INFO - Return code: 0 02:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:34 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:13:34 INFO - Using env: {'DISPLAY': ':0', 02:13:34 INFO - 'HOME': '/home/cltbld', 02:13:34 INFO - 'LANG': 'en_US.UTF-8', 02:13:34 INFO - 'LANGUAGE': 'en_US:en', 02:13:34 INFO - 'LOGNAME': 'cltbld', 02:13:34 INFO - 'MAIL': '/var/mail/cltbld', 02:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:34 INFO - 'MOZ_NO_REMOTE': '1', 02:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:34 INFO - 'NO_EM_RESTART': '1', 02:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:34 INFO - 'PWD': '/builds/slave/test', 02:13:34 INFO - 'SHELL': '/bin/bash', 02:13:34 INFO - 'SHLVL': '1', 02:13:34 INFO - 'TERM': 'linux', 02:13:34 INFO - 'TMOUT': '86400', 02:13:34 INFO - 'USER': 'cltbld', 02:13:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:34 INFO - '_': '/tools/buildbot/bin/python'} 02:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:35 INFO - Running setup.py (path:/tmp/pip-e8zAPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:35 INFO - Running setup.py (path:/tmp/pip-ODlnfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:35 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)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:35 INFO - Running setup.py (path:/tmp/pip-UujBrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:35 INFO - Running setup.py (path:/tmp/pip-_seIKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:35 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)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:35 INFO - Running setup.py (path:/tmp/pip-x9KWaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:35 INFO - Running setup.py (path:/tmp/pip-62_GA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:35 INFO - Running setup.py (path:/tmp/pip-9Bl2hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:35 INFO - Running setup.py (path:/tmp/pip-H1rJz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:35 INFO - Running setup.py (path:/tmp/pip-94wWcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:35 INFO - Running setup.py (path:/tmp/pip-EObkZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:35 INFO - Running setup.py (path:/tmp/pip-vxidz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:35 INFO - Running setup.py (path:/tmp/pip-dP4tOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:36 INFO - Running setup.py (path:/tmp/pip-crsoib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:36 INFO - Running setup.py (path:/tmp/pip-Y8ca2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:36 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)) 02:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:36 INFO - Running setup.py (path:/tmp/pip-3xgvr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:36 INFO - Running setup.py (path:/tmp/pip-bKfITX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:36 INFO - Running setup.py (path:/tmp/pip-bExpEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:13:36 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)) 02:13:36 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)) 02:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:13:36 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)) 02:13:36 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)) 02:13:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:38 INFO - Downloading blessings-1.6.tar.gz 02:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:38 INFO - Installing collected packages: blessings 02:13:38 INFO - Running setup.py install for blessings 02:13:38 INFO - Successfully installed blessings 02:13:38 INFO - Cleaning up... 02:13:38 INFO - Return code: 0 02:13:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:38 INFO - Reading from file tmpfile_stdout 02:13:38 INFO - Current package versions: 02:13:38 INFO - argparse == 1.2.1 02:13:38 INFO - blessings == 1.6 02:13:38 INFO - blobuploader == 1.2.4 02:13:38 INFO - docopt == 0.6.1 02:13:38 INFO - functools32 == 3.2.3-2 02:13:38 INFO - jsonschema == 2.5.1 02:13:38 INFO - manifestparser == 1.1 02:13:38 INFO - mozInstall == 1.12 02:13:38 INFO - mozcrash == 0.17 02:13:38 INFO - mozdebug == 0.1 02:13:38 INFO - mozdevice == 0.48 02:13:38 INFO - mozfile == 1.2 02:13:38 INFO - mozhttpd == 0.7 02:13:38 INFO - mozinfo == 0.9 02:13:38 INFO - mozleak == 0.1 02:13:38 INFO - mozlog == 3.4 02:13:38 INFO - moznetwork == 0.27 02:13:38 INFO - mozprocess == 0.23 02:13:38 INFO - mozprofile == 0.28 02:13:38 INFO - mozrunner == 6.12 02:13:38 INFO - mozscreenshot == 0.1 02:13:38 INFO - mozsystemmonitor == 0.3 02:13:38 INFO - moztest == 0.7 02:13:38 INFO - mozversion == 1.4 02:13:38 INFO - psutil == 3.1.1 02:13:38 INFO - requests == 1.2.3 02:13:38 INFO - wsgiref == 0.1.2 02:13:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:13:38 INFO - Using env: {'DISPLAY': ':0', 02:13:38 INFO - 'HOME': '/home/cltbld', 02:13:38 INFO - 'LANG': 'en_US.UTF-8', 02:13:38 INFO - 'LANGUAGE': 'en_US:en', 02:13:38 INFO - 'LOGNAME': 'cltbld', 02:13:38 INFO - 'MAIL': '/var/mail/cltbld', 02:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:38 INFO - 'MOZ_NO_REMOTE': '1', 02:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:38 INFO - 'NO_EM_RESTART': '1', 02:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:38 INFO - 'PWD': '/builds/slave/test', 02:13:38 INFO - 'SHELL': '/bin/bash', 02:13:38 INFO - 'SHLVL': '1', 02:13:38 INFO - 'TERM': 'linux', 02:13:38 INFO - 'TMOUT': '86400', 02:13:38 INFO - 'USER': 'cltbld', 02:13:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:38 INFO - '_': '/tools/buildbot/bin/python'} 02:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:13:38 INFO - Cleaning up... 02:13:38 INFO - Return code: 0 02:13:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:39 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 0x7f752567cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1252ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:13:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:13:39 INFO - Using env: {'DISPLAY': ':0', 02:13:39 INFO - 'HOME': '/home/cltbld', 02:13:39 INFO - 'LANG': 'en_US.UTF-8', 02:13:39 INFO - 'LANGUAGE': 'en_US:en', 02:13:39 INFO - 'LOGNAME': 'cltbld', 02:13:39 INFO - 'MAIL': '/var/mail/cltbld', 02:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:39 INFO - 'MOZ_NO_REMOTE': '1', 02:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:39 INFO - 'NO_EM_RESTART': '1', 02:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:39 INFO - 'PWD': '/builds/slave/test', 02:13:39 INFO - 'SHELL': '/bin/bash', 02:13:39 INFO - 'SHLVL': '1', 02:13:39 INFO - 'TERM': 'linux', 02:13:39 INFO - 'TMOUT': '86400', 02:13:39 INFO - 'USER': 'cltbld', 02:13:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:39 INFO - '_': '/tools/buildbot/bin/python'} 02:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:13:39 INFO - Cleaning up... 02:13:39 INFO - Return code: 0 02:13:39 INFO - Running post-action listener: _resource_record_post_action 02:13:39 INFO - Running post-action listener: _start_resource_monitoring 02:13:39 INFO - Starting resource monitoring. 02:13:39 INFO - [mozharness: 2016-10-03 09:13:39.263729Z] Finished create-virtualenv step (success) 02:13:39 INFO - [mozharness: 2016-10-03 09:13:39.264328Z] Running install step. 02:13:39 INFO - Running pre-action listener: _resource_record_pre_action 02:13:39 INFO - Running main action method: install 02:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:39 INFO - Reading from file tmpfile_stdout 02:13:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:13:39 INFO - Reading from file tmpfile_stdout 02:13:39 INFO - Output received: 02:13:39 INFO - Usage: mozinstall [options] installer 02:13:39 INFO - Options: 02:13:39 INFO - -h, --help show this help message and exit 02:13:39 INFO - -d DEST, --destination=DEST 02:13:39 INFO - Directory to install application into. [default: 02:13:39 INFO - "/builds/slave/test"] 02:13:39 INFO - --app=APP Application being installed. [default: firefox] 02:13:39 INFO - mkdir: /builds/slave/test/build/application 02:13:39 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'] 02:13:39 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 02:13:55 INFO - Reading from file tmpfile_stdout 02:13:55 INFO - Output received: 02:13:55 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:55 INFO - Running post-action listener: _resource_record_post_action 02:13:55 INFO - [mozharness: 2016-10-03 09:13:55.743786Z] Finished install step (success) 02:13:55 INFO - [mozharness: 2016-10-03 09:13:55.744031Z] Running run-tests step. 02:13:55 INFO - Running pre-action listener: _resource_record_pre_action 02:13:55 INFO - Running main action method: run_tests 02:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:55 INFO - Python 2.7.3 02:13:55 INFO - Return code: 0 02:13:55 INFO - grabbing minidump binary from tooltool 02:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:55 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 0x124ff60>, '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 0x1250d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12511d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:13:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:13:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:13:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:55 INFO - Return code: 0 02:13:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:13:55 INFO - Using env: {'DISPLAY': ':0', 02:13:55 INFO - 'HOME': '/home/cltbld', 02:13:55 INFO - 'LANG': 'en_US.UTF-8', 02:13:55 INFO - 'LANGUAGE': 'en_US:en', 02:13:55 INFO - 'LOGNAME': 'cltbld', 02:13:55 INFO - 'MAIL': '/var/mail/cltbld', 02:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:55 INFO - 'MOZ_NO_REMOTE': '1', 02:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:55 INFO - 'NO_EM_RESTART': '1', 02:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:55 INFO - 'PWD': '/builds/slave/test', 02:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:55 INFO - 'SHELL': '/bin/bash', 02:13:55 INFO - 'SHLVL': '1', 02:13:55 INFO - 'TERM': 'linux', 02:13:55 INFO - 'TMOUT': '86400', 02:13:55 INFO - 'USER': 'cltbld', 02:13:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422', 02:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:55 INFO - '_': '/tools/buildbot/bin/python'} 02:13:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:13:56 INFO - mozversion application_buildid: 20161003005354 02:13:56 INFO - mozversion application_changeset: 2b6868859c21af4e24651be7e308fe96f66680cf 02:13:56 INFO - mozversion application_display_name: Nightly 02:13:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:56 INFO - mozversion application_name: Firefox 02:13:56 INFO - mozversion application_remotingname: firefox 02:13:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:13:56 INFO - mozversion application_vendor: Mozilla 02:13:56 INFO - mozversion application_version: 52.0a1 02:13:56 INFO - mozversion platform_buildid: 20161003005354 02:13:56 INFO - mozversion platform_changeset: 2b6868859c21af4e24651be7e308fe96f66680cf 02:13:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:13:56 INFO - mozversion platform_version: 52.0a1 02:13:56 INFO - using testdate: 1475486036 02:13:56 INFO - actual date: 1475486036 02:13:56 INFO - starting webserver on 'localhost:51845' 02:13:56 INFO - SUITE-START | Running 2 tests 02:13:56 INFO - TEST-START | dromaeo_css 02:13:56 INFO - operating with platform_type : linux_ 02:13:56 INFO - Initialising browser for dromaeo_css test... 02:13:56 INFO - TEST-INFO | started process 8348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYLgFPG/profile http://localhost:51845/getInfo.html) 02:14:00 INFO - PROCESS | 8348 | __metrics Screen width/height:1600/1200 02:14:00 INFO - PROCESS | 8348 | colorDepth:24 02:14:00 INFO - PROCESS | 8348 | Browser inner width/height: 1024/697 02:14:00 INFO - PROCESS | 8348 | __metrics 02:14:01 INFO - PROCESS | 8348 | 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" 02:14:01 INFO - PROCESS | 8348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:01 INFO - PROCESS | 8348 | console.error: PushService: 02:14:01 INFO - PROCESS | 8348 | stateChangeProcessEnqueue: Error transitioning state 02:14:01 INFO - PROCESS | 8348 | UnknownError 02:14:02 INFO - TEST-INFO | 8348: exit 0 02:14:02 INFO - Browser initialized. 02:14:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:14:02 INFO - TEST-INFO | started process 8432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYLgFPG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:14 INFO - PROCESS | 8432 | RSS: Main: 175755264 02:14:14 INFO - PROCESS | 8432 | 02:15:06 INFO - PROCESS | 8432 | 1475486106452 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:17:19 INFO - PROCESS | 8432 | Cycle 1(1): loaded http://localhost:51845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51845/tests/dromaeo/cssquery-ext.html) 02:17:20 INFO - PROCESS | 8432 | RSS: Main: 301191168 02:17:20 INFO - PROCESS | 8432 | 02:20:23 INFO - PROCESS | 8432 | Cycle 1(1): loaded http://localhost:51845/tests/dromaeo/cssquery-ext.html (next: http://localhost:51845/tests/dromaeo/cssquery-jquery.html) 02:20:24 INFO - PROCESS | 8432 | RSS: Main: 273190912 02:20:24 INFO - PROCESS | 8432 | 02:23:26 INFO - PROCESS | 8432 | Cycle 1(1): loaded http://localhost:51845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51845/tests/dromaeo/cssquery-mootools.html) 02:23:26 INFO - PROCESS | 8432 | RSS: Main: 242900992 02:23:26 INFO - PROCESS | 8432 | 02:26:29 INFO - PROCESS | 8432 | Cycle 1(1): loaded http://localhost:51845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51845/tests/dromaeo/cssquery-prototype.html) 02:26:29 INFO - PROCESS | 8432 | RSS: Main: 220368896 02:26:29 INFO - PROCESS | 8432 | 02:29:32 INFO - PROCESS | 8432 | Cycle 1(1): loaded http://localhost:51845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51845/tests/dromaeo/cssquery-yui.html) 02:29:33 INFO - PROCESS | 8432 | RSS: Main: 220336128 02:29:33 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | Cycle 1(1): loaded http://localhost:51845/tests/dromaeo/cssquery-yui.html (next: http://localhost:51845/tests/dromaeo/cssquery-dojo.html) 02:32:36 INFO - PROCESS | 8432 | RSS: Main: 303493120 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | __start_tp_report 02:32:36 INFO - PROCESS | 8432 | _x_x_mozilla_page_load 02:32:36 INFO - PROCESS | 8432 | _x_x_mozilla_page_load_details 02:32:36 INFO - PROCESS | 8432 | |i|pagename|runs| 02:32:36 INFO - PROCESS | 8432 | |0;dojo.html;2522.104652848239;2557.053890060678;2591.4039770852696;2596.454744503654;2611.0600183933793;4462.62067724243;4536.841210557631;4586.220342541767;4595.632349412047;4666.276727107295;4605.723656580608;4664.2770370592525;4689.906201875969;4716.221823399135;4738.52614738526;4196.601322874322;4212.873613791591;4272.978635106836;4285.507166675826;4353.825846966118;4338.132373525292;4370.169667763131;4389.363542286366;4400.44994375703;4450.532694067125;4312.159128969852;4331.263685173512;4356.368326592642;4375.6937014409;4390.868273951786;4159.9376009359885;4215.494140703105;4216.536181020086;4218.8523401680795;4290;4267.594578515036;4291.849785257501;4321.805518751664;4344.478662560481;4347.260965635818;4627.699199552018;4634.559716826896;4638.072385522909;4660.044690838404;4706.482286948433;4791.0178413425165;4804.687695299829;4909.754512274372;4974.054929563371;4981.676191047571;4948.356713627206;4993.325901003391;4998.850034498971;5040;5052.646314757969;4652;4652.302154676791;4653.813847446064;4657.6273898088075;4715.552022557886;4959.429665588504;5028.64799464034;5079.060373830779;5091.465396133352;5151.098557752378;4782.808687652525;4809.519048095232;4822;4843.588294994895;4847.297141914473;4909.533594308535;4924.8276310328965;4999.009312462806;5000.149974504343;5065.9746701266995;4771.976140119346;4943.307936888838;4951.331570238044;4959.082569724613;5017.473165317662;4806.182948898696;4849.2968519564465;4935.851924442272;4941.851744447672;5023.648344615842;3958.44581758554;3985.6811455083525;3992.1017771001293;3996.0609256824623;4040.6363427291685;3561.0741207285773;3565.6612621800887;3588.6411358863907;3613.0967258185456;3613.9277214456088;4224.683148763855;4287.8070486828165;4329.19909816685;4388.100439409914;4395.912081758411;5022.698638081727;5062.772175252123;5074.289599456005;5110.2590124431745;5120.334356533627;4375.081232941055;4388.824447022083;4389.868303950887;4441.111777644484;4445;4412.536683648171;4460.821567137278;4530.524294948983;4627.120847039052;4635.629149668019;4704.905901882012;4724.763761811964;4726.338312636302;4781.187198176388;4782.067496838223;5006.098902197639;5017.799288028438;5020.723860187724;5022.547970682656;5082.593392528663;4529.909401812011;4565.086982603426;4703.553162449562;4724.692894961817;4789.640776941813;4866.780994855169;4904.632152588499;4908.705477671351;4925.704457732548;4985.725785081855;4986.650934434555;4995.550400463831;4996.02577497399;5004.799808007639;5065.986802639413;4663.580277775017;4823.204171311694;4872.196087645499;4873.610111191026;4929.852104436873;4763;4833.95166048335;4867.58625516835;4892.168331383602;4947.554720075211;4796.040791841715;4797.616190704665;4803.1114243864995;4805.495422980537;4853.975730121327;4654.138984287918;4696.624270058319;4701.858944231679;4915.827946021872;4927.260910863399;4648.744319062349;4659.813607455664;4664.696794708333;4667.439907211156;4675.602573781131 02:32:36 INFO - PROCESS | 8432 | |1;ext.html;526.6997811247589;553.3221803290967;561.5199004850855;569.0752527143392;576.8038866785292;27594.860770884377;28298;37252.25495490092;38848.80575597118;39079.21841563174;39692.40461393074;39837.40243896336;40225;40237;40255.396169057414;7480.289372509616;7669.731559395423;7670.7698769037015;7676.577788221645;7678.155402905704;7410.740624078158;7495.362894154004;7499.437542184331;7503.5497870127965;7506.512076714996;7503.174650788409;7536.43476739244;7541.095068591777;7554.508956917783;7555.546667199958;7485.700571977114;7515.8496830063095;7519.060117485315;7529.548227106391;7531.849363012764;7530.623468826591;7570.962145189294;7590.278923502258;7592;7598.734044308423;37478.43782343267;37890.43164352537;37937.810310948546;37945;37963.43054854179;3018.471767440711;3024.349764800578;3025.773067019982;3269.54226408303;3297.73618110553;27237.45525089507;27560;27758;28528.71471285302;28889;3269.623993240784;3415.0949998250235;3425.4348032574594;3440.2603440260214;3464.4803279508023;243153;244228;245246;245927;246915;29653.703462965525;30838.229044273623;48779.51220487821;48877.2668409967;48977;32424.675753242638;32500.674993249766;32730.672693273238;32760.344793104003;32904.58360619656;12596.874031259571;12736.6815829605;12738.363081845871;12741.745165096832;12741.936290318674;9920.950395247977;9946;9948.651797187209;9953.552090155961;9958.502074896227;7797.805054873674;7816.140224575292;7884.369250459949;7934.492446435159;7942.563159026194;3123.1567476781142;3128.71841534263;3147.213196700825;3147.970597635031;3190.6968837960358;810.5096416667949;815.4006804998321;890.496869268861;927.8097989912052;1012.9037741414554;25959.870200649253;26748.465030699277;26819.597706034427;27332.863335683196;27353;766.7623036858591;910.6220918318824;917.866909298148;965.3339195954769;996.3175224970918;14211.78682319766;14478.565643030726;14580.1980891052;14625.707485850437;14836.554903352917;378421;381111;381978;382038;382437;47956.28065579019;48052;48172;48269.5173048265;48271;1073.8174510333263;1096.4791723931228;1103.5585765693786;1167.3229526874393;1199.1006744941294;26432.867835660698;27972.89463689666;29482;30414.239644009078;30568.37860632679;44127.558724412345;44899.77550112228;45002.77498612486;45211.32183017192;45255.54744452513;346208;347300;348391;348831;349044;24124.51750965006;24805;25243.74756252414;25274.74725252724;26370.73629263683;40010;40170.19659606733;40204.79897600493;40444.595554044085;40955.38566921558;33996.32007359889;34503.827480862434;34530.82734586311;34632.82683586566;34904;33904;34031.31937361288;34732.305353892276;35129;35205.82397087998;33585.83207083949;34042.489362659086;34241.65758342385;34447.311053778285;34765.65234347624;30123.096307110824;31706.207344816565;31721.36557268888;31790;32328;24339.63490547608;24666.63000054965;24723.134690285755;24729.87635061885;25236.49527009413 02:32:36 INFO - PROCESS | 8432 | |2;jquery.html;345.8789423701703;356.4688613965191;368.1789609171547;374.2066818345108;384.2219505501361;11043.171762117843;11845.7630847383;15706.37174513021;16320.183990800442;17257.82742172578;16918.323267069303;17053.14734263288;17080.572985675364;17091.009073412133;17384.826151738478;4024.3762216856435;4876.87807804805;5076.289319495274;5096.949030509703;5099.694018358892;4927.728974906378;5054.090263752523;5057.595392368602;5059.822906198284;5061.266116413118;4810;4923.064617722621;5028.522290382426;5034.119029169899;5040.823571175009;4915.188993816034;4942.678725882806;4955.380577427822;4959.578435832958;4962.751862406865;4455.22033644111;4467.352233926063;4470.038941627566;4470.329450582439;4633.212353899845;18545.165467553994;19232.71150932737;19747.802521974885;19972.10125544354;20010.89994550018;1841.0978620476005;1940.9902950485157;2044.4479990402508;2315.0623997281127;2390.1873363056643;8656.740297791077;8660.913390866073;8785.34109941757;9165.679201227991;9234.353595248336;1666.991665041667;1714.2285971312835;1717.6221231329087;1720.329071662053;1727.153694689593;60566.69716651433;61640;68946.3105368945;70470;73200.6339968302;9391.90608093924;9559.94840567537;9795.853062204073;9875.20998320147;10086.848697269546;12708.3010434427;12729.299888506035;12809.167404118702;12861.614151575468;12866.742665146645;6779.796606101825;6936.514443988974;6958.304169583002;7000.719971201095;7041.788746337618;6352.396522330371;6469.805905822739;6492.707828147744;6684.832879177962;6697;3920.9805450583053;3959.366501359769;4098.8360465581045;4100.938485922714;4289.528151903288;1694.6610677864476;1797.0834874213983;1798.5683435975272;1803.9007854568124;1823.6079242962826;794.4756460736002;809.1059379385694;813.5118928642885;862.1723145779996;895.7841349555129;16025.759613605805;16862.156892155344;17065.573360666083;17066;17443.215055322285;820.1306614988132;840.5503055865083;868.9565521723888;882.1751662195867;887.4143065576689;8953.597088130919;9170.724878253663;10024.248181386425;10088.142507886912;10610.257281990187;366000;371819;374072;376631;376737.3957562555;78970;79034;79193.20806791974;80005.19994799978;80993.19006809975;907.5552979040223;910.9908900911171;942.7454587261401;945.5036106044245;950.2920324358397;15749.921250393674;15767.763483547986;16119.516414507583;16187.27157277949;16645.167741613113;36005.27989440249;36846.44730328993;37126.814365927996;37877.242455151296;37993.240135197695;48676.5132348672;49057.75471122622;50882.745586271834;51340;51819;7347.448941329529;7407.296306850841;7504.174540800398;7555.622218889143;7661.118971318369;10434.895651043393;10610.787784244427;10616.363018218623;10762;10854.67435976922;9028;9327.720168394959;9466.290028247771;9474.194693451134;9841.45871977048;9270.72187834366;9305.581248843953;9313.161815436642;9560.569774360032;9808.509574521388;9476.147146756824;9590.376625519319;10154.695359139238;10156.898431015596;10363.63727269542;7399.519031262951;7532.209118042527;7611.467197296136;7612.238776122565;7614.923850761422;7666.425018123775;9685.128338449573;9812.411255324418;9919.65281215154;9972.900270997487 02:32:36 INFO - PROCESS | 8432 | |3;mootools.html;1185.3125187391313;1354.9729005419892;1385.501219560958;1429.3353590580384;1687.0974028894543;6566.146400967874;7129;7337.559746415205;7357.999999999994;7546.320831125197;7380.96309518453;7408.3332500074985;7433.145188303347;7434.553926764398;7456.478046536745;2093.780153083927;2122.119320482006;2122.352682431858;2122.6603743400983;2127.8936053197353;2055.2703790154505;2076.8650037747498;2103.821175200102;2107.8840663763485;2108.926187583435;2058.4570012859176;2082.1775398717496;2090.1534878374205;2094.068139677844;2108.2621082621113;2029.8883561404116;2030.7360043194437;2032.9491762705902;2034.338839877031;2035.3588619584784;2016.4253187841396;2026.0781344488223;2044.877307361563;2045.3557129504159;2051.1180192517213;7335.083114610674;7444.36722878556;7480.251974802476;7484.32641062307;7488.513246639006;4241.851535196253;4388.956110438919;4394.670399720034;4396.956030439686;4398.164348773723;2587.650667159947;2695.878685459159;2752.8892351642517;2759.9586006209925;2764.847933363664;794.6106407860165;804.5172896262254;812.3257696112272;822.0464261456682;825.5830805443272;10060.547275372553;10102.898971010269;10116.848247276297;10142.695719128364;10194.235432342604;3606.819659017091;3674.540682414698;3772.245550889833;3800.467934489174;3831.482749828793;8027.518348898968;8033.477823941425;8036.357091432671;8047.678092876336;8086.43394962347;4333.7833108345085;4337.045849913077;4337.891552711144;4404.7357158570585;4410.272305069691;3588.4976103345552;3705.555333360014;3945.743526670815;4107.979460102681;4109.856155034559;3186.2193762527863;3216.8552415141376;3284.211789170582;3311.966880331214;3319.867205311809;1017.7557386227252;1018.1752780248023;1021.6526381030485;1022.3099407899638;1035.223582313265;798.7204478432618;802.7952872017715;816.1797393619374;820.1142765812908;840.1346612988632;5040.47075057121;5041.092603331363;5045.621578381636;5190.09173394662;5192.844214673566;359.84310441929324;382.037266089453;383.31578133032406;386.78533413955523;387.42080589518287;3297.604287485517;3428.708559772397;3464.1859163097156;3566.4828599852876;3575.928481430357;8590.484570925764;8872.201501864864;8936.41913275635;8945.552722363856;8995.100489950952;8881.955590222007;8891.688790892287;8914.108589141035;8955.955220223857;8963.103689631114;6627.072209890715;6704.698288577026;6788.083608712761;6799.762008329685;6800.625965571842;4795.736234506996;4822.228443449031;4936.753162341796;4987.925181122214;5154.175331947021;7986.201379861967;8138.552379618941;8220.671173153007;8308.086110527958;8350.08149103586;8327.583620819056;8332.916670833214;8357.122502137188;8402.285805706584;8438.957805210935;5855.94144058554;5919.91120133207;5920.348761636131;5921.61509501881;6321.431071203614;7116.679749411185;7396.889046664197;7404.96297518509;7417.517861338995;7418.480706350504;6486.6756662167645;6721.428678562377;6727.058211850247;6750.898736518858;6833.760818371333;6466.385693359123;6473.805785826245;6519.217693876765;6528.37980391862;6568.211814582281;6092.482139018233;6180.81457556274;6190.690465476799;6193.504519638508;6198.72105755233;4323.913521729485;4389.692721509464;4433.556644335541;4490.640748740158;4530.252508336088;4337.544557821383;4428.33574963758;4445.555444455528;4449.043455657049;4476.440444944382 02:32:36 INFO - PROCESS | 8432 | |4;prototype.html;293.2843860979211;298.3763933379237;302.4042636007066;305.0224031977512;305.1395065914123;4770.141374552579;4778.204750221124;4791.592714619253;4794.616430685545;4795.160846851804;4672.229082201441;4699.90600187996;4704.647151463645;4705.64707646927;4726.834560790373;3487.7035451986612;3639.490471334015;3646.270745850827;3755.7183211259266;3794.260119276742;3762.322781899257;3762.7554208976467;3767.566729826064;3767.7550959187565;3787.4508196311517;3730.7388482806214;3737.514123163985;3740.45763364312;3748.4939533162947;3750.6811920986747;3535.946960795577;3597.7121830253777;3658.9451158232646;3670.376036073874;3760.8683696070643;3273.2635157089703;3277.066036179677;3278.5246139309666;3279.6884295991845;3283.1956170738085;4603.5856772890265;4612.746298953556;4615.030843522864;4621.792019359137;4630.143423466636;4142.378279546635;4189.832406703728;4206.074663574009;4229.471316085489;4234.745915245065;4902.632302577285;4954.851354459372;4954.975225123887;4958.9504104959215;4959.132151873408;3597.0647631615707;3597.730170237243;3599.1721903961975;3599.8200089995657;3610.4764809102794;5190.766415511311;5196.778756992142;5197.818076367347;5206.349206349207;5222.843314700565;3374.257663314067;3565.7682250653625;3590.4793804898145;3595.3035223582315;3606.1886075633297;3644.526211592476;3645.8906232813056;3648.562172539312;3648.7810731356203;3675;4184.979075104666;4196.720000399907;4223.260929337353;4227.217964676544;4233.703640745119;4815.2054910940005;5020.447750747415;5047.274471785268;5048.798048078109;5050.242463630485;1251.5932321995388;1266.4997326056157;1267.8462599034833;1268.0743057568027;1268.822364868919;778.1518145221622;798.9041315042232;805.3557154276556;808.7775861638097;811.5212024905217;4218.346156345771;4336.395533652569;4341.370501277297;4342.913141737147;4365.912681746411;4947.529984651453;4972.900541989212;5056.974715126401;5075.720835354091;5079.3650793650795;4422.226110430662;4435.223835828781;4437.400950871655;4437.866863994085;4439.42287502629;2570.8071894607606;2642.9867850660626;2655.64148839908;2704.6348742919454;2705.418335057972;4837.467878533358;4859.489753575895;4870.245112007645;4878.853634390974;4891.364122664031;5190.195519694454;5209.426963034063;5216.713080780593;5227.085260079471;5227.398849132398;4592.242280023758;4845.273209018605;4919.385076865392;4920.114379411741;4922.433920099091;5120.8719782004255;5143.502418355554;5146.922796157985;5150.742462876766;5164;4865.878353041202;5080.212567052113;5085.7457127144235;5094.898102038012;5097.8725531862;4859.902801944012;4890.266460031024;4899.632527560519;4907;4913.6069114471475;3622.5290712207243;3650.7079433645777;3658.725595580289;3661.707063434972;3666.2667466506273;5147.9227811583605;5195.142801437721;5198.168293073241;5206.271122042993;5218.765155568084;4804.375431193923;4998.600111991104;5019.52314530119;5034.974825125851;5052.1663925451885;5006.649534532694;5007.924881126713;5026.246063090565;5026.698398096126;5032.6477146600855;4786.832460863853;4913.877153071202;4929.433115191656;4934.5312195341385;4940.2342636891335;4745.928811067905;4888.973315603763;4983.152864013199;5036.974815125901;5070.264811602223;4791.1854984652;4920.286558449076;4926.852194434173;4931.7040977541465;4932.8766780830765 02:32:36 INFO - PROCESS | 8432 | |5;yui.html;596.1769286472438;598.739548296491;611.7338957553465;632.5414074795774;632.6330728177658;11984.161108722383;12769.61691149267;12775.233485990835;12781.936090319547;13468.66328341792;13018;13388.866111338884;13425.194488330708;13444.932775336134;13517.864821351783;764.2586690909809;787.5865170785355;790.1782146567563;790.2374208888422;790.9011373578303;626.924769027715;643.6363454648132;748.0649188514357;767.9961600191991;776.5884081436848;816.7345612675874;816.8611336072881;818.3698552114897;819.0253598218131;819.491915012693;809.6842231529708;809.8825670277806;810.1169724999778;810.222186700768;810.2990912860392;482.9323894654751;491.275368830975;568.3350479938441;583.8131797824698;600.2676734384045;12547.435365408579;12625.116241863074;12629.24224546521;12634.305113218768;12645.810312845315;11137.665870023913;11460.656180314603;11500.94249528747;11704.18070735049;12169.756604867942;11511.942440287829;11980.161388702794;12008.159428839985;12303;12487.93756031214;4114.362273847559;4114.526829414625;4157.272477316487;4179.331306990867;4203.243416185085;61013;62704.37295627031;63687.04469432962;64245.67877160631;64310;10469.528871200815;10493.187793801273;10556.47217639115;10568.735781605368;10756.946215268874;19303.324383646504;19308.80691193098;19337.8066219336;19412.320568780025;19451.416457506297;6385.329540398284;6616.636085015371;6638.236602790645;6641.800745977628;6840.521163518605;3578.3737845876867;3586.264815712773;3633.454981752758;3710.350688629533;3714.182879766447;2892.913212603625;3037.407705497451;3046.070948360727;3216.3084936738715;3399.9490007649906;534.398801348483;539.2019810680137;542.6120323968303;545.4027839515724;554.5923746046652;467.4344043707085;493.25764724090016;548.6077454619966;598.2073752278249;601.2634522709645;7358.595277259695;7541.170471248159;8226.958865205635;8258.587070646443;8416.957915210385;482.3054801086424;491.61408294488655;549.6235078970918;612.4120843989731;626.2985456288894;3460.2214501737412;3702.5371828521434;3771.1891943232336;3805.2769973705463;3999.64003239704;87169.5641521801;88928;89996.5500172495;95004;95340;77837;78964.21035789569;79957.20042799614;80047;80604.59697701473;55798.721006394706;68546.65726671435;68947.65526172437;69219.65390173017;71945;7078.964605176941;7207.315305046012;7214.422846172399;7382.926170738224;7497.250274972459;41188.794056029525;41923.58076419319;41997.52603647091;42276.36585451159;43370.78314608407;52078.479215207364;58652;58918.41081589129;59621.403785961586;59782.40217597768;9241.907580924104;9412.247020238501;9452.149306562442;9533.380330278787;9669.661561845302;10581.153507719519;10659.4137322448;12080;12289.078319125923;12493.189032467986;11514.194006419806;11788.646340609796;11918.702032449259;12764.17032892859;13317.933410332886;10039.598416063276;11175.441227938732;11649.88350116488;11777.646670599554;13034.116512711613;11728.824067639163;12035.879641203475;12312.26126432417;12770.68073298175;13044;9422.905770942478;9551.188149007412;9825.410475371214;9992.20062394992;10007.748256642488;8945.776355591162;10169.186465082628;10246.487675616338;10265.640702575374;10303.330283531546 02:32:36 INFO - PROCESS | 8432 | __end_tp_report 02:32:36 INFO - PROCESS | 8432 | __start_cc_report 02:32:36 INFO - PROCESS | 8432 | _x_x_mozilla_cycle_collect,1271 02:32:36 INFO - PROCESS | 8432 | __end_cc_report 02:32:36 INFO - PROCESS | 8432 | __startTimestamp1475487156700__endTimestamp 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | ------- Summary: start ------- 02:32:36 INFO - PROCESS | 8432 | Number of tests: 6 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | [#0] dojo.html Cycles:165 Average:4591.84 Median:4703.55 stddev:491.84 (10.5%) stddev-sans-first:465.78 02:32:36 INFO - PROCESS | 8432 | Values: 2522.1 2557.1 2591.4 2596.5 2611.1 4462.6 4536.8 4586.2 4595.6 4666.3 4605.7 4664.3 4689.9 4716.2 4738.5 4196.6 4212.9 4273.0 4285.5 4353.8 4338.1 4370.2 4389.4 4400.4 4450.5 4312.2 4331.3 4356.4 4375.7 4390.9 4159.9 4215.5 4216.5 4218.9 4290.0 4267.6 4291.8 4321.8 4344.5 4347.3 4627.7 4634.6 4638.1 4660.0 4706.5 4791.0 4804.7 4909.8 4974.1 4981.7 4948.4 4993.3 4998.9 5040.0 5052.6 4652.0 4652.3 4653.8 4657.6 4715.6 4959.4 5028.6 5079.1 5091.5 5151.1 4782.8 4809.5 4822.0 4843.6 4847.3 4909.5 4924.8 4999.0 5000.1 5066.0 4772.0 4943.3 4951.3 4959.1 5017.5 4806.2 4849.3 4935.9 4941.9 5023.6 3958.4 3985.7 3992.1 3996.1 4040.6 3561.1 3565.7 3588.6 3613.1 3613.9 4224.7 4287.8 4329.2 4388.1 4395.9 5022.7 5062.8 5074.3 5110.3 5120.3 4375.1 4388.8 4389.9 4441.1 4445.0 4412.5 4460.8 4530.5 4627.1 4635.6 4704.9 4724.8 4726.3 4781.2 4782.1 5006.1 5017.8 5020.7 5022.5 5082.6 4529.9 4565.1 4703.6 4724.7 4789.6 4866.8 4904.6 4908.7 4925.7 4985.7 4986.7 4995.6 4996.0 5004.8 5066.0 4663.6 4823.2 4872.2 4873.6 4929.9 4763.0 4834.0 4867.6 4892.2 4947.6 4796.0 4797.6 4803.1 4805.5 4854.0 4654.1 4696.6 4701.9 4915.8 4927.3 4648.7 4659.8 4664.7 4667.4 4675.6 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | [#1] ext.html Cycles:180 Average:46067.08 Median:191867.50 stddev:87185.18 (45.4%) stddev-sans-first:87362.71 02:32:36 INFO - PROCESS | 8432 | Values: 526.7 553.3 561.5 569.1 576.8 27594.9 28298.0 37252.3 38848.8 39079.2 39692.4 39837.4 40225.0 40237.0 40255.4 7480.3 7669.7 7670.8 7676.6 7678.2 7410.7 7495.4 7499.4 7503.5 7506.5 7503.2 7536.4 7541.1 7554.5 7555.5 7485.7 7515.8 7519.1 7529.5 7531.8 7530.6 7571.0 7590.3 7592.0 7598.7 37478.4 37890.4 37937.8 37945.0 37963.4 3018.5 3024.3 3025.8 3269.5 3297.7 27237.5 27560.0 27758.0 28528.7 28889.0 3269.6 3415.1 3425.4 3440.3 3464.5 243153.0 244228.0 245246.0 245927.0 246915.0 29653.7 30838.2 48779.5 48877.3 48977.0 32424.7 32500.7 32730.7 32760.3 32904.6 12596.9 12736.7 12738.4 12741.7 12741.9 9921.0 9946.0 9948.7 9953.6 9958.5 7797.8 7816.1 7884.4 7934.5 7942.6 3123.2 3128.7 3147.2 3148.0 3190.7 810.5 815.4 890.5 927.8 1012.9 25959.9 26748.5 26819.6 27332.9 27353.0 766.8 910.6 917.9 965.3 996.3 14211.8 14478.6 14580.2 14625.7 14836.6 378421.0 381111.0 381978.0 382038.0 382437.0 47956.3 48052.0 48172.0 48269.5 48271.0 1073.8 1096.5 1103.6 1167.3 1199.1 26432.9 27972.9 29482.0 30414.2 30568.4 44127.6 44899.8 45002.8 45211.3 45255.5 346208.0 347300.0 348391.0 348831.0 349044.0 24124.5 24805.0 25243.7 25274.7 26370.7 40010.0 40170.2 40204.8 40444.6 40955.4 33996.3 34503.8 34530.8 34632.8 34904.0 33904.0 34031.3 34732.3 35129.0 35205.8 33585.8 34042.5 34241.7 34447.3 34765.7 30123.1 31706.2 31721.4 31790.0 32328.0 24339.6 24666.6 24723.1 24729.9 25236.5 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | [#2] jquery.html Cycles:180 Average:23521.90 Median:4949.03 stddev:61801.56 (1248.8%) stddev-sans-first:61950.44 02:32:36 INFO - PROCESS | 8432 | Values: 345.9 356.5 368.2 374.2 384.2 11043.2 11845.8 15706.4 16320.2 17257.8 16918.3 17053.1 17080.6 17091.0 17384.8 4024.4 4876.9 5076.3 5096.9 5099.7 4927.7 5054.1 5057.6 5059.8 5061.3 4810.0 4923.1 5028.5 5034.1 5040.8 4915.2 4942.7 4955.4 4959.6 4962.8 4455.2 4467.4 4470.0 4470.3 4633.2 18545.2 19232.7 19747.8 19972.1 20010.9 1841.1 1941.0 2044.4 2315.1 2390.2 8656.7 8660.9 8785.3 9165.7 9234.4 1667.0 1714.2 1717.6 1720.3 1727.2 60566.7 61640.0 68946.3 70470.0 73200.6 9391.9 9559.9 9795.9 9875.2 10086.8 12708.3 12729.3 12809.2 12861.6 12866.7 6779.8 6936.5 6958.3 7000.7 7041.8 6352.4 6469.8 6492.7 6684.8 6697.0 3921.0 3959.4 4098.8 4100.9 4289.5 1694.7 1797.1 1798.6 1803.9 1823.6 794.5 809.1 813.5 862.2 895.8 16025.8 16862.2 17065.6 17066.0 17443.2 820.1 840.6 869.0 882.2 887.4 8953.6 9170.7 10024.2 10088.1 10610.3 366000.0 371819.0 374072.0 376631.0 376737.4 78970.0 79034.0 79193.2 80005.2 80993.2 907.6 911.0 942.7 945.5 950.3 15749.9 15767.8 16119.5 16187.3 16645.2 36005.3 36846.4 37126.8 37877.2 37993.2 48676.5 49057.8 50882.7 51340.0 51819.0 7347.4 7407.3 7504.2 7555.6 7661.1 10434.9 10610.8 10616.4 10762.0 10854.7 9028.0 9327.7 9466.3 9474.2 9841.5 9270.7 9305.6 9313.2 9560.6 9808.5 9476.1 9590.4 10154.7 10156.9 10363.6 7399.5 7532.2 7611.5 7612.2 7614.9 7666.4 9685.1 9812.4 9919.7 9972.9 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | [#3] mootools.html Cycles:180 Average:4821.19 Median:4808.98 stddev:2706.71 (56.3%) stddev-sans-first:2700.51 02:32:36 INFO - PROCESS | 8432 | Values: 1185.3 1355.0 1385.5 1429.3 1687.1 6566.1 7129.0 7337.6 7358.0 7546.3 7381.0 7408.3 7433.1 7434.6 7456.5 2093.8 2122.1 2122.4 2122.7 2127.9 2055.3 2076.9 2103.8 2107.9 2108.9 2058.5 2082.2 2090.2 2094.1 2108.3 2029.9 2030.7 2032.9 2034.3 2035.4 2016.4 2026.1 2044.9 2045.4 2051.1 7335.1 7444.4 7480.3 7484.3 7488.5 4241.9 4389.0 4394.7 4397.0 4398.2 2587.7 2695.9 2752.9 2760.0 2764.8 794.6 804.5 812.3 822.0 825.6 10060.5 10102.9 10116.8 10142.7 10194.2 3606.8 3674.5 3772.2 3800.5 3831.5 8027.5 8033.5 8036.4 8047.7 8086.4 4333.8 4337.0 4337.9 4404.7 4410.3 3588.5 3705.6 3945.7 4108.0 4109.9 3186.2 3216.9 3284.2 3312.0 3319.9 1017.8 1018.2 1021.7 1022.3 1035.2 798.7 802.8 816.2 820.1 840.1 5040.5 5041.1 5045.6 5190.1 5192.8 359.8 382.0 383.3 386.8 387.4 3297.6 3428.7 3464.2 3566.5 3575.9 8590.5 8872.2 8936.4 8945.6 8995.1 8882.0 8891.7 8914.1 8956.0 8963.1 6627.1 6704.7 6788.1 6799.8 6800.6 4795.7 4822.2 4936.8 4987.9 5154.2 7986.2 8138.6 8220.7 8308.1 8350.1 8327.6 8332.9 8357.1 8402.3 8439.0 5855.9 5919.9 5920.3 5921.6 6321.4 7116.7 7396.9 7405.0 7417.5 7418.5 6486.7 6721.4 6727.1 6750.9 6833.8 6466.4 6473.8 6519.2 6528.4 6568.2 6092.5 6180.8 6190.7 6193.5 6198.7 4323.9 4389.7 4433.6 4490.6 4530.3 4337.5 4428.3 4445.6 4449.0 4476.4 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | [#4] prototype.html Cycles:180 Average:4137.93 Median:4736.38 stddev:1210.35 (25.6%) stddev-sans-first:1178.85 02:32:36 INFO - PROCESS | 8432 | Values: 293.3 298.4 302.4 305.0 305.1 4770.1 4778.2 4791.6 4794.6 4795.2 4672.2 4699.9 4704.6 4705.6 4726.8 3487.7 3639.5 3646.3 3755.7 3794.3 3762.3 3762.8 3767.6 3767.8 3787.5 3730.7 3737.5 3740.5 3748.5 3750.7 3535.9 3597.7 3658.9 3670.4 3760.9 3273.3 3277.1 3278.5 3279.7 3283.2 4603.6 4612.7 4615.0 4621.8 4630.1 4142.4 4189.8 4206.1 4229.5 4234.7 4902.6 4954.9 4955.0 4959.0 4959.1 3597.1 3597.7 3599.2 3599.8 3610.5 5190.8 5196.8 5197.8 5206.3 5222.8 3374.3 3565.8 3590.5 3595.3 3606.2 3644.5 3645.9 3648.6 3648.8 3675.0 4185.0 4196.7 4223.3 4227.2 4233.7 4815.2 5020.4 5047.3 5048.8 5050.2 1251.6 1266.5 1267.8 1268.1 1268.8 778.2 798.9 805.4 808.8 811.5 4218.3 4336.4 4341.4 4342.9 4365.9 4947.5 4972.9 5057.0 5075.7 5079.4 4422.2 4435.2 4437.4 4437.9 4439.4 2570.8 2643.0 2655.6 2704.6 2705.4 4837.5 4859.5 4870.2 4878.9 4891.4 5190.2 5209.4 5216.7 5227.1 5227.4 4592.2 4845.3 4919.4 4920.1 4922.4 5120.9 5143.5 5146.9 5150.7 5164.0 4865.9 5080.2 5085.7 5094.9 5097.9 4859.9 4890.3 4899.6 4907.0 4913.6 3622.5 3650.7 3658.7 3661.7 3666.3 5147.9 5195.1 5198.2 5206.3 5218.8 4804.4 4998.6 5019.5 5035.0 5052.2 5006.6 5007.9 5026.2 5026.7 5032.6 4786.8 4913.9 4929.4 4934.5 4940.2 4745.9 4889.0 4983.2 5037.0 5070.3 4791.2 4920.3 4926.9 4931.7 4932.9 02:32:36 INFO - PROCESS | 8432 | 02:32:36 INFO - PROCESS | 8432 | [#5] yui.html Cycles:180 Average:17016.17 Median:26285.87 stddev:23761.44 (90.4%) stddev-sans-first:23796.11 02:32:36 INFO - PROCESS | 8432 | Values: 596.2 598.7 611.7 632.5 632.6 11984.2 12769.6 12775.2 12781.9 13468.7 13018.0 13388.9 13425.2 13444.9 13517.9 764.3 787.6 790.2 790.2 790.9 626.9 643.6 748.1 768.0 776.6 816.7 816.9 818.4 819.0 819.5 809.7 809.9 810.1 810.2 810.3 482.9 491.3 568.3 583.8 600.3 12547.4 12625.1 12629.2 12634.3 12645.8 11137.7 11460.7 11500.9 11704.2 12169.8 11511.9 11980.2 12008.2 12303.0 12487.9 4114.4 4114.5 4157.3 4179.3 4203.2 61013.0 62704.4 63687.0 64245.7 64310.0 10469.5 10493.2 10556.5 10568.7 10756.9 19303.3 19308.8 19337.8 19412.3 19451.4 6385.3 6616.6 6638.2 6641.8 6840.5 3578.4 3586.3 3633.5 3710.4 3714.2 2892.9 3037.4 3046.1 3216.3 3399.9 534.4 539.2 542.6 545.4 554.6 467.4 493.3 548.6 598.2 601.3 7358.6 7541.2 8227.0 8258.6 8417.0 482.3 491.6 549.6 612.4 626.3 3460.2 3702.5 3771.2 3805.3 3999.6 87169.6 88928.0 89996.6 95004.0 95340.0 77837.0 78964.2 79957.2 80047.0 80604.6 55798.7 68546.7 68947.7 69219.7 71945.0 7079.0 7207.3 7214.4 7382.9 7497.3 41188.8 41923.6 41997.5 42276.4 43370.8 52078.5 58652.0 58918.4 59621.4 59782.4 9241.9 9412.2 9452.1 9533.4 9669.7 10581.2 10659.4 12080.0 12289.1 12493.2 11514.2 11788.6 11918.7 12764.2 13317.9 10039.6 11175.4 11649.9 11777.6 13034.1 11728.8 12035.9 12312.3 12770.7 13044.0 9422.9 9551.2 9825.4 9992.2 10007.7 8945.8 10169.2 10246.5 10265.6 10303.3 02:32:36 INFO - PROCESS | 8432 | -------- Summary: end -------- 02:32:36 INFO - PROCESS | 8432 | 02:32:37 INFO - TEST-INFO | 8432: exit 0 02:32:37 INFO - TEST-OK | dromaeo_css | took 1121678ms 02:32:37 INFO - TEST-START | kraken 02:32:37 INFO - operating with platform_type : linux_ 02:32:37 INFO - Initialising browser for kraken test... 02:32:37 INFO - TEST-INFO | started process 8742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5Urm2/profile http://localhost:51845/getInfo.html) 02:32:42 INFO - PROCESS | 8742 | __metrics Screen width/height:1600/1200 02:32:42 INFO - PROCESS | 8742 | colorDepth:24 02:32:42 INFO - PROCESS | 8742 | Browser inner width/height: 1024/697 02:32:42 INFO - PROCESS | 8742 | __metrics 02:32:42 INFO - PROCESS | 8742 | 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" 02:32:42 INFO - PROCESS | 8742 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:43 INFO - PROCESS | 8742 | console.error: PushService: 02:32:43 INFO - PROCESS | 8742 | stateChangeProcessEnqueue: Error transitioning state 02:32:43 INFO - PROCESS | 8742 | UnknownError 02:32:43 INFO - TEST-INFO | 8742: exit 0 02:32:43 INFO - Browser initialized. 02:32:43 INFO - Running cycle 1/1 for kraken test... 02:32:43 INFO - TEST-INFO | started process 8825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5Urm2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:56 INFO - PROCESS | 8825 | RSS: Main: 175509504 02:32:56 INFO - PROCESS | 8825 | 02:32:59 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51845/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:00 INFO - PROCESS | 8825 | RSS: Main: 233414656 02:33:00 INFO - PROCESS | 8825 | 02:33:02 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51845/tests/kraken/driver.html?testName=audio-dft) 02:33:03 INFO - PROCESS | 8825 | RSS: Main: 219095040 02:33:03 INFO - PROCESS | 8825 | 02:33:06 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51845/tests/kraken/driver.html?testName=audio-fft) 02:33:07 INFO - PROCESS | 8825 | RSS: Main: 301305856 02:33:07 INFO - PROCESS | 8825 | 02:33:09 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51845/tests/kraken/driver.html?testName=audio-oscillator) 02:33:10 INFO - PROCESS | 8825 | RSS: Main: 212267008 02:33:10 INFO - PROCESS | 8825 | 02:33:12 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:13 INFO - PROCESS | 8825 | RSS: Main: 215158784 02:33:13 INFO - PROCESS | 8825 | 02:33:16 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51845/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:16 INFO - PROCESS | 8825 | RSS: Main: 250695680 02:33:16 INFO - PROCESS | 8825 | 02:33:20 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51845/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:20 INFO - PROCESS | 8825 | RSS: Main: 249327616 02:33:20 INFO - PROCESS | 8825 | 02:33:23 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51845/tests/kraken/driver.html?testName=json-parse-financial) 02:33:24 INFO - PROCESS | 8825 | RSS: Main: 249901056 02:33:24 INFO - PROCESS | 8825 | 02:33:26 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:26 INFO - PROCESS | 8825 | RSS: Main: 211755008 02:33:26 INFO - PROCESS | 8825 | 02:33:28 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:29 INFO - PROCESS | 8825 | RSS: Main: 219815936 02:33:29 INFO - PROCESS | 8825 | 02:33:31 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:32 INFO - PROCESS | 8825 | RSS: Main: 228139008 02:33:32 INFO - PROCESS | 8825 | 02:33:34 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:35 INFO - PROCESS | 8825 | RSS: Main: 237010944 02:33:35 INFO - PROCESS | 8825 | 02:33:38 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:39 INFO - PROCESS | 8825 | RSS: Main: 233590784 02:33:39 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:51845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51845/tests/kraken/driver.html?testName=ai-astar) 02:33:41 INFO - PROCESS | 8825 | RSS: Main: 285122560 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | __start_tp_report 02:33:41 INFO - PROCESS | 8825 | _x_x_mozilla_page_load 02:33:41 INFO - PROCESS | 8825 | _x_x_mozilla_page_load_details 02:33:41 INFO - PROCESS | 8825 | |i|pagename|runs| 02:33:41 INFO - PROCESS | 8825 | |0;ai-astar;113;115;115;117;114;116;114;114;115;114 02:33:41 INFO - PROCESS | 8825 | |1;audio-beat-detection;153;136;129;171;128;133;133;125;159;130 02:33:41 INFO - PROCESS | 8825 | |2;audio-dft;162;162;164;163;164;163;163;161;162;161 02:33:41 INFO - PROCESS | 8825 | |3;audio-fft;78;76;75;101;77;78;77;76;101;77 02:33:41 INFO - PROCESS | 8825 | |4;audio-oscillator;85;83;124;84;83;84;118;84;84;111 02:33:41 INFO - PROCESS | 8825 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;120;117;118 02:33:41 INFO - PROCESS | 8825 | |6;imaging-darkroom;148;147;146;147;147;147;146;147;147;146 02:33:41 INFO - PROCESS | 8825 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;96 02:33:41 INFO - PROCESS | 8825 | |8;json-parse-financial;63;64;63;63;65;64;64;64;65;64 02:33:41 INFO - PROCESS | 8825 | |9;json-stringify-tinderbox;65;66;66;66;67;66;66;66;66;67 02:33:41 INFO - PROCESS | 8825 | |10;stanford-crypto-aes;84;86;84;83;84;89;84;94;85;84 02:33:41 INFO - PROCESS | 8825 | |11;stanford-crypto-ccm;142;141;147;140;146;142;139;139;180;141 02:33:41 INFO - PROCESS | 8825 | |12;stanford-crypto-pbkdf2;174;173;175;184;177;178;178;177;176;177 02:33:41 INFO - PROCESS | 8825 | |13;stanford-crypto-sha256-iterative;71;75;75;77;71;70;69;69;69;68 02:33:41 INFO - PROCESS | 8825 | __end_tp_report 02:33:41 INFO - PROCESS | 8825 | __start_cc_report 02:33:41 INFO - PROCESS | 8825 | _x_x_mozilla_cycle_collect,1936 02:33:41 INFO - PROCESS | 8825 | __end_cc_report 02:33:41 INFO - PROCESS | 8825 | __startTimestamp1475487221389__endTimestamp 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | ------- Summary: start ------- 02:33:41 INFO - PROCESS | 8825 | Number of tests: 14 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 02:33:41 INFO - PROCESS | 8825 | Values: 113.0 115.0 115.0 117.0 114.0 116.0 114.0 114.0 115.0 114.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:134.50 stddev:15.61 (11.6%) stddev-sans-first:15.80 02:33:41 INFO - PROCESS | 8825 | Values: 153.0 136.0 129.0 171.0 128.0 133.0 133.0 125.0 159.0 130.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 02:33:41 INFO - PROCESS | 8825 | Values: 162.0 162.0 164.0 163.0 164.0 163.0 163.0 161.0 162.0 161.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:10.27 (13.3%) stddev-sans-first:10.81 02:33:41 INFO - PROCESS | 8825 | Values: 78.0 76.0 75.0 101.0 77.0 78.0 77.0 76.0 101.0 77.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:16.63 (19.8%) stddev-sans-first:17.31 02:33:41 INFO - PROCESS | 8825 | Values: 85.0 83.0 124.0 84.0 83.0 84.0 118.0 84.0 84.0 111.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 02:33:41 INFO - PROCESS | 8825 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 120.0 117.0 118.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 02:33:41 INFO - PROCESS | 8825 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:33:41 INFO - PROCESS | 8825 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 02:33:41 INFO - PROCESS | 8825 | Values: 63.0 64.0 63.0 63.0 65.0 64.0 64.0 64.0 65.0 64.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 02:33:41 INFO - PROCESS | 8825 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 67.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:3.37 (4.0%) stddev-sans-first:3.52 02:33:41 INFO - PROCESS | 8825 | Values: 84.0 86.0 84.0 83.0 84.0 89.0 84.0 94.0 85.0 84.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.00 stddev:12.35 (8.7%) stddev-sans-first:13.02 02:33:41 INFO - PROCESS | 8825 | Values: 142.0 141.0 147.0 140.0 146.0 142.0 139.0 139.0 180.0 141.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.00 stddev:3.00 (1.7%) stddev-sans-first:2.99 02:33:41 INFO - PROCESS | 8825 | Values: 174.0 173.0 175.0 184.0 177.0 178.0 178.0 177.0 176.0 177.0 02:33:41 INFO - PROCESS | 8825 | 02:33:41 INFO - PROCESS | 8825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:3.13 (4.4%) stddev-sans-first:3.32 02:33:41 INFO - PROCESS | 8825 | Values: 71.0 75.0 75.0 77.0 71.0 70.0 69.0 69.0 69.0 68.0 02:33:41 INFO - PROCESS | 8825 | -------- Summary: end -------- 02:33:41 INFO - PROCESS | 8825 | 02:33:42 INFO - TEST-INFO | 8825: exit 0 02:33:42 INFO - TEST-OK | kraken | took 65028ms 02:33:42 INFO - SUITE-END | took 1186s 02:33:43 INFO - Completed test suite (00:19:47) 02:33:43 INFO - javascript benchmark 02:33:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2522.104652848239, 2557.053890060678, 2591.4039770852696, 2596.454744503654, 2611.0600183933793, 4462.62067724243, 4536.841210557631, 4586.220342541767, 4595.632349412047, 4666.276727107295, 4605.723656580608, 4664.2770370592525, 4689.906201875969, 4716.221823399135, 4738.52614738526, 4196.601322874322, 4212.873613791591, 4272.978635106836, 4285.507166675826, 4353.825846966118, 4338.132373525292, 4370.169667763131, 4389.363542286366, 4400.44994375703, 4450.532694067125, 4312.159128969852, 4331.263685173512, 4356.368326592642, 4375.6937014409, 4390.868273951786, 4159.9376009359885, 4215.494140703105, 4216.536181020086, 4218.8523401680795, 4290.0, 4267.594578515036, 4291.849785257501, 4321.805518751664, 4344.478662560481, 4347.260965635818, 4627.699199552018, 4634.559716826896, 4638.072385522909, 4660.044690838404, 4706.482286948433, 4791.0178413425165, 4804.687695299829, 4909.754512274372, 4974.054929563371, 4981.676191047571, 4948.356713627206, 4993.325901003391, 4998.850034498971, 5040.0, 5052.646314757969, 4652.0, 4652.302154676791, 4653.813847446064, 4657.6273898088075, 4715.552022557886, 4959.429665588504, 5028.64799464034, 5079.060373830779, 5091.465396133352, 5151.098557752378, 4782.808687652525, 4809.519048095232, 4822.0, 4843.588294994895, 4847.297141914473, 4909.533594308535, 4924.8276310328965, 4999.009312462806, 5000.149974504343, 5065.9746701266995, 4771.976140119346, 4943.307936888838, 4951.331570238044, 4959.082569724613, 5017.473165317662, 4806.182948898696, 4849.2968519564465, 4935.851924442272, 4941.851744447672, 5023.648344615842, 3958.44581758554, 3985.6811455083525, 3992.1017771001293, 3996.0609256824623, 4040.6363427291685, 3561.0741207285773, 3565.6612621800887, 3588.6411358863907, 3613.0967258185456, 3613.9277214456088, 4224.683148763855, 4287.8070486828165, 4329.19909816685, 4388.100439409914, 4395.912081758411, 5022.698638081727, 5062.772175252123, 5074.289599456005, 5110.2590124431745, 5120.334356533627, 4375.081232941055, 4388.824447022083, 4389.868303950887, 4441.111777644484, 4445.0, 4412.536683648171, 4460.821567137278, 4530.524294948983, 4627.120847039052, 4635.629149668019, 4704.905901882012, 4724.763761811964, 4726.338312636302, 4781.187198176388, 4782.067496838223, 5006.098902197639, 5017.799288028438, 5020.723860187724, 5022.547970682656, 5082.593392528663, 4529.909401812011, 4565.086982603426, 4703.553162449562, 4724.692894961817, 4789.640776941813, 4866.780994855169, 4904.632152588499, 4908.705477671351, 4925.704457732548, 4985.725785081855, 4986.650934434555, 4995.550400463831, 4996.02577497399, 5004.799808007639, 5065.986802639413, 4663.580277775017, 4823.204171311694, 4872.196087645499, 4873.610111191026, 4929.852104436873, 4763.0, 4833.95166048335, 4867.58625516835, 4892.168331383602, 4947.554720075211, 4796.040791841715, 4797.616190704665, 4803.1114243864995, 4805.495422980537, 4853.975730121327, 4654.138984287918, 4696.624270058319, 4701.858944231679, 4915.827946021872, 4927.260910863399, 4648.744319062349, 4659.813607455664, 4664.696794708333, 4667.439907211156, 4675.602573781131], "value": 4559.716126737714, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.6997811247589, 553.3221803290967, 561.5199004850855, 569.0752527143392, 576.8038866785292, 27594.860770884377, 28298.0, 37252.25495490092, 38848.80575597118, 39079.21841563174, 39692.40461393074, 39837.40243896336, 40225.0, 40237.0, 40255.396169057414, 7480.289372509616, 7669.731559395423, 7670.7698769037015, 7676.577788221645, 7678.155402905704, 7410.740624078158, 7495.362894154004, 7499.437542184331, 7503.5497870127965, 7506.512076714996, 7503.174650788409, 7536.43476739244, 7541.095068591777, 7554.508956917783, 7555.546667199958, 7485.700571977114, 7515.8496830063095, 7519.060117485315, 7529.548227106391, 7531.849363012764, 7530.623468826591, 7570.962145189294, 7590.278923502258, 7592.0, 7598.734044308423, 37478.43782343267, 37890.43164352537, 37937.810310948546, 37945.0, 37963.43054854179, 3018.471767440711, 3024.349764800578, 3025.773067019982, 3269.54226408303, 3297.73618110553, 27237.45525089507, 27560.0, 27758.0, 28528.71471285302, 28889.0, 3269.623993240784, 3415.0949998250235, 3425.4348032574594, 3440.2603440260214, 3464.4803279508023, 243153.0, 244228.0, 245246.0, 245927.0, 246915.0, 29653.703462965525, 30838.229044273623, 48779.51220487821, 48877.2668409967, 48977.0, 32424.675753242638, 32500.674993249766, 32730.672693273238, 32760.344793104003, 32904.58360619656, 12596.874031259571, 12736.6815829605, 12738.363081845871, 12741.745165096832, 12741.936290318674, 9920.950395247977, 9946.0, 9948.651797187209, 9953.552090155961, 9958.502074896227, 7797.805054873674, 7816.140224575292, 7884.369250459949, 7934.492446435159, 7942.563159026194, 3123.1567476781142, 3128.71841534263, 3147.213196700825, 3147.970597635031, 3190.6968837960358, 810.5096416667949, 815.4006804998321, 890.496869268861, 927.8097989912052, 1012.9037741414554, 25959.870200649253, 26748.465030699277, 26819.597706034427, 27332.863335683196, 27353.0, 766.7623036858591, 910.6220918318824, 917.866909298148, 965.3339195954769, 996.3175224970918, 14211.78682319766, 14478.565643030726, 14580.1980891052, 14625.707485850437, 14836.554903352917, 378421.0, 381111.0, 381978.0, 382038.0, 382437.0, 47956.28065579019, 48052.0, 48172.0, 48269.5173048265, 48271.0, 1073.8174510333263, 1096.4791723931228, 1103.5585765693786, 1167.3229526874393, 1199.1006744941294, 26432.867835660698, 27972.89463689666, 29482.0, 30414.239644009078, 30568.37860632679, 44127.558724412345, 44899.77550112228, 45002.77498612486, 45211.32183017192, 45255.54744452513, 346208.0, 347300.0, 348391.0, 348831.0, 349044.0, 24124.51750965006, 24805.0, 25243.74756252414, 25274.74725252724, 26370.73629263683, 40010.0, 40170.19659606733, 40204.79897600493, 40444.595554044085, 40955.38566921558, 33996.32007359889, 34503.827480862434, 34530.82734586311, 34632.82683586566, 34904.0, 33904.0, 34031.31937361288, 34732.305353892276, 35129.0, 35205.82397087998, 33585.83207083949, 34042.489362659086, 34241.65758342385, 34447.311053778285, 34765.65234347624, 30123.096307110824, 31706.207344816565, 31721.36557268888, 31790.0, 32328.0, 24339.63490547608, 24666.63000054965, 24723.134690285755, 24729.87635061885, 25236.49527009413], "value": 15978.220046107286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8789423701703, 356.4688613965191, 368.1789609171547, 374.2066818345108, 384.2219505501361, 11043.171762117843, 11845.7630847383, 15706.37174513021, 16320.183990800442, 17257.82742172578, 16918.323267069303, 17053.14734263288, 17080.572985675364, 17091.009073412133, 17384.826151738478, 4024.3762216856435, 4876.87807804805, 5076.289319495274, 5096.949030509703, 5099.694018358892, 4927.728974906378, 5054.090263752523, 5057.595392368602, 5059.822906198284, 5061.266116413118, 4810.0, 4923.064617722621, 5028.522290382426, 5034.119029169899, 5040.823571175009, 4915.188993816034, 4942.678725882806, 4955.380577427822, 4959.578435832958, 4962.751862406865, 4455.22033644111, 4467.352233926063, 4470.038941627566, 4470.329450582439, 4633.212353899845, 18545.165467553994, 19232.71150932737, 19747.802521974885, 19972.10125544354, 20010.89994550018, 1841.0978620476005, 1940.9902950485157, 2044.4479990402508, 2315.0623997281127, 2390.1873363056643, 8656.740297791077, 8660.913390866073, 8785.34109941757, 9165.679201227991, 9234.353595248336, 1666.991665041667, 1714.2285971312835, 1717.6221231329087, 1720.329071662053, 1727.153694689593, 60566.69716651433, 61640.0, 68946.3105368945, 70470.0, 73200.6339968302, 9391.90608093924, 9559.94840567537, 9795.853062204073, 9875.20998320147, 10086.848697269546, 12708.3010434427, 12729.299888506035, 12809.167404118702, 12861.614151575468, 12866.742665146645, 6779.796606101825, 6936.514443988974, 6958.304169583002, 7000.719971201095, 7041.788746337618, 6352.396522330371, 6469.805905822739, 6492.707828147744, 6684.832879177962, 6697.0, 3920.9805450583053, 3959.366501359769, 4098.8360465581045, 4100.938485922714, 4289.528151903288, 1694.6610677864476, 1797.0834874213983, 1798.5683435975272, 1803.9007854568124, 1823.6079242962826, 794.4756460736002, 809.1059379385694, 813.5118928642885, 862.1723145779996, 895.7841349555129, 16025.759613605805, 16862.156892155344, 17065.573360666083, 17066.0, 17443.215055322285, 820.1306614988132, 840.5503055865083, 868.9565521723888, 882.1751662195867, 887.4143065576689, 8953.597088130919, 9170.724878253663, 10024.248181386425, 10088.142507886912, 10610.257281990187, 366000.0, 371819.0, 374072.0, 376631.0, 376737.3957562555, 78970.0, 79034.0, 79193.20806791974, 80005.19994799978, 80993.19006809975, 907.5552979040223, 910.9908900911171, 942.7454587261401, 945.5036106044245, 950.2920324358397, 15749.921250393674, 15767.763483547986, 16119.516414507583, 16187.27157277949, 16645.167741613113, 36005.27989440249, 36846.44730328993, 37126.814365927996, 37877.242455151296, 37993.240135197695, 48676.5132348672, 49057.75471122622, 50882.745586271834, 51340.0, 51819.0, 7347.448941329529, 7407.296306850841, 7504.174540800398, 7555.622218889143, 7661.118971318369, 10434.895651043393, 10610.787784244427, 10616.363018218623, 10762.0, 10854.67435976922, 9028.0, 9327.720168394959, 9466.290028247771, 9474.194693451134, 9841.45871977048, 9270.72187834366, 9305.581248843953, 9313.161815436642, 9560.569774360032, 9808.509574521388, 9476.147146756824, 9590.376625519319, 10154.695359139238, 10156.898431015596, 10363.63727269542, 7399.519031262951, 7532.209118042527, 7611.467197296136, 7612.238776122565, 7614.923850761422, 7666.425018123775, 9685.128338449573, 9812.411255324418, 9919.65281215154, 9972.900270997487], "value": 7903.005107781941, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1185.3125187391313, 1354.9729005419892, 1385.501219560958, 1429.3353590580384, 1687.0974028894543, 6566.146400967874, 7129.0, 7337.559746415205, 7357.999999999994, 7546.320831125197, 7380.96309518453, 7408.3332500074985, 7433.145188303347, 7434.553926764398, 7456.478046536745, 2093.780153083927, 2122.119320482006, 2122.352682431858, 2122.6603743400983, 2127.8936053197353, 2055.2703790154505, 2076.8650037747498, 2103.821175200102, 2107.8840663763485, 2108.926187583435, 2058.4570012859176, 2082.1775398717496, 2090.1534878374205, 2094.068139677844, 2108.2621082621113, 2029.8883561404116, 2030.7360043194437, 2032.9491762705902, 2034.338839877031, 2035.3588619584784, 2016.4253187841396, 2026.0781344488223, 2044.877307361563, 2045.3557129504159, 2051.1180192517213, 7335.083114610674, 7444.36722878556, 7480.251974802476, 7484.32641062307, 7488.513246639006, 4241.851535196253, 4388.956110438919, 4394.670399720034, 4396.956030439686, 4398.164348773723, 2587.650667159947, 2695.878685459159, 2752.8892351642517, 2759.9586006209925, 2764.847933363664, 794.6106407860165, 804.5172896262254, 812.3257696112272, 822.0464261456682, 825.5830805443272, 10060.547275372553, 10102.898971010269, 10116.848247276297, 10142.695719128364, 10194.235432342604, 3606.819659017091, 3674.540682414698, 3772.245550889833, 3800.467934489174, 3831.482749828793, 8027.518348898968, 8033.477823941425, 8036.357091432671, 8047.678092876336, 8086.43394962347, 4333.7833108345085, 4337.045849913077, 4337.891552711144, 4404.7357158570585, 4410.272305069691, 3588.4976103345552, 3705.555333360014, 3945.743526670815, 4107.979460102681, 4109.856155034559, 3186.2193762527863, 3216.8552415141376, 3284.211789170582, 3311.966880331214, 3319.867205311809, 1017.7557386227252, 1018.1752780248023, 1021.6526381030485, 1022.3099407899638, 1035.223582313265, 798.7204478432618, 802.7952872017715, 816.1797393619374, 820.1142765812908, 840.1346612988632, 5040.47075057121, 5041.092603331363, 5045.621578381636, 5190.09173394662, 5192.844214673566, 359.84310441929324, 382.037266089453, 383.31578133032406, 386.78533413955523, 387.42080589518287, 3297.604287485517, 3428.708559772397, 3464.1859163097156, 3566.4828599852876, 3575.928481430357, 8590.484570925764, 8872.201501864864, 8936.41913275635, 8945.552722363856, 8995.100489950952, 8881.955590222007, 8891.688790892287, 8914.108589141035, 8955.955220223857, 8963.103689631114, 6627.072209890715, 6704.698288577026, 6788.083608712761, 6799.762008329685, 6800.625965571842, 4795.736234506996, 4822.228443449031, 4936.753162341796, 4987.925181122214, 5154.175331947021, 7986.201379861967, 8138.552379618941, 8220.671173153007, 8308.086110527958, 8350.08149103586, 8327.583620819056, 8332.916670833214, 8357.122502137188, 8402.285805706584, 8438.957805210935, 5855.94144058554, 5919.91120133207, 5920.348761636131, 5921.61509501881, 6321.431071203614, 7116.679749411185, 7396.889046664197, 7404.96297518509, 7417.517861338995, 7418.480706350504, 6486.6756662167645, 6721.428678562377, 6727.058211850247, 6750.898736518858, 6833.760818371333, 6466.385693359123, 6473.805785826245, 6519.217693876765, 6528.37980391862, 6568.211814582281, 6092.482139018233, 6180.81457556274, 6190.690465476799, 6193.504519638508, 6198.72105755233, 4323.913521729485, 4389.692721509464, 4433.556644335541, 4490.640748740158, 4530.252508336088, 4337.544557821383, 4428.33574963758, 4445.555444455528, 4449.043455657049, 4476.440444944382], "value": 3810.5079927820884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2843860979211, 298.3763933379237, 302.4042636007066, 305.0224031977512, 305.1395065914123, 4770.141374552579, 4778.204750221124, 4791.592714619253, 4794.616430685545, 4795.160846851804, 4672.229082201441, 4699.90600187996, 4704.647151463645, 4705.64707646927, 4726.834560790373, 3487.7035451986612, 3639.490471334015, 3646.270745850827, 3755.7183211259266, 3794.260119276742, 3762.322781899257, 3762.7554208976467, 3767.566729826064, 3767.7550959187565, 3787.4508196311517, 3730.7388482806214, 3737.514123163985, 3740.45763364312, 3748.4939533162947, 3750.6811920986747, 3535.946960795577, 3597.7121830253777, 3658.9451158232646, 3670.376036073874, 3760.8683696070643, 3273.2635157089703, 3277.066036179677, 3278.5246139309666, 3279.6884295991845, 3283.1956170738085, 4603.5856772890265, 4612.746298953556, 4615.030843522864, 4621.792019359137, 4630.143423466636, 4142.378279546635, 4189.832406703728, 4206.074663574009, 4229.471316085489, 4234.745915245065, 4902.632302577285, 4954.851354459372, 4954.975225123887, 4958.9504104959215, 4959.132151873408, 3597.0647631615707, 3597.730170237243, 3599.1721903961975, 3599.8200089995657, 3610.4764809102794, 5190.766415511311, 5196.778756992142, 5197.818076367347, 5206.349206349207, 5222.843314700565, 3374.257663314067, 3565.7682250653625, 3590.4793804898145, 3595.3035223582315, 3606.1886075633297, 3644.526211592476, 3645.8906232813056, 3648.562172539312, 3648.7810731356203, 3675.0, 4184.979075104666, 4196.720000399907, 4223.260929337353, 4227.217964676544, 4233.703640745119, 4815.2054910940005, 5020.447750747415, 5047.274471785268, 5048.798048078109, 5050.242463630485, 1251.5932321995388, 1266.4997326056157, 1267.8462599034833, 1268.0743057568027, 1268.822364868919, 778.1518145221622, 798.9041315042232, 805.3557154276556, 808.7775861638097, 811.5212024905217, 4218.346156345771, 4336.395533652569, 4341.370501277297, 4342.913141737147, 4365.912681746411, 4947.529984651453, 4972.900541989212, 5056.974715126401, 5075.720835354091, 5079.3650793650795, 4422.226110430662, 4435.223835828781, 4437.400950871655, 4437.866863994085, 4439.42287502629, 2570.8071894607606, 2642.9867850660626, 2655.64148839908, 2704.6348742919454, 2705.418335057972, 4837.467878533358, 4859.489753575895, 4870.245112007645, 4878.853634390974, 4891.364122664031, 5190.195519694454, 5209.426963034063, 5216.713080780593, 5227.085260079471, 5227.398849132398, 4592.242280023758, 4845.273209018605, 4919.385076865392, 4920.114379411741, 4922.433920099091, 5120.8719782004255, 5143.502418355554, 5146.922796157985, 5150.742462876766, 5164.0, 4865.878353041202, 5080.212567052113, 5085.7457127144235, 5094.898102038012, 5097.8725531862, 4859.902801944012, 4890.266460031024, 4899.632527560519, 4907.0, 4913.6069114471475, 3622.5290712207243, 3650.7079433645777, 3658.725595580289, 3661.707063434972, 3666.2667466506273, 5147.9227811583605, 5195.142801437721, 5198.168293073241, 5206.271122042993, 5218.765155568084, 4804.375431193923, 4998.600111991104, 5019.52314530119, 5034.974825125851, 5052.1663925451885, 5006.649534532694, 5007.924881126713, 5026.246063090565, 5026.698398096126, 5032.6477146600855, 4786.832460863853, 4913.877153071202, 4929.433115191656, 4934.5312195341385, 4940.2342636891335, 4745.928811067905, 4888.973315603763, 4983.152864013199, 5036.974815125901, 5070.264811602223, 4791.1854984652, 4920.286558449076, 4926.852194434173, 4931.7040977541465, 4932.8766780830765], "value": 3751.2198011552205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.1769286472438, 598.739548296491, 611.7338957553465, 632.5414074795774, 632.6330728177658, 11984.161108722383, 12769.61691149267, 12775.233485990835, 12781.936090319547, 13468.66328341792, 13018.0, 13388.866111338884, 13425.194488330708, 13444.932775336134, 13517.864821351783, 764.2586690909809, 787.5865170785355, 790.1782146567563, 790.2374208888422, 790.9011373578303, 626.924769027715, 643.6363454648132, 748.0649188514357, 767.9961600191991, 776.5884081436848, 816.7345612675874, 816.8611336072881, 818.3698552114897, 819.0253598218131, 819.491915012693, 809.6842231529708, 809.8825670277806, 810.1169724999778, 810.222186700768, 810.2990912860392, 482.9323894654751, 491.275368830975, 568.3350479938441, 583.8131797824698, 600.2676734384045, 12547.435365408579, 12625.116241863074, 12629.24224546521, 12634.305113218768, 12645.810312845315, 11137.665870023913, 11460.656180314603, 11500.94249528747, 11704.18070735049, 12169.756604867942, 11511.942440287829, 11980.161388702794, 12008.159428839985, 12303.0, 12487.93756031214, 4114.362273847559, 4114.526829414625, 4157.272477316487, 4179.331306990867, 4203.243416185085, 61013.0, 62704.37295627031, 63687.04469432962, 64245.67877160631, 64310.0, 10469.528871200815, 10493.187793801273, 10556.47217639115, 10568.735781605368, 10756.946215268874, 19303.324383646504, 19308.80691193098, 19337.8066219336, 19412.320568780025, 19451.416457506297, 6385.329540398284, 6616.636085015371, 6638.236602790645, 6641.800745977628, 6840.521163518605, 3578.3737845876867, 3586.264815712773, 3633.454981752758, 3710.350688629533, 3714.182879766447, 2892.913212603625, 3037.407705497451, 3046.070948360727, 3216.3084936738715, 3399.9490007649906, 534.398801348483, 539.2019810680137, 542.6120323968303, 545.4027839515724, 554.5923746046652, 467.4344043707085, 493.25764724090016, 548.6077454619966, 598.2073752278249, 601.2634522709645, 7358.595277259695, 7541.170471248159, 8226.958865205635, 8258.587070646443, 8416.957915210385, 482.3054801086424, 491.61408294488655, 549.6235078970918, 612.4120843989731, 626.2985456288894, 3460.2214501737412, 3702.5371828521434, 3771.1891943232336, 3805.2769973705463, 3999.64003239704, 87169.5641521801, 88928.0, 89996.5500172495, 95004.0, 95340.0, 77837.0, 78964.21035789569, 79957.20042799614, 80047.0, 80604.59697701473, 55798.721006394706, 68546.65726671435, 68947.65526172437, 69219.65390173017, 71945.0, 7078.964605176941, 7207.315305046012, 7214.422846172399, 7382.926170738224, 7497.250274972459, 41188.794056029525, 41923.58076419319, 41997.52603647091, 42276.36585451159, 43370.78314608407, 52078.479215207364, 58652.0, 58918.41081589129, 59621.403785961586, 59782.40217597768, 9241.907580924104, 9412.247020238501, 9452.149306562442, 9533.380330278787, 9669.661561845302, 10581.153507719519, 10659.4137322448, 12080.0, 12289.078319125923, 12493.189032467986, 11514.194006419806, 11788.646340609796, 11918.702032449259, 12764.17032892859, 13317.933410332886, 10039.598416063276, 11175.441227938732, 11649.88350116488, 11777.646670599554, 13034.116512711613, 11728.824067639163, 12035.879641203475, 12312.26126432417, 12770.68073298175, 13044.0, 9422.905770942478, 9551.188149007412, 9825.410475371214, 9992.20062394992, 10007.748256642488, 8945.776355591162, 10169.186465082628, 10246.487675616338, 10265.640702575374, 10303.330283531546], "value": 6422.547576876743, "unit": "score"}], "name": "dromaeo_css", "value": 6126.255358465262, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 117.0, 114.0, 116.0, 114.0, 114.0, 115.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 129.0, 171.0, 128.0, 133.0, 133.0, 125.0, 159.0, 130.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 164.0, 163.0, 163.0, 161.0, 162.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 101.0, 77.0, 78.0, 77.0, 76.0, 101.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 124.0, 84.0, 83.0, 84.0, 118.0, 84.0, 84.0, 111.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 120.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 83.0, 84.0, 89.0, 84.0, 94.0, 85.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 147.0, 140.0, 146.0, 142.0, 139.0, 139.0, 180.0, 141.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 175.0, 184.0, 177.0, 178.0, 178.0, 177.0, 176.0, 177.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 75.0, 77.0, 71.0, 70.0, 69.0, 69.0, 69.0, 68.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1562.2000000000003, "alertThreshold": 2.0}]} 02:33:43 INFO - Return code: 0 02:33:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:33:43 INFO - # TBPL SUCCESS # 02:33:43 INFO - Running post-action listener: _resource_record_post_action 02:33:43 INFO - [mozharness: 2016-10-03 09:33:43.195515Z] Finished run-tests step (success) 02:33:43 INFO - Running post-run listener: _resource_record_post_run 02:33:43 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 16384; Write bytes: 402173952; Read time: 120; Write time: 230412 02:33:43 INFO - TinderboxPrint: CPU usage
13.0% 02:33:43 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 120 02:33:43 INFO - TinderboxPrint: I/O write bytes / time
402,173,952 / 230,412 02:33:43 INFO - TinderboxPrint: CPU idle
8,350.4 (87.0%) 02:33:43 INFO - TinderboxPrint: CPU user
1,199.4 (12.5%) 02:33:43 INFO - TinderboxPrint: Swap in / out
0 / 0 02:33:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110632960; Read time: 0; Write time: 59712 02:33:43 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 290639872; Read time: 100; Write time: 170680 02:33:43 INFO - Running post-run listener: _upload_blobber_files 02:33:43 INFO - Blob upload gear active. 02:33:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:33:43 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 02:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:33:44 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:47 INFO - (blobuploader) - INFO - Done attempting. 02:33:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:33:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:48 INFO - (blobuploader) - INFO - Done attempting. 02:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:48 INFO - (blobuploader) - INFO - Done attempting. 02:33:48 INFO - (blobuploader) - INFO - Iteration through files over. 02:33:48 INFO - Return code: 0 02:33:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:33:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:33:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51599aadf12d8c334cf936b42a2ba5c65e304696d7ed18dbb8c3a75005bb715e2f4849212a88040609d85696b686384456ac664a2116a59739b952bf94dd771b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c20d5ab96d2dd0f092ef7833d803d048ba7527187ed61425418c48a2dfa068813c6aa73ca18838ee8abd78fd2fa3bbae816061905932461afc7dc0dcc3ceb701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/91a59c801b1b0f3090a913096d41362c13758ec2c89f44da0e2ac3f3212d7f564cb573d79782e5c16cf87b6c0f7a5a8c58b15b2055d4236ce387dcbe23a954e1"} 02:33:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:33:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:33:49 INFO - Contents: 02:33:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51599aadf12d8c334cf936b42a2ba5c65e304696d7ed18dbb8c3a75005bb715e2f4849212a88040609d85696b686384456ac664a2116a59739b952bf94dd771b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c20d5ab96d2dd0f092ef7833d803d048ba7527187ed61425418c48a2dfa068813c6aa73ca18838ee8abd78fd2fa3bbae816061905932461afc7dc0dcc3ceb701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/91a59c801b1b0f3090a913096d41362c13758ec2c89f44da0e2ac3f3212d7f564cb573d79782e5c16cf87b6c0f7a5a8c58b15b2055d4236ce387dcbe23a954e1"} 02:33:49 INFO - Running post-run listener: copy_logs_to_upload_dir 02:33:49 INFO - Copying logs to upload dir... 02:33:49 INFO - mkdir: /builds/slave/test/build/upload/logs 02:33:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.557149 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-03 02:33:47.156584) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 02:33:47.160693) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51599aadf12d8c334cf936b42a2ba5c65e304696d7ed18dbb8c3a75005bb715e2f4849212a88040609d85696b686384456ac664a2116a59739b952bf94dd771b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c20d5ab96d2dd0f092ef7833d803d048ba7527187ed61425418c48a2dfa068813c6aa73ca18838ee8abd78fd2fa3bbae816061905932461afc7dc0dcc3ceb701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/91a59c801b1b0f3090a913096d41362c13758ec2c89f44da0e2ac3f3212d7f564cb573d79782e5c16cf87b6c0f7a5a8c58b15b2055d4236ce387dcbe23a954e1"} build_url:https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011494 build_url: 'https://queue.taskcluster.net/v1/task/MoyW9oopRimSKcFg06tuvQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/51599aadf12d8c334cf936b42a2ba5c65e304696d7ed18dbb8c3a75005bb715e2f4849212a88040609d85696b686384456ac664a2116a59739b952bf94dd771b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c20d5ab96d2dd0f092ef7833d803d048ba7527187ed61425418c48a2dfa068813c6aa73ca18838ee8abd78fd2fa3bbae816061905932461afc7dc0dcc3ceb701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/91a59c801b1b0f3090a913096d41362c13758ec2c89f44da0e2ac3f3212d7f564cb573d79782e5c16cf87b6c0f7a5a8c58b15b2055d4236ce387dcbe23a954e1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 02:33:47.191135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:33:47.191883) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475480672.976738-881259422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 02:33:47.273348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 02:33:47.273716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 02:33:47.274066) ========= ========= Total master_lag: 0.18 =========