builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1475081140.79 results: success (0) buildid: 20160928063004 builduid: c23f3af6c7c240c8a853bdacfb8c43bb revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:40.793849) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:40.794366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:40.794732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:40.815818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:40.816185) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 09:45:41-- 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% 40.3M=0s 2016-09-28 09:45:41 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:41.011571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:41.012205) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:41.063850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 09:45:41.064244) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --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=e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 09:45:41,336 truncating revision to first 12 chars 2016-09-28 09:45:41,336 Setting DEBUG logging. 2016-09-28 09:45:41,336 attempt 1/10 2016-09-28 09:45:41,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc513f0359eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 09:45:42,841 unpacking tar archive at: fx-team-fc513f0359eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.823071 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 09:45:42.954143) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:42.954494) ========= script_repo_revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:42.954992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:42.955305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:42.966002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-28 09:45:42.966322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:45:43 INFO - MultiFileLogger online at 20160928 09:45:43 in /builds/slave/test 09:45:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:45:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:43 INFO - {'append_to_log': False, 09:45:43 INFO - 'base_work_dir': '/builds/slave/test', 09:45:43 INFO - 'blob_upload_branch': 'Fx-Team', 09:45:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:43 INFO - 'branch': 'Fx-Team', 09:45:43 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:43 INFO - 'config_files': ('talos/linux_config.py',), 09:45:43 INFO - 'default_actions': ('clobber', 09:45:43 INFO - 'read-buildbot-config', 09:45:43 INFO - 'download-and-extract', 09:45:43 INFO - 'populate-webroot', 09:45:43 INFO - 'create-virtualenv', 09:45:43 INFO - 'install', 09:45:43 INFO - 'run-tests'), 09:45:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:43 INFO - 'download_minidump_stackwalk': True, 09:45:43 INFO - 'download_symbols': 'ondemand', 09:45:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:43 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:43 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:43 INFO - 'installer_path': 'installer.exe', 09:45:43 INFO - 'log_level': 'info', 09:45:43 INFO - 'log_name': 'talos', 09:45:43 INFO - 'log_to_console': True, 09:45:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:45:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:45:43 INFO - 'opt_config_files': (), 09:45:43 INFO - 'pip_index': False, 09:45:43 INFO - 'sps_profile': False, 09:45:43 INFO - 'sps_profile_interval': 0, 09:45:43 INFO - 'suite': 'dromaeojs', 09:45:43 INFO - 'system_bits': '32', 09:45:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:43 INFO - 'title': 'talos-linux64-ix-067', 09:45:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:43 INFO - 'use_talos_json': True, 09:45:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:43 INFO - 'work_dir': 'build'} 09:45:43 INFO - [mozharness: 2016-09-28 16:45:43.327494Z] Running clobber step. 09:45:43 INFO - Running pre-action listener: _resource_record_pre_action 09:45:43 INFO - Running main action method: clobber 09:45:43 INFO - rmtree: /builds/slave/test/build 09:45:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:43 INFO - Running post-action listener: _resource_record_post_action 09:45:43 INFO - [mozharness: 2016-09-28 16:45:43.782638Z] Finished clobber step (success) 09:45:43 INFO - [mozharness: 2016-09-28 16:45:43.782738Z] Running read-buildbot-config step. 09:45:43 INFO - Running pre-action listener: _resource_record_pre_action 09:45:43 INFO - Running main action method: read_buildbot_config 09:45:43 INFO - Using buildbot properties: 09:45:43 INFO - { 09:45:43 INFO - "project": "", 09:45:43 INFO - "product": "firefox", 09:45:43 INFO - "script_repo_revision": "production", 09:45:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:45:43 INFO - "repository": "", 09:45:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:45:43 INFO - "buildid": "20160928063004", 09:45:43 INFO - "pgo_build": "True", 09:45:43 INFO - "basedir": "/builds/slave/test", 09:45:43 INFO - "buildnumber": 1602, 09:45:43 INFO - "slavename": "talos-linux64-ix-067", 09:45:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:45:43 INFO - "platform": "ubuntu64_hw", 09:45:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:45:43 INFO - "branch": "fx-team", 09:45:43 INFO - "repo_path": "integration/fx-team", 09:45:43 INFO - "revision": "fc513f0359ebca43d8b791a458583aeb3bb37f42", 09:45:43 INFO - "stage_platform": "linux64-pgo", 09:45:43 INFO - "builduid": "c23f3af6c7c240c8a853bdacfb8c43bb", 09:45:43 INFO - "slavebuilddir": "test" 09:45:43 INFO - } 09:45:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:45:43 INFO - Running post-action listener: _resource_record_post_action 09:45:43 INFO - [mozharness: 2016-09-28 16:45:43.785154Z] Finished read-buildbot-config step (success) 09:45:43 INFO - [mozharness: 2016-09-28 16:45:43.785241Z] Running download-and-extract step. 09:45:43 INFO - Running pre-action listener: _resource_record_pre_action 09:45:43 INFO - Running main action method: download_and_extract 09:45:43 INFO - mkdir: /builds/slave/test/build/tests 09:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:43 INFO - trying https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:45:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:45:44 INFO - Downloaded 1361 bytes. 09:45:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:45:44 INFO - Using the following test package requirements: 09:45:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:45:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'jsshell-linux-x86_64.zip'], 09:45:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:45:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:45:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:45:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:45:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:45:44 INFO - Expected file size: 21984091 09:45:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:45:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:45:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:45:49 INFO - Expected file size: 21984091 09:45:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:45:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:45:55 INFO - Expected file size: 14414062 09:45: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')]} 09:45:55 INFO - trying https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:45:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:45:56 INFO - Downloaded 59760130 bytes. 09:45:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:45:56 INFO - mkdir: /builds/slave/test/properties 09:45:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:56 INFO - Contents: 09:45:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:45:57 INFO - Running post-action listener: _resource_record_post_action 09:45:57 INFO - Running post-action listener: set_extra_try_arguments 09:45:57 INFO - [mozharness: 2016-09-28 16:45:57.438334Z] Finished download-and-extract step (success) 09:45:57 INFO - [mozharness: 2016-09-28 16:45:57.438561Z] Running populate-webroot step. 09:45:57 INFO - Running pre-action listener: _resource_record_pre_action 09:45:57 INFO - Running main action method: populate_webroot 09:45:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:57 INFO - '--tppagecycles', 09:45:57 INFO - '7'], 09:45:57 INFO - 'tests': ['tsvgm']}}, 09:45:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['damp', 'tps']}, 09:45:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'tests': ['damp', 'tps']}, 09:45:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['dromaeo_dom']}, 09:45:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['basic_compositor_video']}, 09:45:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tsvgx', 09:45:57 INFO - 'tsvgr_opacity', 09:45:57 INFO - 'tart', 09:45:57 INFO - 'tscrollx', 09:45:57 INFO - 'cart']}, 09:45:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:57 INFO - 'tsvgr_opacity', 09:45:57 INFO - 'tart', 09:45:57 INFO - 'tscrollx', 09:45:57 INFO - 'cart']}, 09:45:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tp5o']}, 09:45:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'tests': ['tp5o']}, 09:45:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s', 09:45:57 INFO - '--xperf_path', 09:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:57 INFO - 'tests': ['tp5n']}, 09:45:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:57 INFO - 'talos_options': ['--xperf_path', 09:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:57 INFO - 'tests': ['tp5n']}}, 09:45:57 INFO - 'talos.zip': {'path': '', 09:45:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:57 INFO - Running post-action listener: _resource_record_post_action 09:45:57 INFO - [mozharness: 2016-09-28 16:45:57.457453Z] Finished populate-webroot step (success) 09:45:57 INFO - [mozharness: 2016-09-28 16:45:57.457542Z] Running create-virtualenv step. 09:45:57 INFO - Running pre-action listener: _resource_record_pre_action 09:45:57 INFO - Running main action method: create_virtualenv 09:45:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:45:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:57 INFO - Using real prefix '/usr' 09:45:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:00 INFO - Installing pip.................done. 09:46:00 INFO - Return code: 0 09:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:46:00 INFO - Reading from file tmpfile_stdout 09:46:00 INFO - Output received: 09:46:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:46:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:00 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:46:00 INFO - Using env: {'DISPLAY': ':0', 09:46:00 INFO - 'HOME': '/home/cltbld', 09:46:00 INFO - 'LANG': 'en_US.UTF-8', 09:46:00 INFO - 'LANGUAGE': 'en_US:en', 09:46:00 INFO - 'LOGNAME': 'cltbld', 09:46:00 INFO - 'MAIL': '/var/mail/cltbld', 09:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:00 INFO - 'MOZ_NO_REMOTE': '1', 09:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:00 INFO - 'NO_EM_RESTART': '1', 09:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:00 INFO - 'PWD': '/builds/slave/test', 09:46:00 INFO - 'SHELL': '/bin/bash', 09:46:00 INFO - 'SHLVL': '1', 09:46:00 INFO - 'TERM': 'linux', 09:46:00 INFO - 'TMOUT': '86400', 09:46:00 INFO - 'USER': 'cltbld', 09:46:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:00 INFO - '_': '/tools/buildbot/bin/python'} 09:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:46:00 INFO - Cleaning up... 09:46:00 INFO - Return code: 0 09:46:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:00 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:46:00 INFO - Using env: {'DISPLAY': ':0', 09:46:00 INFO - 'HOME': '/home/cltbld', 09:46:00 INFO - 'LANG': 'en_US.UTF-8', 09:46:00 INFO - 'LANGUAGE': 'en_US:en', 09:46:00 INFO - 'LOGNAME': 'cltbld', 09:46:00 INFO - 'MAIL': '/var/mail/cltbld', 09:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:00 INFO - 'MOZ_NO_REMOTE': '1', 09:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:00 INFO - 'NO_EM_RESTART': '1', 09:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:00 INFO - 'PWD': '/builds/slave/test', 09:46:00 INFO - 'SHELL': '/bin/bash', 09:46:00 INFO - 'SHLVL': '1', 09:46:00 INFO - 'TERM': 'linux', 09:46:00 INFO - 'TMOUT': '86400', 09:46:00 INFO - 'USER': 'cltbld', 09:46:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:00 INFO - '_': '/tools/buildbot/bin/python'} 09:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:00 INFO - Downloading/unpacking psutil>=3.1.1 09:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:02 INFO - Installing collected packages: psutil 09:46:02 INFO - Running setup.py install for psutil 09:46:02 INFO - building 'psutil._psutil_linux' extension 09:46:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:46:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:46:02 INFO - building 'psutil._psutil_posix' extension 09:46:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:46:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:46:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:03 INFO - Successfully installed psutil 09:46:03 INFO - Cleaning up... 09:46:03 INFO - Return code: 0 09:46:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:03 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:46:03 INFO - Using env: {'DISPLAY': ':0', 09:46:03 INFO - 'HOME': '/home/cltbld', 09:46:03 INFO - 'LANG': 'en_US.UTF-8', 09:46:03 INFO - 'LANGUAGE': 'en_US:en', 09:46:03 INFO - 'LOGNAME': 'cltbld', 09:46:03 INFO - 'MAIL': '/var/mail/cltbld', 09:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:03 INFO - 'MOZ_NO_REMOTE': '1', 09:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:03 INFO - 'NO_EM_RESTART': '1', 09:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:03 INFO - 'PWD': '/builds/slave/test', 09:46:03 INFO - 'SHELL': '/bin/bash', 09:46:03 INFO - 'SHLVL': '1', 09:46:03 INFO - 'TERM': 'linux', 09:46:03 INFO - 'TMOUT': '86400', 09:46:03 INFO - 'USER': 'cltbld', 09:46:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:03 INFO - '_': '/tools/buildbot/bin/python'} 09:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:46:05 INFO - Installing collected packages: mozsystemmonitor 09:46:05 INFO - Running setup.py install for mozsystemmonitor 09:46:05 INFO - Successfully installed mozsystemmonitor 09:46:05 INFO - Cleaning up... 09:46:05 INFO - Return code: 0 09:46:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:05 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:46:05 INFO - Using env: {'DISPLAY': ':0', 09:46:05 INFO - 'HOME': '/home/cltbld', 09:46:05 INFO - 'LANG': 'en_US.UTF-8', 09:46:05 INFO - 'LANGUAGE': 'en_US:en', 09:46:05 INFO - 'LOGNAME': 'cltbld', 09:46:05 INFO - 'MAIL': '/var/mail/cltbld', 09:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:05 INFO - 'MOZ_NO_REMOTE': '1', 09:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:05 INFO - 'NO_EM_RESTART': '1', 09:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:05 INFO - 'PWD': '/builds/slave/test', 09:46:05 INFO - 'SHELL': '/bin/bash', 09:46:05 INFO - 'SHLVL': '1', 09:46:05 INFO - 'TERM': 'linux', 09:46:05 INFO - 'TMOUT': '86400', 09:46:05 INFO - 'USER': 'cltbld', 09:46:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:05 INFO - '_': '/tools/buildbot/bin/python'} 09:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:05 INFO - Downloading/unpacking jsonschema==2.5.1 09:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:07 INFO - warning: no files found matching '*.txt' 09:46:07 INFO - no previously-included directories found matching 'build' 09:46:07 INFO - no previously-included directories found matching 'dist' 09:46:07 INFO - no previously-included directories found matching '.git*' 09:46:07 INFO - Installing collected packages: jsonschema, functools32 09:46:07 INFO - Running setup.py install for functools32 09:46:08 INFO - warning: no files found matching '*.txt' 09:46:08 INFO - no previously-included directories found matching 'build' 09:46:08 INFO - no previously-included directories found matching 'dist' 09:46:08 INFO - no previously-included directories found matching '.git*' 09:46:08 INFO - Successfully installed jsonschema functools32 09:46:08 INFO - Cleaning up... 09:46:08 INFO - Return code: 0 09:46:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:46:08 INFO - Using env: {'DISPLAY': ':0', 09:46:08 INFO - 'HOME': '/home/cltbld', 09:46:08 INFO - 'LANG': 'en_US.UTF-8', 09:46:08 INFO - 'LANGUAGE': 'en_US:en', 09:46:08 INFO - 'LOGNAME': 'cltbld', 09:46:08 INFO - 'MAIL': '/var/mail/cltbld', 09:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:08 INFO - 'MOZ_NO_REMOTE': '1', 09:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:08 INFO - 'NO_EM_RESTART': '1', 09:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:08 INFO - 'PWD': '/builds/slave/test', 09:46:08 INFO - 'SHELL': '/bin/bash', 09:46:08 INFO - 'SHLVL': '1', 09:46:08 INFO - 'TERM': 'linux', 09:46:08 INFO - 'TMOUT': '86400', 09:46:08 INFO - 'USER': 'cltbld', 09:46:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:08 INFO - '_': '/tools/buildbot/bin/python'} 09:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:46:08 INFO - Cleaning up... 09:46:08 INFO - Return code: 0 09:46:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:46:08 INFO - Using env: {'DISPLAY': ':0', 09:46:08 INFO - 'HOME': '/home/cltbld', 09:46:08 INFO - 'LANG': 'en_US.UTF-8', 09:46:08 INFO - 'LANGUAGE': 'en_US:en', 09:46:08 INFO - 'LOGNAME': 'cltbld', 09:46:08 INFO - 'MAIL': '/var/mail/cltbld', 09:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:08 INFO - 'MOZ_NO_REMOTE': '1', 09:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:08 INFO - 'NO_EM_RESTART': '1', 09:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:08 INFO - 'PWD': '/builds/slave/test', 09:46:08 INFO - 'SHELL': '/bin/bash', 09:46:08 INFO - 'SHLVL': '1', 09:46:08 INFO - 'TERM': 'linux', 09:46:08 INFO - 'TMOUT': '86400', 09:46:08 INFO - 'USER': 'cltbld', 09:46:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:08 INFO - '_': '/tools/buildbot/bin/python'} 09:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:11 INFO - Downloading docopt-0.6.1.tar.gz 09:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:11 INFO - Running setup.py install for blobuploader 09:46:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:11 INFO - Running setup.py install for requests 09:46:11 INFO - Running setup.py install for docopt 09:46:11 INFO - Successfully installed blobuploader requests docopt 09:46:11 INFO - Cleaning up... 09:46:11 INFO - Return code: 0 09:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:11 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:11 INFO - Using env: {'DISPLAY': ':0', 09:46:11 INFO - 'HOME': '/home/cltbld', 09:46:11 INFO - 'LANG': 'en_US.UTF-8', 09:46:11 INFO - 'LANGUAGE': 'en_US:en', 09:46:11 INFO - 'LOGNAME': 'cltbld', 09:46:11 INFO - 'MAIL': '/var/mail/cltbld', 09:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:11 INFO - 'MOZ_NO_REMOTE': '1', 09:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:11 INFO - 'NO_EM_RESTART': '1', 09:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:11 INFO - 'PWD': '/builds/slave/test', 09:46:11 INFO - 'SHELL': '/bin/bash', 09:46:11 INFO - 'SHLVL': '1', 09:46:11 INFO - 'TERM': 'linux', 09:46:11 INFO - 'TMOUT': '86400', 09:46:11 INFO - 'USER': 'cltbld', 09:46:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:11 INFO - '_': '/tools/buildbot/bin/python'} 09:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:12 INFO - Running setup.py (path:/tmp/pip-yzTImZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:12 INFO - Running setup.py (path:/tmp/pip-EXZCQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:12 INFO - Running setup.py (path:/tmp/pip-kIVVpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:12 INFO - Running setup.py (path:/tmp/pip-NsTPMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:12 INFO - Running setup.py (path:/tmp/pip-PyKepy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:12 INFO - Running setup.py (path:/tmp/pip-8B4PmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:12 INFO - Running setup.py (path:/tmp/pip-edYjzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:12 INFO - Running setup.py (path:/tmp/pip-4enAxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:12 INFO - Running setup.py (path:/tmp/pip-rtgwQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:12 INFO - Running setup.py (path:/tmp/pip-Gh9uhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:12 INFO - Running setup.py (path:/tmp/pip-m_67qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:12 INFO - Running setup.py (path:/tmp/pip-gmjYxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:12 INFO - Running setup.py (path:/tmp/pip-IvZG_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:12 INFO - Running setup.py (path:/tmp/pip-FAoOtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:13 INFO - Running setup.py (path:/tmp/pip-6e1DlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:13 INFO - Running setup.py (path:/tmp/pip-rMoFiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:13 INFO - Running setup.py (path:/tmp/pip-IL_QHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:13 INFO - Running setup.py install for manifestparser 09:46:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:13 INFO - Running setup.py install for mozcrash 09:46:13 INFO - Running setup.py install for mozdebug 09:46:13 INFO - Running setup.py install for mozdevice 09:46:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:13 INFO - Running setup.py install for mozfile 09:46:13 INFO - Running setup.py install for mozhttpd 09:46:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:13 INFO - Running setup.py install for mozinfo 09:46:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:13 INFO - Running setup.py install for mozInstall 09:46:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Running setup.py install for mozleak 09:46:14 INFO - Running setup.py install for mozlog 09:46:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Running setup.py install for moznetwork 09:46:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Running setup.py install for mozprocess 09:46:14 INFO - Running setup.py install for mozprofile 09:46:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Running setup.py install for mozrunner 09:46:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Running setup.py install for mozscreenshot 09:46:14 INFO - Running setup.py install for moztest 09:46:14 INFO - Running setup.py install for mozversion 09:46:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:14 INFO - Cleaning up... 09:46:15 INFO - Return code: 0 09:46:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:15 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:15 INFO - Using env: {'DISPLAY': ':0', 09:46:15 INFO - 'HOME': '/home/cltbld', 09:46:15 INFO - 'LANG': 'en_US.UTF-8', 09:46:15 INFO - 'LANGUAGE': 'en_US:en', 09:46:15 INFO - 'LOGNAME': 'cltbld', 09:46:15 INFO - 'MAIL': '/var/mail/cltbld', 09:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:15 INFO - 'MOZ_NO_REMOTE': '1', 09:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:15 INFO - 'NO_EM_RESTART': '1', 09:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:15 INFO - 'PWD': '/builds/slave/test', 09:46:15 INFO - 'SHELL': '/bin/bash', 09:46:15 INFO - 'SHLVL': '1', 09:46:15 INFO - 'TERM': 'linux', 09:46:15 INFO - 'TMOUT': '86400', 09:46:15 INFO - 'USER': 'cltbld', 09:46:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:15 INFO - '_': '/tools/buildbot/bin/python'} 09:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:15 INFO - Running setup.py (path:/tmp/pip-BKHNaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:15 INFO - Running setup.py (path:/tmp/pip-iw_vPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:15 INFO - Running setup.py (path:/tmp/pip-m934FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:15 INFO - Running setup.py (path:/tmp/pip-RHL3AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:15 INFO - Running setup.py (path:/tmp/pip-0ynQfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:15 INFO - Running setup.py (path:/tmp/pip-rGsxVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:15 INFO - Running setup.py (path:/tmp/pip-BAzu4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:15 INFO - Running setup.py (path:/tmp/pip-5z79yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:15 INFO - Running setup.py (path:/tmp/pip-2NZQ5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:15 INFO - Running setup.py (path:/tmp/pip-ezz9E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:15 INFO - Running setup.py (path:/tmp/pip-qMC4bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:16 INFO - Running setup.py (path:/tmp/pip-QBZi0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:16 INFO - Running setup.py (path:/tmp/pip-83Qgj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:16 INFO - Running setup.py (path:/tmp/pip-GrFHO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:16 INFO - Running setup.py (path:/tmp/pip-_m0ME1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:16 INFO - Running setup.py (path:/tmp/pip-IsceR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:16 INFO - Running setup.py (path:/tmp/pip-HTeoWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:18 INFO - Downloading blessings-1.6.tar.gz 09:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:18 INFO - Installing collected packages: blessings 09:46:18 INFO - Running setup.py install for blessings 09:46:18 INFO - Successfully installed blessings 09:46:18 INFO - Cleaning up... 09:46:18 INFO - Return code: 0 09:46:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:18 INFO - Reading from file tmpfile_stdout 09:46:18 INFO - Current package versions: 09:46:18 INFO - argparse == 1.2.1 09:46:18 INFO - blessings == 1.6 09:46:18 INFO - blobuploader == 1.2.4 09:46:18 INFO - docopt == 0.6.1 09:46:18 INFO - functools32 == 3.2.3-2 09:46:18 INFO - jsonschema == 2.5.1 09:46:18 INFO - manifestparser == 1.1 09:46:18 INFO - mozInstall == 1.12 09:46:18 INFO - mozcrash == 0.17 09:46:18 INFO - mozdebug == 0.1 09:46:18 INFO - mozdevice == 0.48 09:46:18 INFO - mozfile == 1.2 09:46:18 INFO - mozhttpd == 0.7 09:46:18 INFO - mozinfo == 0.9 09:46:18 INFO - mozleak == 0.1 09:46:18 INFO - mozlog == 3.4 09:46:18 INFO - moznetwork == 0.27 09:46:18 INFO - mozprocess == 0.23 09:46:18 INFO - mozprofile == 0.28 09:46:18 INFO - mozrunner == 6.12 09:46:18 INFO - mozscreenshot == 0.1 09:46:18 INFO - mozsystemmonitor == 0.3 09:46:18 INFO - moztest == 0.7 09:46:18 INFO - mozversion == 1.4 09:46:18 INFO - psutil == 3.1.1 09:46:18 INFO - requests == 1.2.3 09:46:18 INFO - wsgiref == 0.1.2 09:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:18 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 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:18 INFO - Using env: {'DISPLAY': ':0', 09:46:18 INFO - 'HOME': '/home/cltbld', 09:46:18 INFO - 'LANG': 'en_US.UTF-8', 09:46:18 INFO - 'LANGUAGE': 'en_US:en', 09:46:18 INFO - 'LOGNAME': 'cltbld', 09:46:18 INFO - 'MAIL': '/var/mail/cltbld', 09:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:18 INFO - 'MOZ_NO_REMOTE': '1', 09:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:18 INFO - 'NO_EM_RESTART': '1', 09:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:18 INFO - 'PWD': '/builds/slave/test', 09:46:18 INFO - 'SHELL': '/bin/bash', 09:46:18 INFO - 'SHLVL': '1', 09:46:18 INFO - 'TERM': 'linux', 09:46:18 INFO - 'TMOUT': '86400', 09:46:18 INFO - 'USER': 'cltbld', 09:46:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:18 INFO - '_': '/tools/buildbot/bin/python'} 09:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:46:19 INFO - Cleaning up... 09:46:19 INFO - Return code: 0 09:46:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3258d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46: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', 'jsonschema'] in /builds/slave/test/build 09:46: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 jsonschema 09:46:19 INFO - Using env: {'DISPLAY': ':0', 09:46:19 INFO - 'HOME': '/home/cltbld', 09:46:19 INFO - 'LANG': 'en_US.UTF-8', 09:46:19 INFO - 'LANGUAGE': 'en_US:en', 09:46:19 INFO - 'LOGNAME': 'cltbld', 09:46:19 INFO - 'MAIL': '/var/mail/cltbld', 09:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:19 INFO - 'MOZ_NO_REMOTE': '1', 09:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:19 INFO - 'NO_EM_RESTART': '1', 09:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:19 INFO - 'PWD': '/builds/slave/test', 09:46:19 INFO - 'SHELL': '/bin/bash', 09:46:19 INFO - 'SHLVL': '1', 09:46:19 INFO - 'TERM': 'linux', 09:46:19 INFO - 'TMOUT': '86400', 09:46:19 INFO - 'USER': 'cltbld', 09:46:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:19 INFO - '_': '/tools/buildbot/bin/python'} 09:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:46:19 INFO - Cleaning up... 09:46:19 INFO - Return code: 0 09:46:19 INFO - Running post-action listener: _resource_record_post_action 09:46:19 INFO - Running post-action listener: _start_resource_monitoring 09:46:19 INFO - Starting resource monitoring. 09:46:19 INFO - [mozharness: 2016-09-28 16:46:19.341066Z] Finished create-virtualenv step (success) 09:46:19 INFO - [mozharness: 2016-09-28 16:46:19.341534Z] Running install step. 09:46:19 INFO - Running pre-action listener: _resource_record_pre_action 09:46:19 INFO - Running main action method: install 09:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:19 INFO - Reading from file tmpfile_stdout 09:46:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:46:19 INFO - Reading from file tmpfile_stdout 09:46:19 INFO - Output received: 09:46:19 INFO - Usage: mozinstall [options] installer 09:46:19 INFO - Options: 09:46:19 INFO - -h, --help show this help message and exit 09:46:19 INFO - -d DEST, --destination=DEST 09:46:19 INFO - Directory to install application into. [default: 09:46:19 INFO - "/builds/slave/test"] 09:46:19 INFO - --app=APP Application being installed. [default: firefox] 09:46:19 INFO - mkdir: /builds/slave/test/build/application 09:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:46:37 INFO - Reading from file tmpfile_stdout 09:46:37 INFO - Output received: 09:46:37 INFO - /builds/slave/test/build/application/firefox/firefox 09:46:37 INFO - Running post-action listener: _resource_record_post_action 09:46:37 INFO - [mozharness: 2016-09-28 16:46:37.163309Z] Finished install step (success) 09:46:37 INFO - [mozharness: 2016-09-28 16:46:37.163564Z] Running run-tests step. 09:46:37 INFO - Running pre-action listener: _resource_record_pre_action 09:46:37 INFO - Running main action method: run_tests 09:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:37 INFO - Python 2.7.3 09:46:37 INFO - Return code: 0 09:46:37 INFO - grabbing minidump binary from tooltool 09:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:37 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 0x11f2930>, '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 0x11f3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f3cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:46:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:46:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:46:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:37 INFO - Return code: 0 09:46:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:46:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:46:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:46:37 INFO - Using env: {'DISPLAY': ':0', 09:46:37 INFO - 'HOME': '/home/cltbld', 09:46:37 INFO - 'LANG': 'en_US.UTF-8', 09:46:37 INFO - 'LANGUAGE': 'en_US:en', 09:46:37 INFO - 'LOGNAME': 'cltbld', 09:46:37 INFO - 'MAIL': '/var/mail/cltbld', 09:46:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:37 INFO - 'MOZ_NO_REMOTE': '1', 09:46:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:37 INFO - 'NO_EM_RESTART': '1', 09:46:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:37 INFO - 'PWD': '/builds/slave/test', 09:46:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:37 INFO - 'SHELL': '/bin/bash', 09:46:37 INFO - 'SHLVL': '1', 09:46:37 INFO - 'TERM': 'linux', 09:46:37 INFO - 'TMOUT': '86400', 09:46:37 INFO - 'USER': 'cltbld', 09:46:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166', 09:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:37 INFO - '_': '/tools/buildbot/bin/python'} 09:46:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:46:37 INFO - mozversion application_buildid: 20160928063004 09:46:37 INFO - mozversion application_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 09:46:37 INFO - mozversion application_display_name: Nightly 09:46:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:37 INFO - mozversion application_name: Firefox 09:46:37 INFO - mozversion application_remotingname: firefox 09:46:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:46:37 INFO - mozversion application_vendor: Mozilla 09:46:37 INFO - mozversion application_version: 52.0a1 09:46:37 INFO - mozversion platform_buildid: 20160928063004 09:46:37 INFO - mozversion platform_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 09:46:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:46:37 INFO - mozversion platform_version: 52.0a1 09:46:37 INFO - using testdate: 1475081197 09:46:37 INFO - actual date: 1475081197 09:46:37 INFO - starting webserver on 'localhost:51441' 09:46:37 INFO - SUITE-START | Running 2 tests 09:46:37 INFO - TEST-START | dromaeo_css 09:46:37 INFO - operating with platform_type : linux_ 09:46:37 INFO - Initialising browser for dromaeo_css test... 09:46:37 INFO - TEST-INFO | started process 11559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8X3tQ/profile http://localhost:51441/getInfo.html) 09:46:41 INFO - PROCESS | 11559 | __metrics Screen width/height:1600/1200 09:46:41 INFO - PROCESS | 11559 | colorDepth:24 09:46:41 INFO - PROCESS | 11559 | Browser inner width/height: 1024/697 09:46:41 INFO - PROCESS | 11559 | __metrics 09:46:41 INFO - PROCESS | 11559 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:46:41 INFO - PROCESS | 11559 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:42 INFO - PROCESS | 11559 | console.error: PushService: 09:46:42 INFO - PROCESS | 11559 | stateChangeProcessEnqueue: Error transitioning state 09:46:42 INFO - PROCESS | 11559 | UnknownError 09:46:43 INFO - TEST-INFO | 11559: exit 0 09:46:43 INFO - Browser initialized. 09:46:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:43 INFO - TEST-INFO | started process 11644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8X3tQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:55 INFO - PROCESS | 11644 | RSS: Main: 173899776 09:46:55 INFO - PROCESS | 11644 | 09:47:46 INFO - PROCESS | 11644 | 1475081266566 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:49:56 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:51441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51441/tests/dromaeo/cssquery-ext.html) 09:49:57 INFO - PROCESS | 11644 | RSS: Main: 284889088 09:49:57 INFO - PROCESS | 11644 | 09:52:59 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:51441/tests/dromaeo/cssquery-ext.html (next: http://localhost:51441/tests/dromaeo/cssquery-jquery.html) 09:53:00 INFO - PROCESS | 11644 | RSS: Main: 277323776 09:53:00 INFO - PROCESS | 11644 | 09:56:02 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:51441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51441/tests/dromaeo/cssquery-mootools.html) 09:56:02 INFO - PROCESS | 11644 | RSS: Main: 220082176 09:56:02 INFO - PROCESS | 11644 | 09:59:04 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:51441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51441/tests/dromaeo/cssquery-prototype.html) 09:59:05 INFO - PROCESS | 11644 | RSS: Main: 217722880 09:59:05 INFO - PROCESS | 11644 | 10:02:08 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:51441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51441/tests/dromaeo/cssquery-yui.html) 10:02:08 INFO - PROCESS | 11644 | RSS: Main: 218681344 10:02:08 INFO - PROCESS | 11644 | 10:05:11 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:51441/tests/dromaeo/cssquery-yui.html (next: http://localhost:51441/tests/dromaeo/cssquery-dojo.html) 10:05:12 INFO - PROCESS | 11644 | RSS: Main: 309784576 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | __start_tp_report 10:05:12 INFO - PROCESS | 11644 | _x_x_mozilla_page_load 10:05:12 INFO - PROCESS | 11644 | _x_x_mozilla_page_load_details 10:05:12 INFO - PROCESS | 11644 | |i|pagename|runs| 10:05:12 INFO - PROCESS | 11644 | |0;dojo.html;3030.287882347648;3044.786864919454;3068.186930463426;3069.1713237425897;3102.2089367211356;5120.311836285951;5221;5260.8158714445;5348.598855085865;5413.0256553820345;5312.442193569668;5321.255024296592;5379.757910894009;5423.267858839065;5446.972765136179;4764.475907650156;4833.516648335156;4841.61267098633;4853.733044682559;4872.829450969217;4882.755862206894;4908.607311415079;4935.3090567320605;4952.653314267985;4969.478204788499;4784.043191361707;4822.252550854623;4851.85444436664;4862.927056094161;4969.577585905185;4881.048195601859;4953.777080031407;4971.850844474671;4974.452810190876;4984.0281145176705;4826.638002149853;4845.588125009378;4854.951450485485;4863.8540843774745;4927.285543596195;5195.246689230078;5348.51863332298;5362.91955620666;5372.758225879845;5377.7580008899695;5593.636413633101;5682.289713785777;5683.175939488751;5684.317881854204;5684.317881854204;5639.577031722596;5726.427357264281;5731.799387021476;5737.598368114233;5775.971120144414;5263.447338029452;5291.074062039128;5344.518993290622;5352.464753524655;5355.437679043722;5716.085426331767;5743.54051675865;5782.913256301074;5794;5802.419758024248;5518.089515230023;5558.805441809517;5563.972180139073;5571.164325351148;5571.693556854331;5686.0333743263745;5731.684757338303;5736.885262294731;5765.250517432707;5837.7664893404635;5705.885882282331;5740.684262365527;5747.942520574741;5752.453516915886;5756.366799652035;5465.945340546544;5741.655500669973;5746.827595172152;5747.597668163272;5750.482456578928;4289.378040184156;4411.139827733626;4432.734035957853;4447.266201076786;4507.301368287921;3928.0376307804772;3936.1537269486626;3964;3980.6616437602547;3989.1423343980605;5484.670919744828;5486.341639003345;5486.780528778884;5487.533559647395;5493.423190565013;5618.943810561842;5659.179418984307;5662.065759149777;5785.14030423139;5866.6186697864505;5439.755211015514;5480.945190548044;5506.669599824023;5571.526420254243;5575.024370735106;5001.499850015042;5001.799928002912;5035.420926593489;5041.866296511886;5046.873828154326;5947.732352044169;6004.969975150097;6007.429294217042;6010.1285313628405;6044.576879618385;5614.803481878114;5651.773929042956;5725.427457254241;5744.195812586325;5749.080147176432;5985.820425387245;5990.88018239624;5992.610480318765;5999.280086389661;6049.18336024631;5683.573731970201;5691.146328050825;5695.857603559944;5697.829065128053;5698.088305871041;5490.780368785204;5589.608727389043;5670.319561652628;5704.857378565569;5788.768449261982;5575.303087114111;5613.803516876889;5620.578456615688;5674.716264186692;5682.744276507649;5621.943780562142;5626.24045753818;5627;5631.2960879890015;5633.8309850704545;5345.1714984177515;5374.3013408256675;5531.308586426697;5563.165525171256;5565.16522521625;5638.746256418389;5663.57523185771;5672.290963629546;5718.628289161191;5737.024705800108;5504.9449505504435;5537.169424586345;5543.362513311021;5547.916781248204;5550.944490555043 10:05:12 INFO - PROCESS | 11644 | |1;ext.html;581.700424281495;610.8320211941718;613.2885852411204;626.2829060725468;629.4743888852811;40955.385669214986;42914.35628465572;43009.78495107528;46779.53220467794;46821.76589117058;44072;44623.55376446235;44702.32946505797;44710.105797884105;44757;8850.778730531756;8978.730638080835;8992.325575581825;9003.369764116514;9006;8860.025397206302;8955.552222388887;8963.95518022409;8965.865512017324;8969.730908072768;8889.066648001964;8984.820303593924;8992.23565996891;8996.460212387277;8999.640014399416;8906.06486318937;8924.866127008036;8955.41789783662;8956.552172391386;8960.372773905829;8812.38313318068;8832.8675069874;8852.114788521161;8919;8920;39432;40117.59882401168;40162.19675606472;40199.397009044886;40236.39645405321;3110.284634534047;3113.3928883867657;3220.72623826975;3435.914102147466;3441.4493681011168;30432.695673043207;30712.84643576768;30823;31166.688333116606;31349;4170.35359519272;4281.871543853689;4314.697971142022;4329.328954012133;4394.4067550880545;337356;337725;337966;338306;339731.99999999756;54580.45419545833;54776.45223547793;54885;54891.725541372834;54950.45049549533;54657.1801422979;56144;57179;57434.13848792271;57535;12492.063095267891;12742.426590803436;13528.864711352957;14018.789718154236;14023.719525609431;10663;10705.732356691145;10739.140868730483;10754.085902698358;10791.6222932197;15204;15231.466898658715;15383.384664613513;15441.922790386201;15474.303656335493;4987.501249875056;5546.389897111315;5600.05996851648;5731.838273855622;5876.236089308362;895.7088946092546;994.9353292035994;1006.7583779892773;1013.1388319928002;1052.3633201912885;28904.710952890622;29891;30038.549421758693;30119;30266.697333026827;1016.6645007147623;1018.4551265073151;1046.4035499765214;1111.6442738323658;1113.9220254582262;15900.840991589936;16102.43641472543;16191.190440478165;16249.350025999063;16514.83485165157;501974;505620;508492;511151;511438;56311;56354.43645563574;56451.43548564544;56488.43511564914;56556;1205.421397729095;1210.267787988272;1260.1556956839124;1301.8698130187095;1319.9076064675573;26991;29980.550291746076;30386.696133038386;30708.692913070583;30821;47832.76083619559;48479;48597;48601.75699121482;48628.75685621549;420056;420219;420963;422219;422919;37836.81081594574;38590.614093859826;39328.41007384949;39402.60597394104;39422.408663870636;45371;46284.7685761569;46457;46506.53493465022;46586.53413465822;39430.60569394269;39728.80135599303;40543.79728101341;40646.59353406546;41565.79217103895;38490.2679379423;38880.2223955525;39115.6088439112;39727.205455890144;40005.19989600134;38314.80842595769;38538.421923671725;38992.49021054089;39676.206475870895;39814;33600;34919.476207856394;35819.462708058876;36371.45442818413;36614.63385366112;27452;27660.723392765816;27666.478343690484;27923.581146282417;27961.860190698917 10:05:12 INFO - PROCESS | 11644 | |2;jquery.html;370.2114496123257;391.1277850393622;398.5814894360921;402.4004233691799;419.6055707634823;13068.73862522749;14899.10605363679;15646.921765391171;18940.905295473538;19001.61996760064;18728.157232924517;19164.90417547914;19258.51853703658;19429.12568934398;19558.41324760256;5438.700871452069;5780.53755699543;5786.103154011135;5818.679972601505;5824;5107.514786095315;6395.840103997414;6439.678016099199;6549.279579246279;6549.279579246279;6231.158793562879;6393.392627700384;6483.897737384656;6484.967575162118;6499.577527460724;6430.421262086411;6449.9355006449805;6465.159529261213;6469;6471.385218404244;5543.473370029841;5551.500364967173;5624.943750562483;5632.3103069079525;5634.408387119375;22361.664575031387;22657.206997755166;22657.320280391614;22836.086556537717;23129.53740925189;2344.3201471573393;2348.283773449097;2501.8498890066653;2649.0198626508313;2722.68689100752;13864;14738.852611473962;15086.170260635661;15122.319495622723;15268.618284542865;1868.4394681595602;1939.5732938753451;1985.7319261899604;1994.3618042226494;2006.2877678424095;76662;77910.61044694798;79701;80247.5987620064;80479;10245.231607629308;10421.5831366746;10782.245242833083;10886.67339979802;10895.237333386587;14854.2572871356;14867.5539733806;14905.105693658199;14919;14932.850671493146;7427.925720742724;7517.511361761468;7545.6981720730555;7633.389328853678;7702.96148519265;6982.47631427645;6987.930120698829;7115.644217789193;7281.781546553612;7286.23494533077;6345.524085693592;6410.775622853271;6426.2931077581425;6521.771737989147;6563.868722625521;1811.53805779528;1873.8313551780404;1887.4149013805763;1905.7486264762435;1949.76602807664;837.539353355652;978.6819283732815;1023.4524529376748;1025.3745215418737;1049.821530339844;18483.90758046201;19614.411567652995;19665.705014424795;19719.802801971797;20065.097070631855;943.3915124744501;972.6109556177586;974.1914211204684;1008.2992320337295;1019.3985548526405;10555.313904596176;11054.392008439452;11094.167937404727;11215.943920280346;11240.494177761857;442333;445938;454514;454699;454852;77566.61216693881;79970;80166;80943.59528202322;81937;959.7552624080814;963.6530848894532;994.9156517096671;995.4077323992213;1001.952959157682;16436.917815410845;16739.24673389725;16952.237149328063;17414.82585174132;17684.204210810803;36639;38591.80704096462;38965;38988.61011389963;39196.21607567776;49185.26222106743;49311.75344123256;49372.50627493679;49798.502014979385;51328.48671513237;8453.450525715809;8500.659973600987;8655.783605409915;8703.1296870315;8711.564421779012;12178.39108044612;12613.243205407705;12855.935720321339;13047.869521304665;13070.607881763563;11191.613232763486;11263.211575189658;11361.204715669825;11386.886131138583;11429.942850285695;10888.183386245904;11340;11642.825357619811;11730.413479326171;12011.81982270284;11276.32342059479;11420.600278990196;11586.246893951866;11589.6523104307;12043;8272.503649781032;8527.872081918653;8602.354823388396;8608;8775.56122193875;10201.54093065799;10574.947125264633;10727.463626818784;10728.570857165938;11289.491972861406 10:05:12 INFO - PROCESS | 11644 | |3;mootools.html;1330.826992490976;1458.5259790568068;1493;1633.4609578838983;1780.0209884563487;7765.339946104581;8767.956160219206;9102.908970910281;9103.77240568986;9310.906890931088;9162.35863489556;9178.449293042422;9210.953945230282;9231.492267925261;9233.907660923389;2381.666566680666;2432.1609044879488;2434.805215582749;2435.2694191742494;2436.4517983453757;2329.4176455886027;2338.4387746940783;2383.9642405363848;2384.642303654457;2389.354874183978;2333.136739406422;2335.4861930375373;2338.5673650374733;2375.049980008002;2375.6317770745563;2277.1802151225547;2302.2502897797626;2307.123293148601;2308.572914010905;2311.1564279038116;2285.0859656137513;2307.40007598024;2309.2956648222284;2321.7330007049236;2324.837261391703;7941.761747147595;8881.73354799357;8956.373053886231;9007.954960225157;9100.63597456101;4545.09098180362;5065.442801291855;5236.397814251333;5251.448597897204;5317.388500322435;3420.7605467617277;3511.3855075361707;3576.7853928764357;3578.1054736315923;3603.40543810271;1090.7327704712318;1131.9660410187707;1143.3597185576104;1150.4765331774022;1151.5508951508834;12970.740585188338;13060.542880999119;13067.019973502025;13097.214167150001;13115.868841311656;4738.715677059318;4780.7102514045655;4853.927191092136;4928.457869634337;4978.502149785065;10779.568817247222;10804.297720648132;10820.72948176286;10820.945895270474;10826.891731082746;5437.13005919051;5438.592105592096;5448.155535891943;5449.754761035763;5449.945500544944;4902.730349830794;4940.209566469348;4990.476000020019;4997.30037794709;5005.1491246488185;3935.311320518898;3982.820773065219;4057.411675307064;4090.1206240658403;4098.5286692030795;1274.668586167603;1301.5704817410233;1331.187975335045;1341.148370784559;1352.553657293091;756.7048850948134;913.5067063785482;921.1065266691432;922.7462447826767;944.4899754132829;5882.882342353129;5950.166976623276;5952.821415357546;6056.727447264883;6229.595076320115;472.23497933348193;480.19087836994777;482.3921858458298;498.1431937068237;499.0493110624267;4040.1111755413763;4097.262492751273;4216.9578304217175;4237.237297286456;4327.7619730914475;11267.774644507228;11557.826632600518;11636.709082273012;11644;11645.301281923112;11445.942770286261;11454.48454819535;11477.827832582518;11504.424778761197;11521.423928803693;7954.960225198837;8423.073461919184;8471.57642117904;8544.530050847263;8553.828923421497;6135.079738039151;6141.385861413823;6160.521474845915;6177.2556062759995;6223.408776166257;10513.369197848153;10581.735456613646;10588.735281617714;10632.893671063499;10660.62687805923;10490;10964.780704386027;11108;11133.777324453627;11146.665600032013;8278.917210827814;8329.875051874105;8378.664853405795;8410.327173826201;8412.62143203545;8639.222469977733;8675.522846243517;8799.428037177562;8847.73456796297;8925.910740892508;7975.840483190188;7977.960110199412;7998.280154786097;8065.475744076616;8206;7632.562949998029;7781.649825757741;7865.134835168242;7957.363410927228;7994.120646728739;7157.785266442015;7158.821029474305;7205.927940720526;7207.783766486804;7209.6034718091005;4273.401723758739;5071.923921141112;5108.66793658411;5132;5145.819896303611;5324.707141107121;5349.491798279158;5358.383785864676;5403.83788486346;5462.508374246337 10:05:12 INFO - PROCESS | 11644 | |4;prototype.html;330.7982130900151;331.16381137627485;339.4212867061659;348.87614896711654;351.54474954933374;5221.530062294398;5249.4750524947485;5267.420583735786;5270.20946857971;5305.310309659739;5121.15500942345;5173.560247378968;5241.42344342123;5258.842234732954;5281.207818827178;3878.495795546575;4069.572694867041;4152.397902304157;4158.37624356346;4217.692515320246;4075.4498142750645;4077.1641813428323;4092.7953602319913;4096.283150448675;4101.610347017044;4010.278149933011;4027.107259587989;4036.8385264589383;4040.9797951010205;4056.9391459128137;3910.159315747128;3967.841286348543;3996.6403023728003;4060.512738471373;4063.1264278180183;3588.8385022674042;3589.46158076288;3598.1004748812798;3602;3607.8917632471066;5044.218146187347;5051.1815746331295;5053.393592768891;5068.898622027576;5096;4385.978070109629;4406.7355958642265;4588.632909367243;4605.585497305258;4686.484486706459;5350.973245133789;5359.5712343012465;5361.839144825662;5376.489233522809;5392.325959255093;3895.8052097395016;3902.2975864344407;3921.647051765326;3925.7840818754958;3936.5276166859876;5444.482774136451;5599.356074051496;5642.843217140477;5694.402087780806;5709.857253568653;4055.7769322686945;4063.837446502166;4074.2258970796047;4075;4086.079542614966;4124.278251306069;4126.133511962462;4130.876073717794;4134.421181034658;4138.52406973196;4443.7111587746695;4548;4583.495815460296;4692.131955588227;4708.788104535304;5408.945910540923;5411.106112860546;5425.26758887553;5436.184572314105;5438.809641662523;1399.4961813747043;1407.71141915907;1413.3569226002144;1415.1862678959433;1417.192200445736;853.2107800284712;918.4122161816442;932.4172392254841;935.9719208423758;939.4551160326994;4719.244920812722;4725.267583524559;4757.524247575215;4786.271825059752;4816.397950256218;4872.8781780455065;4922.975385123052;4945.604351651859;4958.281049247839;4971.875703107451;4756.334113224151;4756.881077973078;4765.808547863035;4774.498677638798;4910.950890491049;2914.1403286030672;2936.853157342124;2957.4233024560435;2962.170592234178;2968.257935516121;5754.942450575524;5803.970980145073;5804.984127777622;5844.590878638454;5855.765769369263;5595.63628364155;5676.914846277309;5714.999875021855;5732.426757324318;5741.1388291756575;5773.220615216892;5788.9131663024245;5788.913166302509;5799.9130013049835;5805.593608447452;5380.246765452762;5574.108142697149;5603.10350343943;5606.084835885398;5628.324601047901;5456.863578410572;5500.202470641814;5522.144067669517;5529.778808847601;5531.778728850801;5811.651300921958;5821;5821.76712931478;5849.473547380756;5852.619579727304;3929.312370335237;3946.309395855771;4036.9192616146925;4052.4529188560346;4054.493188351456;5620;5624.803131890364;5627.199296225169;5632.436756324335;5641.8589535261945;5468.617196796186;5472.343318801769;5513.614047016831;5532.834014979557;5574.136008918624;5374.140137577969;5441.156620723794;5456.690394305418;5528.391876893619;5544.724713315879;5345.54562862161;5394.892102158014;5401.810936617199;5409.83770486886;5424.647397919122;5195.908859139623;5405.918911216257;5452.154915988028;5538.6122971391615;5542.946840100368;5429.945700542944;5438.972805135949;5439.156930675752;5454.127339625799;5474.151506516497 10:05:12 INFO - PROCESS | 11644 | |5;yui.html;597.3101068266151;630.73509126167;658.2561705273041;701.9120363436673;706.8868980963047;13628.250446225453;15275.847241527596;15374.769378459305;15554.300056497457;15619.140947247897;13844.723105537883;13908;13922.443102275896;13940.51208207713;13951.651208719763;785.4384115357504;806.1615919443772;807.9757607271791;808.886755854178;810.1979040749675;656.1666683312191;681.0737397139886;771.4214339245566;799.2087833045273;800.3437181511163;829.2536716954729;831.3432388413177;831.6382373667444;832.134580036761;832.6794184239051;829.7386323308139;829.983400331993;830.1076342931373;830.1781236575807;830.2112992656939;496.3720893070269;510.8416390918827;578.5747475605426;594.9464548190683;610.1549354144497;12936.35318234094;12961.22232666043;12979.41592628334;12982.026348023935;13117.344132793321;13492.59522214335;14037.859621403757;14265.952187136376;14274.928625356806;14432.422703091865;9874.456904870229;10507.106895913856;10804.67585972422;10922.945385273022;11015.118790496741;4213.894652633709;4261.424707664457;4329.220740266751;4346.76092814895;4355.281378572563;74728.85681247286;76487;78153.21846781517;78397;79492.20507794963;10313.27807053499;10402.843957340647;10407.167426605853;10563.154947604173;10572.577096916037;15906.204689765465;15960.76058859118;16042.037477751372;17317.48047558575;19310.227590896207;7938;8352.081271060179;8478.448900821428;8481.491110533389;9009.369344145847;4634.652401069866;4685.1800934836265;4698.577128058491;4818.469968303484;5044.067393104927;3420.4185288501017;3518.03254105118;3553.07620018797;3554.7511674183074;3560.732945029133;623.2707731953534;626.2578844069792;633.0567454492773;638.9776357827546;647.3817504283398;643.5141468191486;750.5496701978769;750.8535835512023;751.6279441676405;752.8494301139795;8273.627686753991;9526.977381496123;9586.808263834824;9712;9912.55393507294;728.7085165933669;735.5770432001514;736.8084298082537;743.0785825576246;754.5329212269612;4524.185646583646;4788.209945359046;4808.567228949411;4808.951910480921;4829.203181475087;74221.6288918552;75196;76768;125339.3733031329;125341.35963881647;84201.57899210587;87185;107370.46314768532;109798;110733.44633276782;66835.99746003814;68878.65560672164;82692.58653706813;84314.57842710747;87221.56389218013;8932.642694292155;9123;9563.187129094105;9656.565454554702;9859.852102218616;49607.255891162386;49889.501104988485;50172.24741628805;50947;51087.74456127696;60894.391056090644;69249;70868.64565677139;72831.63584182045;74809;11600.245984011011;11721.648350549498;11909.546231592742;12106.455209515418;12503.937165340683;14312.284385780462;14632.54951170275;14642.34109465098;14648.926755366581;14674.26628668541;12898.290594017419;12907;13127;13128.737425251633;13576.59270221895;10336.638217662647;13229.05870159257;13271.270080145685;13401.86598134006;13548.86451135476;13060;13209.141405808592;13422.731545369234;13620.727585448434;13625.523106691218;9566.712998609775;10326.793464130826;10513.737156571147;10622.150227981589;10996.450177491253;10201.336913100624;10752.98666534483;10896.455177241265;10947.945260273647;11033.779324413626 10:05:12 INFO - PROCESS | 11644 | __end_tp_report 10:05:12 INFO - PROCESS | 11644 | __start_cc_report 10:05:12 INFO - PROCESS | 11644 | _x_x_mozilla_cycle_collect,974 10:05:12 INFO - PROCESS | 11644 | __end_cc_report 10:05:12 INFO - PROCESS | 11644 | __startTimestamp1475082312006__endTimestamp 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | ------- Summary: start ------- 10:05:12 INFO - PROCESS | 11644 | Number of tests: 6 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | [#0] dojo.html Cycles:165 Average:5328.11 Median:5547.92 stddev:601.66 (10.8%) stddev-sans-first:575.87 10:05:12 INFO - PROCESS | 11644 | Values: 3030.3 3044.8 3068.2 3069.2 3102.2 5120.3 5221.0 5260.8 5348.6 5413.0 5312.4 5321.3 5379.8 5423.3 5447.0 4764.5 4833.5 4841.6 4853.7 4872.8 4882.8 4908.6 4935.3 4952.7 4969.5 4784.0 4822.3 4851.9 4862.9 4969.6 4881.0 4953.8 4971.9 4974.5 4984.0 4826.6 4845.6 4855.0 4863.9 4927.3 5195.2 5348.5 5362.9 5372.8 5377.8 5593.6 5682.3 5683.2 5684.3 5684.3 5639.6 5726.4 5731.8 5737.6 5776.0 5263.4 5291.1 5344.5 5352.5 5355.4 5716.1 5743.5 5782.9 5794.0 5802.4 5518.1 5558.8 5564.0 5571.2 5571.7 5686.0 5731.7 5736.9 5765.3 5837.8 5705.9 5740.7 5747.9 5752.5 5756.4 5465.9 5741.7 5746.8 5747.6 5750.5 4289.4 4411.1 4432.7 4447.3 4507.3 3928.0 3936.2 3964.0 3980.7 3989.1 5484.7 5486.3 5486.8 5487.5 5493.4 5618.9 5659.2 5662.1 5785.1 5866.6 5439.8 5480.9 5506.7 5571.5 5575.0 5001.5 5001.8 5035.4 5041.9 5046.9 5947.7 6005.0 6007.4 6010.1 6044.6 5614.8 5651.8 5725.4 5744.2 5749.1 5985.8 5990.9 5992.6 5999.3 6049.2 5683.6 5691.1 5695.9 5697.8 5698.1 5490.8 5589.6 5670.3 5704.9 5788.8 5575.3 5613.8 5620.6 5674.7 5682.7 5621.9 5626.2 5627.0 5631.3 5633.8 5345.2 5374.3 5531.3 5563.2 5565.2 5638.7 5663.6 5672.3 5718.6 5737.0 5504.9 5537.2 5543.4 5547.9 5550.9 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | [#1] ext.html Cycles:180 Average:57975.48 Median:40595.20 stddev:113393.38 (279.3%) stddev-sans-first:113629.60 10:05:12 INFO - PROCESS | 11644 | Values: 581.7 610.8 613.3 626.3 629.5 40955.4 42914.4 43009.8 46779.5 46821.8 44072.0 44623.6 44702.3 44710.1 44757.0 8850.8 8978.7 8992.3 9003.4 9006.0 8860.0 8955.6 8964.0 8965.9 8969.7 8889.1 8984.8 8992.2 8996.5 8999.6 8906.1 8924.9 8955.4 8956.6 8960.4 8812.4 8832.9 8852.1 8919.0 8920.0 39432.0 40117.6 40162.2 40199.4 40236.4 3110.3 3113.4 3220.7 3435.9 3441.4 30432.7 30712.8 30823.0 31166.7 31349.0 4170.4 4281.9 4314.7 4329.3 4394.4 337356.0 337725.0 337966.0 338306.0 339732.0 54580.5 54776.5 54885.0 54891.7 54950.5 54657.2 56144.0 57179.0 57434.1 57535.0 12492.1 12742.4 13528.9 14018.8 14023.7 10663.0 10705.7 10739.1 10754.1 10791.6 15204.0 15231.5 15383.4 15441.9 15474.3 4987.5 5546.4 5600.1 5731.8 5876.2 895.7 994.9 1006.8 1013.1 1052.4 28904.7 29891.0 30038.5 30119.0 30266.7 1016.7 1018.5 1046.4 1111.6 1113.9 15900.8 16102.4 16191.2 16249.4 16514.8 501974.0 505620.0 508492.0 511151.0 511438.0 56311.0 56354.4 56451.4 56488.4 56556.0 1205.4 1210.3 1260.2 1301.9 1319.9 26991.0 29980.6 30386.7 30708.7 30821.0 47832.8 48479.0 48597.0 48601.8 48628.8 420056.0 420219.0 420963.0 422219.0 422919.0 37836.8 38590.6 39328.4 39402.6 39422.4 45371.0 46284.8 46457.0 46506.5 46586.5 39430.6 39728.8 40543.8 40646.6 41565.8 38490.3 38880.2 39115.6 39727.2 40005.2 38314.8 38538.4 38992.5 39676.2 39814.0 33600.0 34919.5 35819.5 36371.5 36614.6 27452.0 27660.7 27666.5 27923.6 27961.9 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | [#2] jquery.html Cycles:180 Average:27233.03 Median:19680.84 stddev:74096.94 (376.5%) stddev-sans-first:74277.35 10:05:12 INFO - PROCESS | 11644 | Values: 370.2 391.1 398.6 402.4 419.6 13068.7 14899.1 15646.9 18940.9 19001.6 18728.2 19164.9 19258.5 19429.1 19558.4 5438.7 5780.5 5786.1 5818.7 5824.0 5107.5 6395.8 6439.7 6549.3 6549.3 6231.2 6393.4 6483.9 6485.0 6499.6 6430.4 6449.9 6465.2 6469.0 6471.4 5543.5 5551.5 5624.9 5632.3 5634.4 22361.7 22657.2 22657.3 22836.1 23129.5 2344.3 2348.3 2501.8 2649.0 2722.7 13864.0 14738.9 15086.2 15122.3 15268.6 1868.4 1939.6 1985.7 1994.4 2006.3 76662.0 77910.6 79701.0 80247.6 80479.0 10245.2 10421.6 10782.2 10886.7 10895.2 14854.3 14867.6 14905.1 14919.0 14932.9 7427.9 7517.5 7545.7 7633.4 7703.0 6982.5 6987.9 7115.6 7281.8 7286.2 6345.5 6410.8 6426.3 6521.8 6563.9 1811.5 1873.8 1887.4 1905.7 1949.8 837.5 978.7 1023.5 1025.4 1049.8 18483.9 19614.4 19665.7 19719.8 20065.1 943.4 972.6 974.2 1008.3 1019.4 10555.3 11054.4 11094.2 11215.9 11240.5 442333.0 445938.0 454514.0 454699.0 454852.0 77566.6 79970.0 80166.0 80943.6 81937.0 959.8 963.7 994.9 995.4 1002.0 16436.9 16739.2 16952.2 17414.8 17684.2 36639.0 38591.8 38965.0 38988.6 39196.2 49185.3 49311.8 49372.5 49798.5 51328.5 8453.5 8500.7 8655.8 8703.1 8711.6 12178.4 12613.2 12855.9 13047.9 13070.6 11191.6 11263.2 11361.2 11386.9 11429.9 10888.2 11340.0 11642.8 11730.4 12011.8 11276.3 11420.6 11586.2 11589.7 12043.0 8272.5 8527.9 8602.4 8608.0 8775.6 10201.5 10574.9 10727.5 10728.6 11289.5 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | [#3] mootools.html Cycles:180 Average:5989.01 Median:481.29 stddev:3511.10 (729.5%) stddev-sans-first:3503.50 10:05:12 INFO - PROCESS | 11644 | Values: 1330.8 1458.5 1493.0 1633.5 1780.0 7765.3 8768.0 9102.9 9103.8 9310.9 9162.4 9178.4 9211.0 9231.5 9233.9 2381.7 2432.2 2434.8 2435.3 2436.5 2329.4 2338.4 2384.0 2384.6 2389.4 2333.1 2335.5 2338.6 2375.0 2375.6 2277.2 2302.3 2307.1 2308.6 2311.2 2285.1 2307.4 2309.3 2321.7 2324.8 7941.8 8881.7 8956.4 9008.0 9100.6 4545.1 5065.4 5236.4 5251.4 5317.4 3420.8 3511.4 3576.8 3578.1 3603.4 1090.7 1132.0 1143.4 1150.5 1151.6 12970.7 13060.5 13067.0 13097.2 13115.9 4738.7 4780.7 4853.9 4928.5 4978.5 10779.6 10804.3 10820.7 10820.9 10826.9 5437.1 5438.6 5448.2 5449.8 5449.9 4902.7 4940.2 4990.5 4997.3 5005.1 3935.3 3982.8 4057.4 4090.1 4098.5 1274.7 1301.6 1331.2 1341.1 1352.6 756.7 913.5 921.1 922.7 944.5 5882.9 5950.2 5952.8 6056.7 6229.6 472.2 480.2 482.4 498.1 499.0 4040.1 4097.3 4217.0 4237.2 4327.8 11267.8 11557.8 11636.7 11644.0 11645.3 11445.9 11454.5 11477.8 11504.4 11521.4 7955.0 8423.1 8471.6 8544.5 8553.8 6135.1 6141.4 6160.5 6177.3 6223.4 10513.4 10581.7 10588.7 10632.9 10660.6 10490.0 10964.8 11108.0 11133.8 11146.7 8278.9 8329.9 8378.7 8410.3 8412.6 8639.2 8675.5 8799.4 8847.7 8925.9 7975.8 7978.0 7998.3 8065.5 8206.0 7632.6 7781.6 7865.1 7957.4 7994.1 7157.8 7158.8 7205.9 7207.8 7209.6 4273.4 5071.9 5108.7 5132.0 5145.8 5324.7 5349.5 5358.4 5403.8 5462.5 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | [#4] prototype.html Cycles:180 Average:4561.00 Median:5147.36 stddev:1334.25 (25.9%) stddev-sans-first:1299.67 10:05:12 INFO - PROCESS | 11644 | Values: 330.8 331.2 339.4 348.9 351.5 5221.5 5249.5 5267.4 5270.2 5305.3 5121.2 5173.6 5241.4 5258.8 5281.2 3878.5 4069.6 4152.4 4158.4 4217.7 4075.4 4077.2 4092.8 4096.3 4101.6 4010.3 4027.1 4036.8 4041.0 4056.9 3910.2 3967.8 3996.6 4060.5 4063.1 3588.8 3589.5 3598.1 3602.0 3607.9 5044.2 5051.2 5053.4 5068.9 5096.0 4386.0 4406.7 4588.6 4605.6 4686.5 5351.0 5359.6 5361.8 5376.5 5392.3 3895.8 3902.3 3921.6 3925.8 3936.5 5444.5 5599.4 5642.8 5694.4 5709.9 4055.8 4063.8 4074.2 4075.0 4086.1 4124.3 4126.1 4130.9 4134.4 4138.5 4443.7 4548.0 4583.5 4692.1 4708.8 5408.9 5411.1 5425.3 5436.2 5438.8 1399.5 1407.7 1413.4 1415.2 1417.2 853.2 918.4 932.4 936.0 939.5 4719.2 4725.3 4757.5 4786.3 4816.4 4872.9 4923.0 4945.6 4958.3 4971.9 4756.3 4756.9 4765.8 4774.5 4911.0 2914.1 2936.9 2957.4 2962.2 2968.3 5754.9 5804.0 5805.0 5844.6 5855.8 5595.6 5676.9 5715.0 5732.4 5741.1 5773.2 5788.9 5788.9 5799.9 5805.6 5380.2 5574.1 5603.1 5606.1 5628.3 5456.9 5500.2 5522.1 5529.8 5531.8 5811.7 5821.0 5821.8 5849.5 5852.6 3929.3 3946.3 4036.9 4052.5 4054.5 5620.0 5624.8 5627.2 5632.4 5641.9 5468.6 5472.3 5513.6 5532.8 5574.1 5374.1 5441.2 5456.7 5528.4 5544.7 5345.5 5394.9 5401.8 5409.8 5424.6 5195.9 5405.9 5452.2 5538.6 5542.9 5429.9 5439.0 5439.2 5454.1 5474.2 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - PROCESS | 11644 | [#5] yui.html Cycles:180 Average:19527.25 Median:4823.84 stddev:28153.87 (583.6%) stddev-sans-first:28196.97 10:05:12 INFO - PROCESS | 11644 | Values: 597.3 630.7 658.3 701.9 706.9 13628.3 15275.8 15374.8 15554.3 15619.1 13844.7 13908.0 13922.4 13940.5 13951.7 785.4 806.2 808.0 808.9 810.2 656.2 681.1 771.4 799.2 800.3 829.3 831.3 831.6 832.1 832.7 829.7 830.0 830.1 830.2 830.2 496.4 510.8 578.6 594.9 610.2 12936.4 12961.2 12979.4 12982.0 13117.3 13492.6 14037.9 14266.0 14274.9 14432.4 9874.5 10507.1 10804.7 10922.9 11015.1 4213.9 4261.4 4329.2 4346.8 4355.3 74728.9 76487.0 78153.2 78397.0 79492.2 10313.3 10402.8 10407.2 10563.2 10572.6 15906.2 15960.8 16042.0 17317.5 19310.2 7938.0 8352.1 8478.4 8481.5 9009.4 4634.7 4685.2 4698.6 4818.5 5044.1 3420.4 3518.0 3553.1 3554.8 3560.7 623.3 626.3 633.1 639.0 647.4 643.5 750.5 750.9 751.6 752.8 8273.6 9527.0 9586.8 9712.0 9912.6 728.7 735.6 736.8 743.1 754.5 4524.2 4788.2 4808.6 4809.0 4829.2 74221.6 75196.0 76768.0 125339.4 125341.4 84201.6 87185.0 107370.5 109798.0 110733.4 66836.0 68878.7 82692.6 84314.6 87221.6 8932.6 9123.0 9563.2 9656.6 9859.9 49607.3 49889.5 50172.2 50947.0 51087.7 60894.4 69249.0 70868.6 72831.6 74809.0 11600.2 11721.6 11909.5 12106.5 12503.9 14312.3 14632.5 14642.3 14648.9 14674.3 12898.3 12907.0 13127.0 13128.7 13576.6 10336.6 13229.1 13271.3 13401.9 13548.9 13060.0 13209.1 13422.7 13620.7 13625.5 9566.7 10326.8 10513.7 10622.2 10996.5 10201.3 10753.0 10896.5 10947.9 11033.8 10:05:12 INFO - PROCESS | 11644 | -------- Summary: end -------- 10:05:12 INFO - PROCESS | 11644 | 10:05:12 INFO - TEST-INFO | 11644: exit 0 10:05:12 INFO - TEST-OK | dromaeo_css | took 1115554ms 10:05:12 INFO - TEST-START | kraken 10:05:12 INFO - operating with platform_type : linux_ 10:05:12 INFO - Initialising browser for kraken test... 10:05:13 INFO - TEST-INFO | started process 11949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnEKKL/profile http://localhost:51441/getInfo.html) 10:05:16 INFO - PROCESS | 11949 | __metrics Screen width/height:1600/1200 10:05:16 INFO - PROCESS | 11949 | colorDepth:24 10:05:16 INFO - PROCESS | 11949 | Browser inner width/height: 1024/697 10:05:16 INFO - PROCESS | 11949 | __metrics 10:05:17 INFO - PROCESS | 11949 | 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" 10:05:17 INFO - PROCESS | 11949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:17 INFO - PROCESS | 11949 | console.error: PushService: 10:05:17 INFO - PROCESS | 11949 | stateChangeProcessEnqueue: Error transitioning state 10:05:17 INFO - PROCESS | 11949 | UnknownError 10:05:18 INFO - TEST-INFO | 11949: exit 0 10:05:18 INFO - Browser initialized. 10:05:18 INFO - Running cycle 1/1 for kraken test... 10:05:18 INFO - TEST-INFO | started process 12032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnEKKL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:30 INFO - PROCESS | 12032 | RSS: Main: 174067712 10:05:30 INFO - PROCESS | 12032 | 10:05:33 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51441/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:34 INFO - PROCESS | 12032 | RSS: Main: 233197568 10:05:34 INFO - PROCESS | 12032 | 10:05:36 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51441/tests/kraken/driver.html?testName=audio-dft) 10:05:37 INFO - PROCESS | 12032 | RSS: Main: 216920064 10:05:37 INFO - PROCESS | 12032 | 10:05:40 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51441/tests/kraken/driver.html?testName=audio-fft) 10:05:41 INFO - PROCESS | 12032 | RSS: Main: 298700800 10:05:41 INFO - PROCESS | 12032 | 10:05:43 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51441/tests/kraken/driver.html?testName=audio-oscillator) 10:05:43 INFO - PROCESS | 12032 | RSS: Main: 208412672 10:05:43 INFO - PROCESS | 12032 | 10:05:45 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:46 INFO - PROCESS | 12032 | RSS: Main: 212840448 10:05:46 INFO - PROCESS | 12032 | 10:05:49 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51441/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:50 INFO - PROCESS | 12032 | RSS: Main: 249753600 10:05:50 INFO - PROCESS | 12032 | 10:05:53 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51441/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:54 INFO - PROCESS | 12032 | RSS: Main: 248614912 10:05:54 INFO - PROCESS | 12032 | 10:05:56 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51441/tests/kraken/driver.html?testName=json-parse-financial) 10:05:57 INFO - PROCESS | 12032 | RSS: Main: 248643584 10:05:57 INFO - PROCESS | 12032 | 10:05:58 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:59 INFO - PROCESS | 12032 | RSS: Main: 211038208 10:05:59 INFO - PROCESS | 12032 | 10:06:01 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:01 INFO - PROCESS | 12032 | RSS: Main: 219144192 10:06:01 INFO - PROCESS | 12032 | 10:06:03 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:04 INFO - PROCESS | 12032 | RSS: Main: 222949376 10:06:04 INFO - PROCESS | 12032 | 10:06:07 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:07 INFO - PROCESS | 12032 | RSS: Main: 223387648 10:06:07 INFO - PROCESS | 12032 | 10:06:10 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:11 INFO - PROCESS | 12032 | RSS: Main: 222167040 10:06:11 INFO - PROCESS | 12032 | 10:06:12 INFO - PROCESS | 12032 | Cycle 1(1): loaded http://localhost:51441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51441/tests/kraken/driver.html?testName=ai-astar) 10:06:13 INFO - PROCESS | 12032 | RSS: Main: 273215488 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | __start_tp_report 10:06:13 INFO - PROCESS | 12032 | _x_x_mozilla_page_load 10:06:13 INFO - PROCESS | 12032 | _x_x_mozilla_page_load_details 10:06:13 INFO - PROCESS | 12032 | |i|pagename|runs| 10:06:13 INFO - PROCESS | 12032 | |0;ai-astar;110;112;112;112;113;112;112;113;112;112 10:06:13 INFO - PROCESS | 12032 | |1;audio-beat-detection;141;118;118;166;119;125;125;119;155;132 10:06:13 INFO - PROCESS | 12032 | |2;audio-dft;161;160;160;158;160;162;161;161;161;159 10:06:13 INFO - PROCESS | 12032 | |3;audio-fft;75;75;75;102;77;75;75;75;97;75 10:06:13 INFO - PROCESS | 12032 | |4;audio-oscillator;83;82;117;83;82;82;107;82;83;114 10:06:13 INFO - PROCESS | 12032 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 10:06:13 INFO - PROCESS | 12032 | |6;imaging-darkroom;146;145;146;148;146;146;146;145;145;146 10:06:13 INFO - PROCESS | 12032 | |7;imaging-desaturate;95;95;95;95;96;95;96;96;96;96 10:06:13 INFO - PROCESS | 12032 | |8;json-parse-financial;52;52;53;52;54;53;54;53;54;53 10:06:13 INFO - PROCESS | 12032 | |9;json-stringify-tinderbox;60;61;60;59;61;61;60;60;60;60 10:06:13 INFO - PROCESS | 12032 | |10;stanford-crypto-aes;79;83;84;79;79;79;79;86;81;83 10:06:13 INFO - PROCESS | 12032 | |11;stanford-crypto-ccm;125;124;125;123;123;133;122;123;158;126 10:06:13 INFO - PROCESS | 12032 | |12;stanford-crypto-pbkdf2;170;167;164;163;167;163;161;162;162;163 10:06:13 INFO - PROCESS | 12032 | |13;stanford-crypto-sha256-iterative;66;65;65;65;64;66;64;64;64;66 10:06:13 INFO - PROCESS | 12032 | __end_tp_report 10:06:13 INFO - PROCESS | 12032 | __start_cc_report 10:06:13 INFO - PROCESS | 12032 | _x_x_mozilla_cycle_collect,1622 10:06:13 INFO - PROCESS | 12032 | __end_cc_report 10:06:13 INFO - PROCESS | 12032 | __startTimestamp1475082373066__endTimestamp 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | ------- Summary: start ------- 10:06:13 INFO - PROCESS | 12032 | Number of tests: 14 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 10:06:13 INFO - PROCESS | 12032 | Values: 110.0 112.0 112.0 112.0 113.0 112.0 112.0 113.0 112.0 112.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:128.50 stddev:16.98 (13.2%) stddev-sans-first:17.68 10:06:13 INFO - PROCESS | 12032 | Values: 141.0 118.0 118.0 166.0 119.0 125.0 125.0 119.0 155.0 132.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 10:06:13 INFO - PROCESS | 12032 | Values: 161.0 160.0 160.0 158.0 160.0 162.0 161.0 161.0 161.0 159.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:10.31 (13.7%) stddev-sans-first:10.77 10:06:13 INFO - PROCESS | 12032 | Values: 75.0 75.0 75.0 102.0 77.0 75.0 75.0 75.0 97.0 75.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.00 stddev:14.81 (18.1%) stddev-sans-first:15.39 10:06:13 INFO - PROCESS | 12032 | Values: 83.0 82.0 117.0 83.0 82.0 82.0 107.0 82.0 83.0 114.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:06:13 INFO - PROCESS | 12032 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 10:06:13 INFO - PROCESS | 12032 | Values: 146.0 145.0 146.0 148.0 146.0 146.0 146.0 145.0 145.0 146.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:06:13 INFO - PROCESS | 12032 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 10:06:13 INFO - PROCESS | 12032 | Values: 52.0 52.0 53.0 52.0 54.0 53.0 54.0 53.0 54.0 53.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 10:06:13 INFO - PROCESS | 12032 | Values: 60.0 61.0 60.0 59.0 61.0 61.0 60.0 60.0 60.0 60.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.00 stddev:2.62 (3.2%) stddev-sans-first:2.65 10:06:13 INFO - PROCESS | 12032 | Values: 79.0 83.0 84.0 79.0 79.0 79.0 79.0 86.0 81.0 83.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:125.00 stddev:10.92 (8.7%) stddev-sans-first:11.52 10:06:13 INFO - PROCESS | 12032 | Values: 125.0 124.0 125.0 123.0 123.0 133.0 122.0 123.0 158.0 126.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:163.50 stddev:2.86 (1.7%) stddev-sans-first:2.13 10:06:13 INFO - PROCESS | 12032 | Values: 170.0 167.0 164.0 163.0 167.0 163.0 161.0 162.0 162.0 163.0 10:06:13 INFO - PROCESS | 12032 | 10:06:13 INFO - PROCESS | 12032 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 10:06:13 INFO - PROCESS | 12032 | Values: 66.0 65.0 65.0 65.0 64.0 66.0 64.0 64.0 64.0 66.0 10:06:13 INFO - PROCESS | 12032 | -------- Summary: end -------- 10:06:13 INFO - PROCESS | 12032 | 10:06:14 INFO - TEST-INFO | 12032: exit 0 10:06:14 INFO - TEST-OK | kraken | took 61318ms 10:06:14 INFO - SUITE-END | took 1176s 10:06:14 INFO - Completed test suite (00:19:37) 10:06:14 INFO - javascript benchmark 10:06:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.287882347648, 3044.786864919454, 3068.186930463426, 3069.1713237425897, 3102.2089367211356, 5120.311836285951, 5221.0, 5260.8158714445, 5348.598855085865, 5413.0256553820345, 5312.442193569668, 5321.255024296592, 5379.757910894009, 5423.267858839065, 5446.972765136179, 4764.475907650156, 4833.516648335156, 4841.61267098633, 4853.733044682559, 4872.829450969217, 4882.755862206894, 4908.607311415079, 4935.3090567320605, 4952.653314267985, 4969.478204788499, 4784.043191361707, 4822.252550854623, 4851.85444436664, 4862.927056094161, 4969.577585905185, 4881.048195601859, 4953.777080031407, 4971.850844474671, 4974.452810190876, 4984.0281145176705, 4826.638002149853, 4845.588125009378, 4854.951450485485, 4863.8540843774745, 4927.285543596195, 5195.246689230078, 5348.51863332298, 5362.91955620666, 5372.758225879845, 5377.7580008899695, 5593.636413633101, 5682.289713785777, 5683.175939488751, 5684.317881854204, 5684.317881854204, 5639.577031722596, 5726.427357264281, 5731.799387021476, 5737.598368114233, 5775.971120144414, 5263.447338029452, 5291.074062039128, 5344.518993290622, 5352.464753524655, 5355.437679043722, 5716.085426331767, 5743.54051675865, 5782.913256301074, 5794.0, 5802.419758024248, 5518.089515230023, 5558.805441809517, 5563.972180139073, 5571.164325351148, 5571.693556854331, 5686.0333743263745, 5731.684757338303, 5736.885262294731, 5765.250517432707, 5837.7664893404635, 5705.885882282331, 5740.684262365527, 5747.942520574741, 5752.453516915886, 5756.366799652035, 5465.945340546544, 5741.655500669973, 5746.827595172152, 5747.597668163272, 5750.482456578928, 4289.378040184156, 4411.139827733626, 4432.734035957853, 4447.266201076786, 4507.301368287921, 3928.0376307804772, 3936.1537269486626, 3964.0, 3980.6616437602547, 3989.1423343980605, 5484.670919744828, 5486.341639003345, 5486.780528778884, 5487.533559647395, 5493.423190565013, 5618.943810561842, 5659.179418984307, 5662.065759149777, 5785.14030423139, 5866.6186697864505, 5439.755211015514, 5480.945190548044, 5506.669599824023, 5571.526420254243, 5575.024370735106, 5001.499850015042, 5001.799928002912, 5035.420926593489, 5041.866296511886, 5046.873828154326, 5947.732352044169, 6004.969975150097, 6007.429294217042, 6010.1285313628405, 6044.576879618385, 5614.803481878114, 5651.773929042956, 5725.427457254241, 5744.195812586325, 5749.080147176432, 5985.820425387245, 5990.88018239624, 5992.610480318765, 5999.280086389661, 6049.18336024631, 5683.573731970201, 5691.146328050825, 5695.857603559944, 5697.829065128053, 5698.088305871041, 5490.780368785204, 5589.608727389043, 5670.319561652628, 5704.857378565569, 5788.768449261982, 5575.303087114111, 5613.803516876889, 5620.578456615688, 5674.716264186692, 5682.744276507649, 5621.943780562142, 5626.24045753818, 5627.0, 5631.2960879890015, 5633.8309850704545, 5345.1714984177515, 5374.3013408256675, 5531.308586426697, 5563.165525171256, 5565.16522521625, 5638.746256418389, 5663.57523185771, 5672.290963629546, 5718.628289161191, 5737.024705800108, 5504.9449505504435, 5537.169424586345, 5543.362513311021, 5547.916781248204, 5550.944490555043], "value": 5287.443018797344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.700424281495, 610.8320211941718, 613.2885852411204, 626.2829060725468, 629.4743888852811, 40955.385669214986, 42914.35628465572, 43009.78495107528, 46779.53220467794, 46821.76589117058, 44072.0, 44623.55376446235, 44702.32946505797, 44710.105797884105, 44757.0, 8850.778730531756, 8978.730638080835, 8992.325575581825, 9003.369764116514, 9006.0, 8860.025397206302, 8955.552222388887, 8963.95518022409, 8965.865512017324, 8969.730908072768, 8889.066648001964, 8984.820303593924, 8992.23565996891, 8996.460212387277, 8999.640014399416, 8906.06486318937, 8924.866127008036, 8955.41789783662, 8956.552172391386, 8960.372773905829, 8812.38313318068, 8832.8675069874, 8852.114788521161, 8919.0, 8920.0, 39432.0, 40117.59882401168, 40162.19675606472, 40199.397009044886, 40236.39645405321, 3110.284634534047, 3113.3928883867657, 3220.72623826975, 3435.914102147466, 3441.4493681011168, 30432.695673043207, 30712.84643576768, 30823.0, 31166.688333116606, 31349.0, 4170.35359519272, 4281.871543853689, 4314.697971142022, 4329.328954012133, 4394.4067550880545, 337356.0, 337725.0, 337966.0, 338306.0, 339731.99999999756, 54580.45419545833, 54776.45223547793, 54885.0, 54891.725541372834, 54950.45049549533, 54657.1801422979, 56144.0, 57179.0, 57434.13848792271, 57535.0, 12492.063095267891, 12742.426590803436, 13528.864711352957, 14018.789718154236, 14023.719525609431, 10663.0, 10705.732356691145, 10739.140868730483, 10754.085902698358, 10791.6222932197, 15204.0, 15231.466898658715, 15383.384664613513, 15441.922790386201, 15474.303656335493, 4987.501249875056, 5546.389897111315, 5600.05996851648, 5731.838273855622, 5876.236089308362, 895.7088946092546, 994.9353292035994, 1006.7583779892773, 1013.1388319928002, 1052.3633201912885, 28904.710952890622, 29891.0, 30038.549421758693, 30119.0, 30266.697333026827, 1016.6645007147623, 1018.4551265073151, 1046.4035499765214, 1111.6442738323658, 1113.9220254582262, 15900.840991589936, 16102.43641472543, 16191.190440478165, 16249.350025999063, 16514.83485165157, 501974.0, 505620.0, 508492.0, 511151.0, 511438.0, 56311.0, 56354.43645563574, 56451.43548564544, 56488.43511564914, 56556.0, 1205.421397729095, 1210.267787988272, 1260.1556956839124, 1301.8698130187095, 1319.9076064675573, 26991.0, 29980.550291746076, 30386.696133038386, 30708.692913070583, 30821.0, 47832.76083619559, 48479.0, 48597.0, 48601.75699121482, 48628.75685621549, 420056.0, 420219.0, 420963.0, 422219.0, 422919.0, 37836.81081594574, 38590.614093859826, 39328.41007384949, 39402.60597394104, 39422.408663870636, 45371.0, 46284.7685761569, 46457.0, 46506.53493465022, 46586.53413465822, 39430.60569394269, 39728.80135599303, 40543.79728101341, 40646.59353406546, 41565.79217103895, 38490.2679379423, 38880.2223955525, 39115.6088439112, 39727.205455890144, 40005.19989600134, 38314.80842595769, 38538.421923671725, 38992.49021054089, 39676.206475870895, 39814.0, 33600.0, 34919.476207856394, 35819.462708058876, 36371.45442818413, 36614.63385366112, 27452.0, 27660.723392765816, 27666.478343690484, 27923.581146282417, 27961.860190698917], "value": 19291.186381477568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2114496123257, 391.1277850393622, 398.5814894360921, 402.4004233691799, 419.6055707634823, 13068.73862522749, 14899.10605363679, 15646.921765391171, 18940.905295473538, 19001.61996760064, 18728.157232924517, 19164.90417547914, 19258.51853703658, 19429.12568934398, 19558.41324760256, 5438.700871452069, 5780.53755699543, 5786.103154011135, 5818.679972601505, 5824.0, 5107.514786095315, 6395.840103997414, 6439.678016099199, 6549.279579246279, 6549.279579246279, 6231.158793562879, 6393.392627700384, 6483.897737384656, 6484.967575162118, 6499.577527460724, 6430.421262086411, 6449.9355006449805, 6465.159529261213, 6469.0, 6471.385218404244, 5543.473370029841, 5551.500364967173, 5624.943750562483, 5632.3103069079525, 5634.408387119375, 22361.664575031387, 22657.206997755166, 22657.320280391614, 22836.086556537717, 23129.53740925189, 2344.3201471573393, 2348.283773449097, 2501.8498890066653, 2649.0198626508313, 2722.68689100752, 13864.0, 14738.852611473962, 15086.170260635661, 15122.319495622723, 15268.618284542865, 1868.4394681595602, 1939.5732938753451, 1985.7319261899604, 1994.3618042226494, 2006.2877678424095, 76662.0, 77910.61044694798, 79701.0, 80247.5987620064, 80479.0, 10245.231607629308, 10421.5831366746, 10782.245242833083, 10886.67339979802, 10895.237333386587, 14854.2572871356, 14867.5539733806, 14905.105693658199, 14919.0, 14932.850671493146, 7427.925720742724, 7517.511361761468, 7545.6981720730555, 7633.389328853678, 7702.96148519265, 6982.47631427645, 6987.930120698829, 7115.644217789193, 7281.781546553612, 7286.23494533077, 6345.524085693592, 6410.775622853271, 6426.2931077581425, 6521.771737989147, 6563.868722625521, 1811.53805779528, 1873.8313551780404, 1887.4149013805763, 1905.7486264762435, 1949.76602807664, 837.539353355652, 978.6819283732815, 1023.4524529376748, 1025.3745215418737, 1049.821530339844, 18483.90758046201, 19614.411567652995, 19665.705014424795, 19719.802801971797, 20065.097070631855, 943.3915124744501, 972.6109556177586, 974.1914211204684, 1008.2992320337295, 1019.3985548526405, 10555.313904596176, 11054.392008439452, 11094.167937404727, 11215.943920280346, 11240.494177761857, 442333.0, 445938.0, 454514.0, 454699.0, 454852.0, 77566.61216693881, 79970.0, 80166.0, 80943.59528202322, 81937.0, 959.7552624080814, 963.6530848894532, 994.9156517096671, 995.4077323992213, 1001.952959157682, 16436.917815410845, 16739.24673389725, 16952.237149328063, 17414.82585174132, 17684.204210810803, 36639.0, 38591.80704096462, 38965.0, 38988.61011389963, 39196.21607567776, 49185.26222106743, 49311.75344123256, 49372.50627493679, 49798.502014979385, 51328.48671513237, 8453.450525715809, 8500.659973600987, 8655.783605409915, 8703.1296870315, 8711.564421779012, 12178.39108044612, 12613.243205407705, 12855.935720321339, 13047.869521304665, 13070.607881763563, 11191.613232763486, 11263.211575189658, 11361.204715669825, 11386.886131138583, 11429.942850285695, 10888.183386245904, 11340.0, 11642.825357619811, 11730.413479326171, 12011.81982270284, 11276.32342059479, 11420.600278990196, 11586.246893951866, 11589.6523104307, 12043.0, 8272.503649781032, 8527.872081918653, 8602.354823388396, 8608.0, 8775.56122193875, 10201.54093065799, 10574.947125264633, 10727.463626818784, 10728.570857165938, 11289.491972861406], "value": 9209.361183812196, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.826992490976, 1458.5259790568068, 1493.0, 1633.4609578838983, 1780.0209884563487, 7765.339946104581, 8767.956160219206, 9102.908970910281, 9103.77240568986, 9310.906890931088, 9162.35863489556, 9178.449293042422, 9210.953945230282, 9231.492267925261, 9233.907660923389, 2381.666566680666, 2432.1609044879488, 2434.805215582749, 2435.2694191742494, 2436.4517983453757, 2329.4176455886027, 2338.4387746940783, 2383.9642405363848, 2384.642303654457, 2389.354874183978, 2333.136739406422, 2335.4861930375373, 2338.5673650374733, 2375.049980008002, 2375.6317770745563, 2277.1802151225547, 2302.2502897797626, 2307.123293148601, 2308.572914010905, 2311.1564279038116, 2285.0859656137513, 2307.40007598024, 2309.2956648222284, 2321.7330007049236, 2324.837261391703, 7941.761747147595, 8881.73354799357, 8956.373053886231, 9007.954960225157, 9100.63597456101, 4545.09098180362, 5065.442801291855, 5236.397814251333, 5251.448597897204, 5317.388500322435, 3420.7605467617277, 3511.3855075361707, 3576.7853928764357, 3578.1054736315923, 3603.40543810271, 1090.7327704712318, 1131.9660410187707, 1143.3597185576104, 1150.4765331774022, 1151.5508951508834, 12970.740585188338, 13060.542880999119, 13067.019973502025, 13097.214167150001, 13115.868841311656, 4738.715677059318, 4780.7102514045655, 4853.927191092136, 4928.457869634337, 4978.502149785065, 10779.568817247222, 10804.297720648132, 10820.72948176286, 10820.945895270474, 10826.891731082746, 5437.13005919051, 5438.592105592096, 5448.155535891943, 5449.754761035763, 5449.945500544944, 4902.730349830794, 4940.209566469348, 4990.476000020019, 4997.30037794709, 5005.1491246488185, 3935.311320518898, 3982.820773065219, 4057.411675307064, 4090.1206240658403, 4098.5286692030795, 1274.668586167603, 1301.5704817410233, 1331.187975335045, 1341.148370784559, 1352.553657293091, 756.7048850948134, 913.5067063785482, 921.1065266691432, 922.7462447826767, 944.4899754132829, 5882.882342353129, 5950.166976623276, 5952.821415357546, 6056.727447264883, 6229.595076320115, 472.23497933348193, 480.19087836994777, 482.3921858458298, 498.1431937068237, 499.0493110624267, 4040.1111755413763, 4097.262492751273, 4216.9578304217175, 4237.237297286456, 4327.7619730914475, 11267.774644507228, 11557.826632600518, 11636.709082273012, 11644.0, 11645.301281923112, 11445.942770286261, 11454.48454819535, 11477.827832582518, 11504.424778761197, 11521.423928803693, 7954.960225198837, 8423.073461919184, 8471.57642117904, 8544.530050847263, 8553.828923421497, 6135.079738039151, 6141.385861413823, 6160.521474845915, 6177.2556062759995, 6223.408776166257, 10513.369197848153, 10581.735456613646, 10588.735281617714, 10632.893671063499, 10660.62687805923, 10490.0, 10964.780704386027, 11108.0, 11133.777324453627, 11146.665600032013, 8278.917210827814, 8329.875051874105, 8378.664853405795, 8410.327173826201, 8412.62143203545, 8639.222469977733, 8675.522846243517, 8799.428037177562, 8847.73456796297, 8925.910740892508, 7975.840483190188, 7977.960110199412, 7998.280154786097, 8065.475744076616, 8206.0, 7632.562949998029, 7781.649825757741, 7865.134835168242, 7957.363410927228, 7994.120646728739, 7157.785266442015, 7158.821029474305, 7205.927940720526, 7207.783766486804, 7209.6034718091005, 4273.401723758739, 5071.923921141112, 5108.66793658411, 5132.0, 5145.819896303611, 5324.707141107121, 5349.491798279158, 5358.383785864676, 5403.83788486346, 5462.508374246337], "value": 4667.660534908863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7982130900151, 331.16381137627485, 339.4212867061659, 348.87614896711654, 351.54474954933374, 5221.530062294398, 5249.4750524947485, 5267.420583735786, 5270.20946857971, 5305.310309659739, 5121.15500942345, 5173.560247378968, 5241.42344342123, 5258.842234732954, 5281.207818827178, 3878.495795546575, 4069.572694867041, 4152.397902304157, 4158.37624356346, 4217.692515320246, 4075.4498142750645, 4077.1641813428323, 4092.7953602319913, 4096.283150448675, 4101.610347017044, 4010.278149933011, 4027.107259587989, 4036.8385264589383, 4040.9797951010205, 4056.9391459128137, 3910.159315747128, 3967.841286348543, 3996.6403023728003, 4060.512738471373, 4063.1264278180183, 3588.8385022674042, 3589.46158076288, 3598.1004748812798, 3602.0, 3607.8917632471066, 5044.218146187347, 5051.1815746331295, 5053.393592768891, 5068.898622027576, 5096.0, 4385.978070109629, 4406.7355958642265, 4588.632909367243, 4605.585497305258, 4686.484486706459, 5350.973245133789, 5359.5712343012465, 5361.839144825662, 5376.489233522809, 5392.325959255093, 3895.8052097395016, 3902.2975864344407, 3921.647051765326, 3925.7840818754958, 3936.5276166859876, 5444.482774136451, 5599.356074051496, 5642.843217140477, 5694.402087780806, 5709.857253568653, 4055.7769322686945, 4063.837446502166, 4074.2258970796047, 4075.0, 4086.079542614966, 4124.278251306069, 4126.133511962462, 4130.876073717794, 4134.421181034658, 4138.52406973196, 4443.7111587746695, 4548.0, 4583.495815460296, 4692.131955588227, 4708.788104535304, 5408.945910540923, 5411.106112860546, 5425.26758887553, 5436.184572314105, 5438.809641662523, 1399.4961813747043, 1407.71141915907, 1413.3569226002144, 1415.1862678959433, 1417.192200445736, 853.2107800284712, 918.4122161816442, 932.4172392254841, 935.9719208423758, 939.4551160326994, 4719.244920812722, 4725.267583524559, 4757.524247575215, 4786.271825059752, 4816.397950256218, 4872.8781780455065, 4922.975385123052, 4945.604351651859, 4958.281049247839, 4971.875703107451, 4756.334113224151, 4756.881077973078, 4765.808547863035, 4774.498677638798, 4910.950890491049, 2914.1403286030672, 2936.853157342124, 2957.4233024560435, 2962.170592234178, 2968.257935516121, 5754.942450575524, 5803.970980145073, 5804.984127777622, 5844.590878638454, 5855.765769369263, 5595.63628364155, 5676.914846277309, 5714.999875021855, 5732.426757324318, 5741.1388291756575, 5773.220615216892, 5788.9131663024245, 5788.913166302509, 5799.9130013049835, 5805.593608447452, 5380.246765452762, 5574.108142697149, 5603.10350343943, 5606.084835885398, 5628.324601047901, 5456.863578410572, 5500.202470641814, 5522.144067669517, 5529.778808847601, 5531.778728850801, 5811.651300921958, 5821.0, 5821.76712931478, 5849.473547380756, 5852.619579727304, 3929.312370335237, 3946.309395855771, 4036.9192616146925, 4052.4529188560346, 4054.493188351456, 5620.0, 5624.803131890364, 5627.199296225169, 5632.436756324335, 5641.8589535261945, 5468.617196796186, 5472.343318801769, 5513.614047016831, 5532.834014979557, 5574.136008918624, 5374.140137577969, 5441.156620723794, 5456.690394305418, 5528.391876893619, 5544.724713315879, 5345.54562862161, 5394.892102158014, 5401.810936617199, 5409.83770486886, 5424.647397919122, 5195.908859139623, 5405.918911216257, 5452.154915988028, 5538.6122971391615, 5542.946840100368, 5429.945700542944, 5438.972805135949, 5439.156930675752, 5454.127339625799, 5474.151506516497], "value": 4141.1493934385435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.3101068266151, 630.73509126167, 658.2561705273041, 701.9120363436673, 706.8868980963047, 13628.250446225453, 15275.847241527596, 15374.769378459305, 15554.300056497457, 15619.140947247897, 13844.723105537883, 13908.0, 13922.443102275896, 13940.51208207713, 13951.651208719763, 785.4384115357504, 806.1615919443772, 807.9757607271791, 808.886755854178, 810.1979040749675, 656.1666683312191, 681.0737397139886, 771.4214339245566, 799.2087833045273, 800.3437181511163, 829.2536716954729, 831.3432388413177, 831.6382373667444, 832.134580036761, 832.6794184239051, 829.7386323308139, 829.983400331993, 830.1076342931373, 830.1781236575807, 830.2112992656939, 496.3720893070269, 510.8416390918827, 578.5747475605426, 594.9464548190683, 610.1549354144497, 12936.35318234094, 12961.22232666043, 12979.41592628334, 12982.026348023935, 13117.344132793321, 13492.59522214335, 14037.859621403757, 14265.952187136376, 14274.928625356806, 14432.422703091865, 9874.456904870229, 10507.106895913856, 10804.67585972422, 10922.945385273022, 11015.118790496741, 4213.894652633709, 4261.424707664457, 4329.220740266751, 4346.76092814895, 4355.281378572563, 74728.85681247286, 76487.0, 78153.21846781517, 78397.0, 79492.20507794963, 10313.27807053499, 10402.843957340647, 10407.167426605853, 10563.154947604173, 10572.577096916037, 15906.204689765465, 15960.76058859118, 16042.037477751372, 17317.48047558575, 19310.227590896207, 7938.0, 8352.081271060179, 8478.448900821428, 8481.491110533389, 9009.369344145847, 4634.652401069866, 4685.1800934836265, 4698.577128058491, 4818.469968303484, 5044.067393104927, 3420.4185288501017, 3518.03254105118, 3553.07620018797, 3554.7511674183074, 3560.732945029133, 623.2707731953534, 626.2578844069792, 633.0567454492773, 638.9776357827546, 647.3817504283398, 643.5141468191486, 750.5496701978769, 750.8535835512023, 751.6279441676405, 752.8494301139795, 8273.627686753991, 9526.977381496123, 9586.808263834824, 9712.0, 9912.55393507294, 728.7085165933669, 735.5770432001514, 736.8084298082537, 743.0785825576246, 754.5329212269612, 4524.185646583646, 4788.209945359046, 4808.567228949411, 4808.951910480921, 4829.203181475087, 74221.6288918552, 75196.0, 76768.0, 125339.3733031329, 125341.35963881647, 84201.57899210587, 87185.0, 107370.46314768532, 109798.0, 110733.44633276782, 66835.99746003814, 68878.65560672164, 82692.58653706813, 84314.57842710747, 87221.56389218013, 8932.642694292155, 9123.0, 9563.187129094105, 9656.565454554702, 9859.852102218616, 49607.255891162386, 49889.501104988485, 50172.24741628805, 50947.0, 51087.74456127696, 60894.391056090644, 69249.0, 70868.64565677139, 72831.63584182045, 74809.0, 11600.245984011011, 11721.648350549498, 11909.546231592742, 12106.455209515418, 12503.937165340683, 14312.284385780462, 14632.54951170275, 14642.34109465098, 14648.926755366581, 14674.26628668541, 12898.290594017419, 12907.0, 13127.0, 13128.737425251633, 13576.59270221895, 10336.638217662647, 13229.05870159257, 13271.270080145685, 13401.86598134006, 13548.86451135476, 13060.0, 13209.141405808592, 13422.731545369234, 13620.727585448434, 13625.523106691218, 9566.712998609775, 10326.793464130826, 10513.737156571147, 10622.150227981589, 10996.450177491253, 10201.336913100624, 10752.98666534483, 10896.455177241265, 10947.945260273647, 11033.779324413626], "value": 7232.863926414576, "unit": "score"}], "name": "dromaeo_css", "value": 7129.648931256016, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 118.0, 166.0, 119.0, 125.0, 125.0, 119.0, 155.0, 132.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 158.0, 160.0, 162.0, 161.0, 161.0, 161.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 102.0, 77.0, 75.0, 75.0, 75.0, 97.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 117.0, 83.0, 82.0, 82.0, 107.0, 82.0, 83.0, 114.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 148.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 54.0, 53.0, 54.0, 53.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 84.0, 79.0, 79.0, 79.0, 79.0, 86.0, 81.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 125.0, 123.0, 123.0, 133.0, 122.0, 123.0, 158.0, 126.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 164.0, 163.0, 167.0, 163.0, 161.0, 162.0, 162.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 64.0, 64.0, 66.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1485.7000000000003, "alertThreshold": 2.0}]} 10:06:14 INFO - Return code: 0 10:06:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:06:14 INFO - # TBPL SUCCESS # 10:06:14 INFO - Running post-action listener: _resource_record_post_action 10:06:14 INFO - [mozharness: 2016-09-28 17:06:14.863262Z] Finished run-tests step (success) 10:06:14 INFO - Running post-run listener: _resource_record_post_run 10:06:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 491520; Write bytes: 392699904; Read time: 48; Write time: 230216 10:06:14 INFO - TinderboxPrint: CPU usage
13.0% 10:06:14 INFO - TinderboxPrint: I/O read bytes / time
491,520 / 48 10:06:14 INFO - TinderboxPrint: I/O write bytes / time
392,699,904 / 230,216 10:06:14 INFO - TinderboxPrint: CPU idle
8,289.1 (86.9%) 10:06:14 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 10:06:14 INFO - TinderboxPrint: Swap in / out
0 / 0 10:06:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103387136; Read time: 0; Write time: 66172 10:06:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 491520; Write bytes: 288698368; Read time: 48; Write time: 164044 10:06:15 INFO - Running post-run listener: _upload_blobber_files 10:06:15 INFO - Blob upload gear active. 10:06:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:15 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 10:06:15 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:06:15 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:06:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:06:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:19 INFO - (blobuploader) - INFO - Done attempting. 10:06:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:19 INFO - (blobuploader) - INFO - Done attempting. 10:06:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:20 INFO - (blobuploader) - INFO - Done attempting. 10:06:20 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:20 INFO - Return code: 0 10:06:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96f6cc5dfae2eb879c347b27cfb6554fca5e5c6fa73b07c10757779d64a2872833c84a581cb366ed0815d67443b53927491eb0162f85dad5b3d8dff6c8620754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c73187c15321fac7016c5153f65d7b2604aa1b722f5b84113456727ffc3465c73d8b21e6f8cee947dda57e60ef366885f36aa7e3d7e38e602a8a59ba3f82e15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3468bf09d93d1f8488fff8b2bcb7ebbfad9a74330521116c324a691503108e06fd0313615b88729edb792d2b678c2cc42b2a4004026dde5bb982513be70d3976"} 10:06:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:20 INFO - Contents: 10:06:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96f6cc5dfae2eb879c347b27cfb6554fca5e5c6fa73b07c10757779d64a2872833c84a581cb366ed0815d67443b53927491eb0162f85dad5b3d8dff6c8620754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c73187c15321fac7016c5153f65d7b2604aa1b722f5b84113456727ffc3465c73d8b21e6f8cee947dda57e60ef366885f36aa7e3d7e38e602a8a59ba3f82e15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3468bf09d93d1f8488fff8b2bcb7ebbfad9a74330521116c324a691503108e06fd0313615b88729edb792d2b678c2cc42b2a4004026dde5bb982513be70d3976"} 10:06:20 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:20 INFO - Copying logs to upload dir... 10:06:20 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.345236 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-28 10:06:20.315540) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 10:06:20.319127) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96f6cc5dfae2eb879c347b27cfb6554fca5e5c6fa73b07c10757779d64a2872833c84a581cb366ed0815d67443b53927491eb0162f85dad5b3d8dff6c8620754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c73187c15321fac7016c5153f65d7b2604aa1b722f5b84113456727ffc3465c73d8b21e6f8cee947dda57e60ef366885f36aa7e3d7e38e602a8a59ba3f82e15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3468bf09d93d1f8488fff8b2bcb7ebbfad9a74330521116c324a691503108e06fd0313615b88729edb792d2b678c2cc42b2a4004026dde5bb982513be70d3976"} build_url:https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/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/Fx-Team/sha512/96f6cc5dfae2eb879c347b27cfb6554fca5e5c6fa73b07c10757779d64a2872833c84a581cb366ed0815d67443b53927491eb0162f85dad5b3d8dff6c8620754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c73187c15321fac7016c5153f65d7b2604aa1b722f5b84113456727ffc3465c73d8b21e6f8cee947dda57e60ef366885f36aa7e3d7e38e602a8a59ba3f82e15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3468bf09d93d1f8488fff8b2bcb7ebbfad9a74330521116c324a691503108e06fd0313615b88729edb792d2b678c2cc42b2a4004026dde5bb982513be70d3976"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 10:06:20.346248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 10:06:20.346617) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475081140.81350-236256166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 10:06:20.426760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 10:06:20.427122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 10:06:20.427429) ========= ========= Total master_lag: 0.21 =========