builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1472197486.79 results: success (0) buildid: 20160825232217 builduid: 982579a5030542e288005f4e77b2bbd9 revision: bc6197438658404755876af9f71ccdf8f9c0aee9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.792063) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.792417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.792683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.825267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.825621) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 00:44:46-- 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% 228M=0s 2016-08-26 00:44:46 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077369 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.917230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.917506) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017752 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.966374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:46.966677) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bc6197438658404755876af9f71ccdf8f9c0aee9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev bc6197438658404755876af9f71ccdf8f9c0aee9 --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=2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 00:44:46,976 truncating revision to first 12 chars 2016-08-26 00:44:46,976 Setting DEBUG logging. 2016-08-26 00:44:46,976 attempt 1/10 2016-08-26 00:44:46,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bc6197438658?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 00:44:47,282 unpacking tar archive at: autoland-bc6197438658/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607176 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:47.587338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:47.587642) ========= script_repo_revision: bc6197438658404755876af9f71ccdf8f9c0aee9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:47.588052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:47.588323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 00:44:47.596779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-26 00:44:47.597141) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:44:47 INFO - MultiFileLogger online at 20160826 00:44:47 in /builds/slave/test 00:44:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 00:44:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:44:47 INFO - {'append_to_log': False, 00:44:47 INFO - 'base_work_dir': '/builds/slave/test', 00:44:47 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:44:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:44:47 INFO - 'branch': 'Autoland-Non-PGO', 00:44:47 INFO - 'buildbot_json_path': 'buildprops.json', 00:44:47 INFO - 'config_files': ('talos/linux_config.py',), 00:44:47 INFO - 'default_actions': ('clobber', 00:44:47 INFO - 'read-buildbot-config', 00:44:47 INFO - 'download-and-extract', 00:44:47 INFO - 'populate-webroot', 00:44:47 INFO - 'create-virtualenv', 00:44:47 INFO - 'install', 00:44:47 INFO - 'run-tests'), 00:44:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:44:47 INFO - 'download_minidump_stackwalk': True, 00:44:47 INFO - 'download_symbols': 'ondemand', 00:44:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:44:47 INFO - 'tooltool.py': '/tools/tooltool.py', 00:44:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:44:47 INFO - '/tools/misc-python/virtualenv.py')}, 00:44:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:44:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:44:47 INFO - 'installer_path': 'installer.exe', 00:44:47 INFO - 'log_level': 'info', 00:44:47 INFO - 'log_name': 'talos', 00:44:47 INFO - 'log_to_console': True, 00:44:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:44:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:44:47 INFO - 'opt_config_files': (), 00:44:47 INFO - 'pip_index': False, 00:44:47 INFO - 'sps_profile': False, 00:44:47 INFO - 'sps_profile_interval': 0, 00:44:47 INFO - 'suite': 'dromaeojs', 00:44:47 INFO - 'system_bits': '32', 00:44:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:44:47 INFO - 'title': 'talos-linux64-ix-012', 00:44:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:44:47 INFO - 'use_talos_json': True, 00:44:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:44:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:44:47 INFO - 'work_dir': 'build'} 00:44:47 INFO - [mozharness: 2016-08-26 07:44:47.698803Z] Running clobber step. 00:44:47 INFO - Running pre-action listener: _resource_record_pre_action 00:44:47 INFO - Running main action method: clobber 00:44:47 INFO - rmtree: /builds/slave/test/build 00:44:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:44:48 INFO - Running post-action listener: _resource_record_post_action 00:44:48 INFO - [mozharness: 2016-08-26 07:44:48.149685Z] Finished clobber step (success) 00:44:48 INFO - [mozharness: 2016-08-26 07:44:48.149788Z] Running read-buildbot-config step. 00:44:48 INFO - Running pre-action listener: _resource_record_pre_action 00:44:48 INFO - Running main action method: read_buildbot_config 00:44:48 INFO - Using buildbot properties: 00:44:48 INFO - { 00:44:48 INFO - "project": "", 00:44:48 INFO - "product": "firefox", 00:44:48 INFO - "script_repo_revision": "production", 00:44:48 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:44:48 INFO - "repository": "", 00:44:48 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:44:48 INFO - "buildid": "20160825232217", 00:44:48 INFO - "pgo_build": "False", 00:44:48 INFO - "basedir": "/builds/slave/test", 00:44:48 INFO - "buildnumber": 515, 00:44:48 INFO - "slavename": "talos-linux64-ix-012", 00:44:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:44:48 INFO - "platform": "ubuntu64_hw", 00:44:48 INFO - "scheduler": "tests-autoland-linux64-talos", 00:44:48 INFO - "branch": "autoland", 00:44:48 INFO - "repo_path": "integration/autoland", 00:44:48 INFO - "revision": "bc6197438658404755876af9f71ccdf8f9c0aee9", 00:44:48 INFO - "stage_platform": "linux64", 00:44:48 INFO - "builduid": "982579a5030542e288005f4e77b2bbd9", 00:44:48 INFO - "slavebuilddir": "test" 00:44:48 INFO - } 00:44:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:44:48 INFO - Running post-action listener: _resource_record_post_action 00:44:48 INFO - [mozharness: 2016-08-26 07:44:48.152212Z] Finished read-buildbot-config step (success) 00:44:48 INFO - [mozharness: 2016-08-26 07:44:48.152302Z] Running download-and-extract step. 00:44:48 INFO - Running pre-action listener: _resource_record_pre_action 00:44:48 INFO - Running main action method: download_and_extract 00:44:48 INFO - mkdir: /builds/slave/test/build/tests 00:44:48 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')]} 00:44:48 INFO - trying https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:44:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:44:48 INFO - Downloaded 1361 bytes. 00:44:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:44:48 INFO - Using the following test package requirements: 00:44:48 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:44:48 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:44:48 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:44:48 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'jsshell-linux-x86_64.zip'], 00:44:48 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:44:48 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:44:48 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:44:48 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:44:48 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:44:48 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:44:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:44:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:44:48 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')]} 00:44:48 INFO - trying https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:44:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:44:50 INFO - Downloaded 20302935 bytes. 00:44:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 00:44:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:44:54 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')]} 00:44:54 INFO - trying https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:44:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:44:55 INFO - Downloaded 20302935 bytes. 00:44:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 00:45: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')]} 00:45:00 INFO - trying https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:45:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:45:01 INFO - Downloaded 14413998 bytes. 00:45:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 00:45:01 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')]} 00:45:01 INFO - trying https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:45:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:45:04 INFO - Downloaded 55903219 bytes. 00:45:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:45:04 INFO - mkdir: /builds/slave/test/properties 00:45:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:45:04 INFO - Writing to file /builds/slave/test/properties/build_url 00:45:04 INFO - Contents: 00:45:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:45:04 INFO - Running post-action listener: _resource_record_post_action 00:45:04 INFO - Running post-action listener: set_extra_try_arguments 00:45:04 INFO - [mozharness: 2016-08-26 07:45:04.747806Z] Finished download-and-extract step (success) 00:45:04 INFO - [mozharness: 2016-08-26 07:45:04.748034Z] Running populate-webroot step. 00:45:04 INFO - Running pre-action listener: _resource_record_pre_action 00:45:04 INFO - Running main action method: populate_webroot 00:45:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:45:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:45:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:45:04 INFO - '--tppagecycles', 00:45:04 INFO - '7'], 00:45:04 INFO - 'tests': ['tsvgm']}}, 00:45:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:45:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:45:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:45:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:45:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:45:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:45:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['damp', 'tps']}, 00:45:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'tests': ['damp', 'tps']}, 00:45:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['dromaeo_dom']}, 00:45:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:45:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['basic_compositor_video']}, 00:45:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:45:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['a11yr', 00:45:04 INFO - 'ts_paint', 00:45:04 INFO - 'tpaint', 00:45:04 INFO - 'sessionrestore', 00:45:04 INFO - 'sessionrestore_no_auto_restore', 00:45:04 INFO - 'tabpaint']}, 00:45:04 INFO - 'other-e10s': {'tests': ['a11yr', 00:45:04 INFO - 'ts_paint', 00:45:04 INFO - 'tpaint', 00:45:04 INFO - 'sessionrestore', 00:45:04 INFO - 'sessionrestore_no_auto_restore', 00:45:04 INFO - 'tabpaint']}, 00:45:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:45:04 INFO - 'ts_paint', 00:45:04 INFO - 'tpaint', 00:45:04 INFO - 'sessionrestore', 00:45:04 INFO - 'sessionrestore_no_auto_restore', 00:45:04 INFO - 'tabpaint']}, 00:45:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:45:04 INFO - 'ts_paint', 00:45:04 INFO - 'tpaint', 00:45:04 INFO - 'sessionrestore', 00:45:04 INFO - 'sessionrestore_no_auto_restore', 00:45:04 INFO - 'tabpaint']}, 00:45:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['a11yr', 00:45:04 INFO - 'ts_paint', 00:45:04 INFO - 'tpaint', 00:45:04 INFO - 'sessionrestore', 00:45:04 INFO - 'sessionrestore_no_auto_restore', 00:45:04 INFO - 'tabpaint']}, 00:45:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['a11yr', 00:45:04 INFO - 'ts_paint', 00:45:04 INFO - 'tpaint', 00:45:04 INFO - 'sessionrestore', 00:45:04 INFO - 'sessionrestore_no_auto_restore', 00:45:04 INFO - 'tabpaint']}, 00:45:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['tsvgx', 00:45:04 INFO - 'tsvgr_opacity', 00:45:04 INFO - 'tart', 00:45:04 INFO - 'tscrollx', 00:45:04 INFO - 'cart']}, 00:45:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:45:04 INFO - 'tsvgr_opacity', 00:45:04 INFO - 'tart', 00:45:04 INFO - 'tscrollx', 00:45:04 INFO - 'cart']}, 00:45:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'talos_options': ['--disable-e10s'], 00:45:04 INFO - 'tests': ['tp5o']}, 00:45:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'tests': ['tp5o']}, 00:45:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'talos_options': ['--disable-e10s', 00:45:04 INFO - '--xperf_path', 00:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:45:04 INFO - 'tests': ['tp5n']}, 00:45:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:45:04 INFO - 'talos_options': ['--xperf_path', 00:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:45:04 INFO - 'tests': ['tp5n']}}, 00:45:04 INFO - 'talos.zip': {'path': '', 00:45:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:45:04 INFO - Running post-action listener: _resource_record_post_action 00:45:04 INFO - [mozharness: 2016-08-26 07:45:04.769713Z] Finished populate-webroot step (success) 00:45:04 INFO - [mozharness: 2016-08-26 07:45:04.769803Z] Running create-virtualenv step. 00:45:04 INFO - Running pre-action listener: _resource_record_pre_action 00:45:04 INFO - Running main action method: create_virtualenv 00:45:04 INFO - Creating virtualenv /builds/slave/test/build/venv 00:45:04 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 00:45:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:45:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:45:04 INFO - Using real prefix '/usr' 00:45:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:45:05 INFO - Installing distribute.............................................................................................................................................................................................done. 00:45:07 INFO - Installing pip.................done. 00:45:07 INFO - Return code: 0 00:45:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:07 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:07 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 00:45:07 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 00:45:07 INFO - Using env: {'DISPLAY': ':0', 00:45:07 INFO - 'HOME': '/home/cltbld', 00:45:07 INFO - 'LANG': 'en_US.UTF-8', 00:45:07 INFO - 'LANGUAGE': 'en_US:en', 00:45:07 INFO - 'LOGNAME': 'cltbld', 00:45:07 INFO - 'MAIL': '/var/mail/cltbld', 00:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:07 INFO - 'MOZ_NO_REMOTE': '1', 00:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:07 INFO - 'NO_EM_RESTART': '1', 00:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:07 INFO - 'PWD': '/builds/slave/test', 00:45:07 INFO - 'SHELL': '/bin/bash', 00:45:07 INFO - 'SHLVL': '1', 00:45:07 INFO - 'TERM': 'linux', 00:45:07 INFO - 'TMOUT': '86400', 00:45:07 INFO - 'USER': 'cltbld', 00:45:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:07 INFO - '_': '/tools/buildbot/bin/python'} 00:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:07 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 00:45:07 INFO - Cleaning up... 00:45:07 INFO - Return code: 0 00:45:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:07 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:07 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 00:45:07 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 00:45:07 INFO - Using env: {'DISPLAY': ':0', 00:45:07 INFO - 'HOME': '/home/cltbld', 00:45:07 INFO - 'LANG': 'en_US.UTF-8', 00:45:07 INFO - 'LANGUAGE': 'en_US:en', 00:45:07 INFO - 'LOGNAME': 'cltbld', 00:45:07 INFO - 'MAIL': '/var/mail/cltbld', 00:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:07 INFO - 'MOZ_NO_REMOTE': '1', 00:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:07 INFO - 'NO_EM_RESTART': '1', 00:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:07 INFO - 'PWD': '/builds/slave/test', 00:45:07 INFO - 'SHELL': '/bin/bash', 00:45:07 INFO - 'SHLVL': '1', 00:45:07 INFO - 'TERM': 'linux', 00:45:07 INFO - 'TMOUT': '86400', 00:45:07 INFO - 'USER': 'cltbld', 00:45:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:07 INFO - '_': '/tools/buildbot/bin/python'} 00:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:07 INFO - Downloading/unpacking psutil>=3.1.1 00:45: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 00:45: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 00:45: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 00:45: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 00:45: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 00:45: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 00:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:45:09 INFO - Installing collected packages: psutil 00:45:09 INFO - Running setup.py install for psutil 00:45:09 INFO - building 'psutil._psutil_linux' extension 00:45:09 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 00:45:09 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 00:45:10 INFO - building 'psutil._psutil_posix' extension 00:45:10 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 00:45:10 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 00:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:45:10 INFO - Successfully installed psutil 00:45:10 INFO - Cleaning up... 00:45:10 INFO - Return code: 0 00:45:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:45:10 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')]} 00:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:10 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')]} 00:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:10 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:10 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 00:45:10 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 00:45:10 INFO - Using env: {'DISPLAY': ':0', 00:45:10 INFO - 'HOME': '/home/cltbld', 00:45:10 INFO - 'LANG': 'en_US.UTF-8', 00:45:10 INFO - 'LANGUAGE': 'en_US:en', 00:45:10 INFO - 'LOGNAME': 'cltbld', 00:45:10 INFO - 'MAIL': '/var/mail/cltbld', 00:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:10 INFO - 'MOZ_NO_REMOTE': '1', 00:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:10 INFO - 'NO_EM_RESTART': '1', 00:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:10 INFO - 'PWD': '/builds/slave/test', 00:45:10 INFO - 'SHELL': '/bin/bash', 00:45:10 INFO - 'SHLVL': '1', 00:45:10 INFO - 'TERM': 'linux', 00:45:10 INFO - 'TMOUT': '86400', 00:45:10 INFO - 'USER': 'cltbld', 00:45:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:10 INFO - '_': '/tools/buildbot/bin/python'} 00:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:45: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 00:45: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 00:45: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 00:45: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 00:45: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 00:45: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 00:45:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:45:12 INFO - Installing collected packages: mozsystemmonitor 00:45:12 INFO - Running setup.py install for mozsystemmonitor 00:45:12 INFO - Successfully installed mozsystemmonitor 00:45:12 INFO - Cleaning up... 00:45:12 INFO - Return code: 0 00:45:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:12 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:12 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 00:45:12 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 00:45:12 INFO - Using env: {'DISPLAY': ':0', 00:45:12 INFO - 'HOME': '/home/cltbld', 00:45:12 INFO - 'LANG': 'en_US.UTF-8', 00:45:12 INFO - 'LANGUAGE': 'en_US:en', 00:45:12 INFO - 'LOGNAME': 'cltbld', 00:45:12 INFO - 'MAIL': '/var/mail/cltbld', 00:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:12 INFO - 'MOZ_NO_REMOTE': '1', 00:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:12 INFO - 'NO_EM_RESTART': '1', 00:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:12 INFO - 'PWD': '/builds/slave/test', 00:45:12 INFO - 'SHELL': '/bin/bash', 00:45:12 INFO - 'SHLVL': '1', 00:45:12 INFO - 'TERM': 'linux', 00:45:12 INFO - 'TMOUT': '86400', 00:45:12 INFO - 'USER': 'cltbld', 00:45:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:12 INFO - '_': '/tools/buildbot/bin/python'} 00:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:12 INFO - Downloading/unpacking jsonschema==2.5.1 00:45:12 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 00:45:12 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 00:45:12 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 00:45:12 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 00:45:12 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 00:45:12 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 00:45:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:45:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:45:14 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 00:45:14 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 00:45:14 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 00:45:14 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 00:45:14 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 00:45:14 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 00:45:14 INFO - Downloading functools32-3.2.3-2.tar.gz 00:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:45:14 INFO - warning: no files found matching '*.txt' 00:45:14 INFO - no previously-included directories found matching 'build' 00:45:14 INFO - no previously-included directories found matching 'dist' 00:45:14 INFO - no previously-included directories found matching '.git*' 00:45:14 INFO - Installing collected packages: jsonschema, functools32 00:45:15 INFO - Running setup.py install for functools32 00:45:15 INFO - warning: no files found matching '*.txt' 00:45:15 INFO - no previously-included directories found matching 'build' 00:45:15 INFO - no previously-included directories found matching 'dist' 00:45:15 INFO - no previously-included directories found matching '.git*' 00:45:15 INFO - Successfully installed jsonschema functools32 00:45:15 INFO - Cleaning up... 00:45:15 INFO - Return code: 0 00:45:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:45: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')]} 00:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45: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')]} 00:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:15 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:15 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 00:45:15 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 00:45:15 INFO - Using env: {'DISPLAY': ':0', 00:45:15 INFO - 'HOME': '/home/cltbld', 00:45:15 INFO - 'LANG': 'en_US.UTF-8', 00:45:15 INFO - 'LANGUAGE': 'en_US:en', 00:45:15 INFO - 'LOGNAME': 'cltbld', 00:45:15 INFO - 'MAIL': '/var/mail/cltbld', 00:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:15 INFO - 'MOZ_NO_REMOTE': '1', 00:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:15 INFO - 'NO_EM_RESTART': '1', 00:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:15 INFO - 'PWD': '/builds/slave/test', 00:45:15 INFO - 'SHELL': '/bin/bash', 00:45:15 INFO - 'SHLVL': '1', 00:45:15 INFO - 'TERM': 'linux', 00:45:15 INFO - 'TMOUT': '86400', 00:45:15 INFO - 'USER': 'cltbld', 00:45:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:15 INFO - '_': '/tools/buildbot/bin/python'} 00:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:45:15 INFO - Cleaning up... 00:45:15 INFO - Return code: 0 00:45:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:45: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')]} 00:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45: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')]} 00:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:15 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:15 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 00:45:15 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 00:45:15 INFO - Using env: {'DISPLAY': ':0', 00:45:15 INFO - 'HOME': '/home/cltbld', 00:45:15 INFO - 'LANG': 'en_US.UTF-8', 00:45:15 INFO - 'LANGUAGE': 'en_US:en', 00:45:15 INFO - 'LOGNAME': 'cltbld', 00:45:15 INFO - 'MAIL': '/var/mail/cltbld', 00:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:15 INFO - 'MOZ_NO_REMOTE': '1', 00:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:15 INFO - 'NO_EM_RESTART': '1', 00:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:15 INFO - 'PWD': '/builds/slave/test', 00:45:15 INFO - 'SHELL': '/bin/bash', 00:45:15 INFO - 'SHLVL': '1', 00:45:15 INFO - 'TERM': 'linux', 00:45:15 INFO - 'TMOUT': '86400', 00:45:15 INFO - 'USER': 'cltbld', 00:45:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:15 INFO - '_': '/tools/buildbot/bin/python'} 00:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:15 INFO - Downloading/unpacking blobuploader==1.2.4 00:45:15 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 00:45:15 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 00:45:15 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 00:45:15 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 00:45:15 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 00:45:15 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 00:45:17 INFO - Downloading blobuploader-1.2.4.tar.gz 00:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:45:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:45:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 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 00:45:17 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 00:45:18 INFO - Downloading docopt-0.6.1.tar.gz 00:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:45:18 INFO - Installing collected packages: blobuploader, requests, docopt 00:45:18 INFO - Running setup.py install for blobuploader 00:45:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:45:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:45:18 INFO - Running setup.py install for requests 00:45:18 INFO - Running setup.py install for docopt 00:45:18 INFO - Successfully installed blobuploader requests docopt 00:45:18 INFO - Cleaning up... 00:45:18 INFO - Return code: 0 00:45:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:45: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')]} 00:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45: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')]} 00:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:18 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:18 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 00:45:18 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 00:45:18 INFO - Using env: {'DISPLAY': ':0', 00:45:18 INFO - 'HOME': '/home/cltbld', 00:45:18 INFO - 'LANG': 'en_US.UTF-8', 00:45:18 INFO - 'LANGUAGE': 'en_US:en', 00:45:18 INFO - 'LOGNAME': 'cltbld', 00:45:18 INFO - 'MAIL': '/var/mail/cltbld', 00:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:18 INFO - 'MOZ_NO_REMOTE': '1', 00:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:18 INFO - 'NO_EM_RESTART': '1', 00:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:18 INFO - 'PWD': '/builds/slave/test', 00:45:18 INFO - 'SHELL': '/bin/bash', 00:45:18 INFO - 'SHLVL': '1', 00:45:18 INFO - 'TERM': 'linux', 00:45:18 INFO - 'TMOUT': '86400', 00:45:18 INFO - 'USER': 'cltbld', 00:45:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:18 INFO - '_': '/tools/buildbot/bin/python'} 00:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:45:19 INFO - Running setup.py (path:/tmp/pip-ETjISS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:45:19 INFO - Running setup.py (path:/tmp/pip-O8nofS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:45:19 INFO - Running setup.py (path:/tmp/pip-VRLgA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:45:19 INFO - Running setup.py (path:/tmp/pip-kSVNlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:45:19 INFO - Running setup.py (path:/tmp/pip-owJJG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:45:19 INFO - Running setup.py (path:/tmp/pip-W8CVGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:45:19 INFO - Running setup.py (path:/tmp/pip-M97lgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:45:19 INFO - Running setup.py (path:/tmp/pip-XtYqfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:45:19 INFO - Running setup.py (path:/tmp/pip-07g40x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:45:19 INFO - Running setup.py (path:/tmp/pip-U2lYky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:45:19 INFO - Running setup.py (path:/tmp/pip-jxJWGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:45:19 INFO - Running setup.py (path:/tmp/pip-3vchRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:45:19 INFO - Running setup.py (path:/tmp/pip-YUFcVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:45:19 INFO - Running setup.py (path:/tmp/pip-yCxmaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:45:20 INFO - Running setup.py (path:/tmp/pip-VpUjbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:45:20 INFO - Running setup.py (path:/tmp/pip-1__VVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:45:20 INFO - Running setup.py (path:/tmp/pip-hWhHGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:45:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:45:20 INFO - Running setup.py install for manifestparser 00:45:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:45:20 INFO - Running setup.py install for mozcrash 00:45:20 INFO - Running setup.py install for mozdebug 00:45:20 INFO - Running setup.py install for mozdevice 00:45:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:45:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:45:20 INFO - Running setup.py install for mozfile 00:45:20 INFO - Running setup.py install for mozhttpd 00:45:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:45:20 INFO - Running setup.py install for mozinfo 00:45:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:45:20 INFO - Running setup.py install for mozInstall 00:45:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Running setup.py install for mozleak 00:45:21 INFO - Running setup.py install for mozlog 00:45:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Running setup.py install for moznetwork 00:45:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Running setup.py install for mozprocess 00:45:21 INFO - Running setup.py install for mozprofile 00:45:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Running setup.py install for mozrunner 00:45:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:45:21 INFO - Running setup.py install for mozscreenshot 00:45:21 INFO - Running setup.py install for moztest 00:45:21 INFO - Running setup.py install for mozversion 00:45:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:45:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:45:22 INFO - Cleaning up... 00:45:22 INFO - Return code: 0 00:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:22 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:22 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 00:45:22 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 00:45:22 INFO - Using env: {'DISPLAY': ':0', 00:45:22 INFO - 'HOME': '/home/cltbld', 00:45:22 INFO - 'LANG': 'en_US.UTF-8', 00:45:22 INFO - 'LANGUAGE': 'en_US:en', 00:45:22 INFO - 'LOGNAME': 'cltbld', 00:45:22 INFO - 'MAIL': '/var/mail/cltbld', 00:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:22 INFO - 'MOZ_NO_REMOTE': '1', 00:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:22 INFO - 'NO_EM_RESTART': '1', 00:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:22 INFO - 'PWD': '/builds/slave/test', 00:45:22 INFO - 'SHELL': '/bin/bash', 00:45:22 INFO - 'SHLVL': '1', 00:45:22 INFO - 'TERM': 'linux', 00:45:22 INFO - 'TMOUT': '86400', 00:45:22 INFO - 'USER': 'cltbld', 00:45:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:22 INFO - '_': '/tools/buildbot/bin/python'} 00:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:45:22 INFO - Running setup.py (path:/tmp/pip-5d0yp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:45:22 INFO - Running setup.py (path:/tmp/pip-vQPNsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:45:22 INFO - Running setup.py (path:/tmp/pip-Fu40dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:45:22 INFO - Running setup.py (path:/tmp/pip-GY6VKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:45:22 INFO - Running setup.py (path:/tmp/pip-YLxzhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:45:22 INFO - Running setup.py (path:/tmp/pip-CKKKbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:45:22 INFO - Running setup.py (path:/tmp/pip-mVxRAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:45:22 INFO - Running setup.py (path:/tmp/pip-XufJir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:45:22 INFO - Running setup.py (path:/tmp/pip-3jz3gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:45:22 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:45:22 INFO - Running setup.py (path:/tmp/pip-9nEJPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 00:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:45:22 INFO - Running setup.py (path:/tmp/pip-l8dkLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:45:23 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)) 00:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:45:23 INFO - Running setup.py (path:/tmp/pip-bgrFuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:45:23 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)) 00:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:45:23 INFO - Running setup.py (path:/tmp/pip-5MM581-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:45:23 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)) 00:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:45:23 INFO - Running setup.py (path:/tmp/pip-vMuMZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:45:23 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)) 00:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:45:23 INFO - Running setup.py (path:/tmp/pip-P_Y1zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:45:23 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)) 00:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:45:23 INFO - Running setup.py (path:/tmp/pip-uxJAmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:45:23 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)) 00:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:45:23 INFO - Running setup.py (path:/tmp/pip-k5Pap7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:45:23 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)) 00:45:23 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)) 00:45:23 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)) 00:45:23 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)) 00:45:23 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)) 00:45:23 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)) 00:45:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:45:25 INFO - Downloading blessings-1.6.tar.gz 00:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:45:25 INFO - Installing collected packages: blessings 00:45:25 INFO - Running setup.py install for blessings 00:45:25 INFO - Successfully installed blessings 00:45:25 INFO - Cleaning up... 00:45:25 INFO - Return code: 0 00:45:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:45:25 INFO - Reading from file tmpfile_stdout 00:45:25 INFO - Current package versions: 00:45:25 INFO - argparse == 1.2.1 00:45:25 INFO - blessings == 1.6 00:45:25 INFO - blobuploader == 1.2.4 00:45:25 INFO - docopt == 0.6.1 00:45:25 INFO - functools32 == 3.2.3-2 00:45:25 INFO - jsonschema == 2.5.1 00:45:25 INFO - manifestparser == 1.1 00:45:25 INFO - mozInstall == 1.12 00:45:25 INFO - mozcrash == 0.17 00:45:25 INFO - mozdebug == 0.1 00:45:25 INFO - mozdevice == 0.48 00:45:25 INFO - mozfile == 1.2 00:45:25 INFO - mozhttpd == 0.7 00:45:25 INFO - mozinfo == 0.9 00:45:25 INFO - mozleak == 0.1 00:45:25 INFO - mozlog == 3.3 00:45:25 INFO - moznetwork == 0.27 00:45:25 INFO - mozprocess == 0.23 00:45:25 INFO - mozprofile == 0.28 00:45:25 INFO - mozrunner == 6.12 00:45:25 INFO - mozscreenshot == 0.1 00:45:25 INFO - mozsystemmonitor == 0.3 00:45:25 INFO - moztest == 0.7 00:45:25 INFO - mozversion == 1.4 00:45:25 INFO - psutil == 3.1.1 00:45:25 INFO - requests == 1.2.3 00:45:25 INFO - wsgiref == 0.1.2 00:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:25 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:25 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 00:45:25 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 00:45:25 INFO - Using env: {'DISPLAY': ':0', 00:45:25 INFO - 'HOME': '/home/cltbld', 00:45:25 INFO - 'LANG': 'en_US.UTF-8', 00:45:25 INFO - 'LANGUAGE': 'en_US:en', 00:45:25 INFO - 'LOGNAME': 'cltbld', 00:45:25 INFO - 'MAIL': '/var/mail/cltbld', 00:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:25 INFO - 'MOZ_NO_REMOTE': '1', 00:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:25 INFO - 'NO_EM_RESTART': '1', 00:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:25 INFO - 'PWD': '/builds/slave/test', 00:45:25 INFO - 'SHELL': '/bin/bash', 00:45:25 INFO - 'SHLVL': '1', 00:45:25 INFO - 'TERM': 'linux', 00:45:25 INFO - 'TMOUT': '86400', 00:45:25 INFO - 'USER': 'cltbld', 00:45:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:25 INFO - '_': '/tools/buildbot/bin/python'} 00:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 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)) 00:45:26 INFO - Cleaning up... 00:45:26 INFO - Return code: 0 00:45:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:45:26 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')]} 00:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:26 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')]} 00:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:45:26 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 0x7f533f69ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', '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 00:45:26 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 00:45:26 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 00:45:26 INFO - Using env: {'DISPLAY': ':0', 00:45:26 INFO - 'HOME': '/home/cltbld', 00:45:26 INFO - 'LANG': 'en_US.UTF-8', 00:45:26 INFO - 'LANGUAGE': 'en_US:en', 00:45:26 INFO - 'LOGNAME': 'cltbld', 00:45:26 INFO - 'MAIL': '/var/mail/cltbld', 00:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:26 INFO - 'MOZ_NO_REMOTE': '1', 00:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:26 INFO - 'NO_EM_RESTART': '1', 00:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:26 INFO - 'PWD': '/builds/slave/test', 00:45:26 INFO - 'SHELL': '/bin/bash', 00:45:26 INFO - 'SHLVL': '1', 00:45:26 INFO - 'TERM': 'linux', 00:45:26 INFO - 'TMOUT': '86400', 00:45:26 INFO - 'USER': 'cltbld', 00:45:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:26 INFO - '_': '/tools/buildbot/bin/python'} 00:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:45:26 INFO - Cleaning up... 00:45:26 INFO - Return code: 0 00:45:26 INFO - Running post-action listener: _resource_record_post_action 00:45:26 INFO - Running post-action listener: _start_resource_monitoring 00:45:26 INFO - Starting resource monitoring. 00:45:26 INFO - [mozharness: 2016-08-26 07:45:26.330167Z] Finished create-virtualenv step (success) 00:45:26 INFO - [mozharness: 2016-08-26 07:45:26.330629Z] Running install step. 00:45:26 INFO - Running pre-action listener: _resource_record_pre_action 00:45:26 INFO - Running main action method: install 00:45:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:45:26 INFO - Reading from file tmpfile_stdout 00:45:26 INFO - Detecting whether we're running mozinstall >=1.0... 00:45:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:45:26 INFO - Reading from file tmpfile_stdout 00:45:26 INFO - Output received: 00:45:26 INFO - Usage: mozinstall [options] installer 00:45:26 INFO - Options: 00:45:26 INFO - -h, --help show this help message and exit 00:45:26 INFO - -d DEST, --destination=DEST 00:45:26 INFO - Directory to install application into. [default: 00:45:26 INFO - "/builds/slave/test"] 00:45:26 INFO - --app=APP Application being installed. [default: firefox] 00:45:26 INFO - mkdir: /builds/slave/test/build/application 00:45:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:45:42 INFO - Reading from file tmpfile_stdout 00:45:42 INFO - Output received: 00:45:42 INFO - /builds/slave/test/build/application/firefox/firefox 00:45:42 INFO - Running post-action listener: _resource_record_post_action 00:45:42 INFO - [mozharness: 2016-08-26 07:45:42.827411Z] Finished install step (success) 00:45:42 INFO - [mozharness: 2016-08-26 07:45:42.827694Z] Running run-tests step. 00:45:42 INFO - Running pre-action listener: _resource_record_pre_action 00:45:42 INFO - Running main action method: run_tests 00:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:45:42 INFO - Python 2.7.3 00:45:42 INFO - Return code: 0 00:45:42 INFO - grabbing minidump binary from tooltool 00:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:45:42 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 0x23f0090>, '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 0x23f39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f3e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:45:42 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 00:45:42 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 00:45:42 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 00:45:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:45:42 INFO - Return code: 0 00:45:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:45:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:45:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:45:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:45:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 00:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 00:45:42 INFO - Using env: {'DISPLAY': ':0', 00:45:42 INFO - 'HOME': '/home/cltbld', 00:45:42 INFO - 'LANG': 'en_US.UTF-8', 00:45:42 INFO - 'LANGUAGE': 'en_US:en', 00:45:42 INFO - 'LOGNAME': 'cltbld', 00:45:42 INFO - 'MAIL': '/var/mail/cltbld', 00:45:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:45:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:45:42 INFO - 'MOZ_NO_REMOTE': '1', 00:45:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:45:42 INFO - 'NO_EM_RESTART': '1', 00:45:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:45:42 INFO - 'PWD': '/builds/slave/test', 00:45:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:45:42 INFO - 'SHELL': '/bin/bash', 00:45:42 INFO - 'SHLVL': '1', 00:45:42 INFO - 'TERM': 'linux', 00:45:42 INFO - 'TMOUT': '86400', 00:45:42 INFO - 'USER': 'cltbld', 00:45:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869', 00:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:45:42 INFO - '_': '/tools/buildbot/bin/python'} 00:45:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 00:45:43 INFO - mozversion application_buildid: 20160825232217 00:45:43 INFO - mozversion application_changeset: bc6197438658404755876af9f71ccdf8f9c0aee9 00:45:43 INFO - mozversion application_display_name: Nightly 00:45:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:45:43 INFO - mozversion application_name: Firefox 00:45:43 INFO - mozversion application_remotingname: firefox 00:45:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:45:43 INFO - mozversion application_vendor: Mozilla 00:45:43 INFO - mozversion application_version: 51.0a1 00:45:43 INFO - mozversion platform_buildid: 20160825232217 00:45:43 INFO - mozversion platform_changeset: bc6197438658404755876af9f71ccdf8f9c0aee9 00:45:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:45:43 INFO - mozversion platform_version: 51.0a1 00:45:43 INFO - using testdate: 1472197543 00:45:43 INFO - actual date: 1472197543 00:45:43 INFO - starting webserver on 'localhost:38472' 00:45:43 INFO - SUITE-START | Running 2 tests 00:45:43 INFO - TEST-START | dromaeo_css 00:45:43 INFO - operating with platform_type : linux_ 00:45:43 INFO - Initialising browser for dromaeo_css test... 00:45:43 INFO - TEST-INFO | started process 5474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9CwJ_/profile http://localhost:38472/getInfo.html) 00:45:47 INFO - PROCESS | 5474 | __metrics Screen width/height:1600/1200 00:45:47 INFO - PROCESS | 5474 | colorDepth:24 00:45:47 INFO - PROCESS | 5474 | Browser inner width/height: 1024/697 00:45:47 INFO - PROCESS | 5474 | __metrics 00:45:47 INFO - PROCESS | 5474 | 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" 00:45:47 INFO - PROCESS | 5474 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:45:48 INFO - PROCESS | 5474 | console.error: PushService: 00:45:48 INFO - PROCESS | 5474 | stateChangeProcessEnqueue: Error transitioning state 00:45:48 INFO - PROCESS | 5474 | UnknownError 00:45:48 INFO - TEST-INFO | 5474: exit 0 00:45:48 INFO - Browser initialized. 00:45:48 INFO - Running cycle 1/1 for dromaeo_css test... 00:45:48 INFO - TEST-INFO | started process 5553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9CwJ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:46:01 INFO - PROCESS | 5553 | RSS: Main: 180473856 00:46:01 INFO - PROCESS | 5553 | 00:46:52 INFO - PROCESS | 5553 | 1472197612102 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] 00:49:05 INFO - PROCESS | 5553 | Cycle 1(1): loaded http://localhost:38472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38472/tests/dromaeo/cssquery-ext.html) 00:49:06 INFO - PROCESS | 5553 | RSS: Main: 279183360 00:49:06 INFO - PROCESS | 5553 | 00:52:08 INFO - PROCESS | 5553 | Cycle 1(1): loaded http://localhost:38472/tests/dromaeo/cssquery-ext.html (next: http://localhost:38472/tests/dromaeo/cssquery-jquery.html) 00:52:09 INFO - PROCESS | 5553 | RSS: Main: 273432576 00:52:09 INFO - PROCESS | 5553 | 00:55:11 INFO - PROCESS | 5553 | Cycle 1(1): loaded http://localhost:38472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38472/tests/dromaeo/cssquery-mootools.html) 00:55:12 INFO - PROCESS | 5553 | RSS: Main: 219320320 00:55:12 INFO - PROCESS | 5553 | 00:58:14 INFO - PROCESS | 5553 | Cycle 1(1): loaded http://localhost:38472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38472/tests/dromaeo/cssquery-prototype.html) 00:58:15 INFO - PROCESS | 5553 | RSS: Main: 271650816 00:58:15 INFO - PROCESS | 5553 | 01:01:18 INFO - PROCESS | 5553 | Cycle 1(1): loaded http://localhost:38472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38472/tests/dromaeo/cssquery-yui.html) 01:01:19 INFO - PROCESS | 5553 | RSS: Main: 219672576 01:01:19 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | Cycle 1(1): loaded http://localhost:38472/tests/dromaeo/cssquery-yui.html (next: http://localhost:38472/tests/dromaeo/cssquery-dojo.html) 01:04:22 INFO - PROCESS | 5553 | RSS: Main: 312369152 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | __start_tp_report 01:04:22 INFO - PROCESS | 5553 | _x_x_mozilla_page_load 01:04:22 INFO - PROCESS | 5553 | _x_x_mozilla_page_load_details 01:04:22 INFO - PROCESS | 5553 | |i|pagename|runs| 01:04:22 INFO - PROCESS | 5553 | |0;dojo.html;2581.148221087041;2592.6620167122123;2595.85722785247;2637.5516162252416;2650.628911952327;4502;4567.474740404855;4601.838935637254;4695.366125573047;4763.9523604763945;4564.155631208228;4606.654500912428;4609.147307748069;4615.446146462421;4624.653151013671;4212.936805947921;4233.407322974786;4261.190373828978;4308.46144231971;4324.200022995756;4281.250781113293;4308.181445525356;4340.500842403132;4356.564343565634;4413.44831896013;4271.273883439822;4363.847265345714;4376.606105450509;4385.166818304512;4442.089371678798;4374.103308821684;4400.669949753766;4405.625521830648;4430.778461076966;4435;4109.732867363612;4164.500259968823;4166.64583510402;4295.312749960022;4374.234508960951;4574.771261436915;4579.702319349265;4585.266357382803;4588.426446694163;4677.368555245032;4963.478834722338;4999.975000124976;5006.048850718352;5040.042391945555;5057.797688092472;5033.949660503385;5068.189089745623;5077.898442031175;5101.642884998052;5172.974135129338;4488.753118578509;4627.953720462752;4753.857384278477;4759.595434388081;4769.785359658824;5058.013687331008;5110.872228194325;5110.974445127825;5112.156494178494;5161.793528258902;4887;4905.852824415273;4911.214205727067;4932.53140951609;4963.503649635008;4748.8337908173735;4944.678595891328;4967.850964471072;4979.701217926936;4989.800407983713;4982.676126051795;5001.549860512571;5010.423801262828;5022.824201152942;5030.949690503121;4957.950420495749;4967.528084831935;4977.552020318189;4977.751112444435;5035.84892453227;4062.289099407651;4193.287141186006;4204.747715137101;4205.201011807808;4258.8296468140925;3650.79920604364;3691.667749902522;3713.1088538750505;3739.0652336915773;3815.5993620669983;4232.36514522824;4267.786610669454;4281.743095414286;4289.120730250291;4355.107203023436;4956.975215123901;4994.550490455804;5005.7997680092385;5008.29883816266;5011.824586139468;4130.401091841666;4254.7659878706345;4263.722858014219;4281.871543853689;4357.041450880801;4514.6614003949835;4515.571020753023;4531.13908357411;4535.727856328631;4589.059242855206;4700.717956922527;4704.6236301096515;4708.3643708100335;4710.26990816424;4769.642276829321;4817.975910120567;4996.100701873697;5050.722210278323;5084.339035925306;5142.6914385137015;4756.500567440369;4759.809607615656;4778;4778.713277203379;4848.5636292733825;4985.551300382983;5001.699898006132;5001.955435864156;5003.799848006184;5063.367079115111;4741.122892264942;4903.95096049035;4962.106820772151;4967.726775027409;5038.571721403721;4793.640476964172;4831.903361932812;4860.441049279378;4862.562369386772;4908.950910490992;4770.880727981689;4792.400949881265;4796.712197268175;4798.1123492154065;4860.027994401064;4621.075784843112;4790.113828941657;4835.854924352275;4861.124997500484;4921.803127874988;4897.069556784199;4970.080535101018;4977.9751101244265;4979.576735977337;5046.520580544842;4793.376861008047;4793.880152996064;4807.903841923212;4837.201861692782;4879.658423910292 01:04:22 INFO - PROCESS | 5553 | |1;ext.html;561.1190431023293;570.3725901508338;570.4210226619981;571.7112858006706;573.5755540899734;27859.721402785966;38074.42888356673;39247.60752392475;39431.40852887209;42719.78640106803;39548.60451395485;40142.59857401425;40156.59843401565;40158.397624035664;40197.79901100498;7465.328120469143;7612.352949999256;7615.238476152396;7616.847663046736;7621.23787621239;7623.313901748841;7710.57591832449;7714.691412343527;7716.4212684048925;7716.729914452995;7728.149903510609;7761.844763104735;7772.41706871984;7778.338841198477;7779;7689.423293253;7705.499142555716;7710.961445192795;7728.381729461629;7730.458867879251;7547.207543207939;7607.277308655669;7609.048868891388;7612.048493938258;7615.961920190419;37763.81118094419;38087.23825523474;38090.047748806224;38112.04719882025;38115.42826857599;3178.3802158579088;3194.520821876714;3245.3996010738088;3268.3626692794915;3281.4913688378338;28237.086000418138;28445.431091378057;28689.426211475864;29211.41577168466;29757.256068598243;3390.1524618845287;3420.9828950855085;3431.879884204066;3433.776804507724;3437.2781715839706;242423;243352;244423;244676.77661611757;244842;30885.69114308873;50772.74613626908;51206.48793512092;51233;51330.23004654933;31085.222869428446;32883;32930;33038;33090.66909330924;12301.815472767916;12354.876451235552;12378.504859805507;12379.814302785466;12382.442790074288;11451.599194028335;11620.244684095507;11621.07031437483;11629.88370116305;11631.709207269885;7700.768976930701;7733.265339792823;7768.7669369918995;7774.1837107104075;7792.259735325135;2971.524556071018;2997.925051873721;3023.516237402005;3058.2507285714696;3060.8622611982514;832.5088197963231;852.6461518469889;898.3307435960121;913.4701872913694;935.3826474526916;26387.472250555264;27213.86393068022;27509.17472475829;27571.586426203623;27757;826.5990994367727;908;936.2135805923058;986.5609803637456;1024.0680980307884;14008.509702160376;14453.78319325211;14495;14650.413983440756;14690.55928322152;352531;356021;356314;356743;356844;47577.76211118991;47886.92961098276;48005.51925490084;48069.75965120152;48083;1076.8492411062457;1141.7716456708692;1177.31127290536;1198.4187668980712;1206.3184300870155;26241.868790655924;27242.318942026606;27613.86193069022;28225.576616351183;28485.857570712844;40046.79976600215;40601.390979135926;40613;40616.11066395297;40650.593494064684;278099;278356;278497;278768;279247;24284.392890177885;25107;25145.748542514342;26332.21003369902;26471.205863824118;39322.6067739319;39746.40380394354;40402.59597403988;40568.79715601403;41066.1786764269;35149.8242508796;35226.47160292546;35283;35822.641773581934;36022;34492.31015379728;34558.82720586381;34761;34775.826120869235;34783.652163478044;33963.66036339605;34194;34938.82530587331;35228.647713522536;35259.64740352564;30268.697313026587;32130.518042229854;32233.35533289368;32266.35467290594;32283;24245.393865153514;24287.63568546438;24677.87661061755;24885.253442396755;25044.874775626005 01:04:22 INFO - PROCESS | 5553 | |2;jquery.html;331.98008119512843;355.4951968205148;362.1615959054788;362.16520919281055;381.2299155705475;12482.625521234355;15864.603384915368;16303.266353014113;16944.23750931208;18070.638587228248;16976.236069376875;17000.4049858255;17230.655386892253;17365.392211272607;17488.912555437237;4914.287428322891;4926.433460152075;5130.050940576006;5148.845534633967;5149.0474262261605;3623.9094022649515;5020.297158397809;5105.259737338084;5587.608867379285;5825.533957283428;5914.852128696774;5917.526597872182;5918.348981612019;5922.141289513018;5923.5853490255695;5175.689458632494;5436.945630543683;5460.26286451328;5466.207399926989;5908.350081491032;5249.212618107276;5253.86865328366;5254.500822421864;5266.0257852297445;5271.525562699376;11935.403229838561;12164.5134194633;12195.756084878341;12381.071419643562;12502;1854.341708693408;1857.600615867595;1884.481767513931;2087.1651339464183;2216.1467834883524;8702.608382622797;8772.692955746517;9265.536723163816;9336.67321643746;12258.570950016796;1593.5936336234302;1707.538964479596;1720.8623310135285;1723.319288880885;1727.4731206981864;61826;71799.64100179519;72084;72614.63692681503;72631.63684181598;9749.756256093513;9919.65281215154;9939.701808945743;10200.38797672142;10307.74230644225;13825.861741382658;13850.376733047036;13857.861421385858;13869.09850859691;13869.445222191;6811.352921472452;6991.510594258455;7026.086608740831;7255.673494692752;7258.782236532912;6580.144581204413;6730.629815360202;6781.62701051437;6801.387875091265;7115.679794409264;4194.203101410722;4286.914261714748;4298.140371925565;4430.800613972379;4445.422095127613;1787.6871547479138;1791.6237590106223;1803.1885651456896;1809.80092189859;1849.1031849552955;799.94400391972;812.7683610171073;883.0418995389946;883.6421249394006;933.1788026536605;16415.671686566202;16548.420805272;16750.329986800392;16985.660286794442;17541.736873946902;821.7837600351394;827.5696637748338;846.716350022737;860.1183786618766;884.964601415949;9123.77190570241;10263.692089237335;10490.790184196274;10500.369977801356;10649.627263045757;352701;357939;359120;360563;364132;80046.5997670008;80936.19063809287;81232.18767812246;81533.59233203914;82300;906.4878343735768;913.712180663089;934.6868798952427;942.6842007927421;943.5848226780332;15713.842861571238;15744.370225190863;16441.91779041097;16444.588885277964;16580.83419165841;33838.3232335347;34706;34984.650153498136;38112;38422.80788596039;49663.25505117499;49721;50540.49459505358;50644;50746;7418.703251870081;7602.96198519026;7765.922340776746;7776.455648104578;7877.487963282369;11839.763204735686;12249.081318901297;12356.876431235572;12750.872491274968;12981.286029268482;10081.69754907354;10634.361938283728;10792.892071079188;10833.67498975032;11058.889411105785;10540.472976350999;10619.628313009007;10651.786964260826;10767.676969690609;11220.38287894141;10141.949290253502;10684.679459616224;10763.784724305313;10803.945980270048;10934.45327733626;7508.211637778173;7658.73194438192;7703.061026511041;7794.415418843496;8073.19268073188;7764.262395072459;10334.276600637882;10855.620053298097;10937.507812148313;11137.164712646421 01:04:22 INFO - PROCESS | 5553 | |3;mootools.html;1229.538922903911;1335.8702582084793;1397.6170629077421;1443.6102252391854;1684.6209602839356;7533.811654708635;7853.37173026158;7889.842203155933;8158.224968627986;8167.305779008791;7980.800479988004;8093.352531797457;8099.838003239932;8099.878501822463;8101.675932962675;1795.6049669072784;2157.6439887418555;2167.1331467413042;2189.8467107302495;2192.5395666909967;2213.1589995801573;2224.065892325227;2224.555088982202;2226.4322597737555;2228.253535065755;2175.1516908405656;2190.6494960806276;2205.933821985335;2206.2278202629113;2221.0782525252002;2081.2195426714984;2151.6880052392394;2160.7839216078423;2162.0703097667997;2162.4701948022835;2185.4864106934856;2195.648696208615;2197.6703494475796;2201.3836125884777;2208.083645287204;8118.228768267005;8178.754637360829;8179.550124743137;8183.181681831828;8184.672613095469;4446.644268458548;4567.588916997486;4618.099470603233;4625.32932724753;4634.119517291738;2900.695426980179;2912.5485549739824;3051.4659934511374;3073.262417019899;3077.3999070181326;936.7517607833929;947.9004704505996;955.1546881010356;960.7886265021684;962.7448726087592;10707.571697132184;10809.891901081046;10817.891821081766;10818.513166907507;10831.025207731342;3980.641742243212;3984.641382275609;4146.564610715832;4152.563980781974;4155.210510003089;8394.874076888851;8466;8467.576621168917;8470.322374210049;8475.957620211859;4590.196715574761;4591.609713174351;4591.885202869888;4597.287420449836;4597.862064138081;3551.200979779529;4160.1471698301775;4227.281362168439;4268.061026574149;4284.057507348379;3296.3901678189613;3332.583427071616;3412.078738740576;3442.7762195457217;3446.965530344715;1022.9079382855579;1031.1029404418205;1044.0916402729522;1048.051513380392;1060.3849767135043;692.0795342194868;704.5103652961245;767.769669099268;831.995840020796;870.9085546017703;4878.414590249122;5092.6180536459915;5112.846614601568;5165.682750898497;5281;451.13157172442914;458.7614440490993;460.2245216809686;460.67292222522383;614.7848253111375;3509.298140371936;3581.6239294873662;3593.658602432765;3601.333753255656;3704.814759262026;9037.728868133967;9510.28672849539;9513.238940884712;9517.809643807224;9518.333716639769;9394.248460123174;9494.098060684224;9495.477748723886;9499.715008549754;9505;7119.679614417364;7182.030425892438;7210.531315464373;7212.819679508054;7256.963715181496;4935.337433684149;5143.485651434827;5150.381954165524;5293.629445938901;5328.6802791832615;8748.343874209588;8805.955970220364;8814.471131732116;8835.425697329652;8862.246709029805;8616.181462761027;8806;8837.602307896032;8895.4662720237;8988.86516702263;5768.567357448124;6143.293521245114;6229.626222426669;6239.594426362272;6293.307736149111;7583.127940286938;7747.883781743166;7750.341220996278;7803.765887023398;7808.960955195188;6824.829379265558;6878.621675807879;6907.896381554381;6993.160820701549;7042.50702450844;6808.183018037867;6892.586444813327;6894.827629309308;6907.6891539881835;6917.757878474229;6359.491240700825;6389.393007664265;6428.292887782433;6454.741810327722;6539.542232043711;4484.327350897261;4623.439951237596;4650.302454631697;4656.161890859677;4717.622590192707;4709.81160753566;4752.192127338291;4762.833300834593;4946.802127914843;4963.950360496348 01:04:22 INFO - PROCESS | 5553 | |4;prototype.html;278.84942131249124;299.66138263761945;301.5040258774316;302.3574903330423;307.1262258873505;4582.793774280157;4724.858254252378;4730.408698912636;4784.875554244754;4811.494793046732;4588.449386073676;4706.552877476643;4713.888833369968;4720.433547974248;4722.694114120121;3764.416515440111;3771.4531392948006;3779.1874746929407;3781.8109094545302;3788.4238717671974;3578.7494875358734;3630.8729194478196;3799.734018618698;3805.5813860475328;3805.7145714071416;3688.7417880748358;3715.238376132886;3729.8508059677715;3739.8691045813403;3753.51204343435;3725.3666876631037;3725.795081270529;3730.9067273318115;3740.4576336431064;3740.9625903740884;3276.459384201604;3308.139883630249;3327.800331980089;3332.5334453176574;3335.4163021471145;4425.247707889666;4570.840020599263;4584.633229341644;4648.86053418398;4672.74299913508;4212.831486740527;4219.746815191098;4219.852305169335;4245.766482843443;4260.488741351027;4929.260610908356;4934.914318849883;4939.3578834751615;4941.827036053757;4957.5042495750495;3324.2354258520677;3502.7390139549743;3615.927681446383;3621.9094522637147;3626.2747450510005;5118.155504341779;5125.589952803767;5145.22821576759;5149.176131818928;5155.551113221228;3585.659362360572;3588.551431071116;3591.3356029134693;3595.209054008114;3597.226596281812;3630.219502806909;3631.763935344194;3633.5458067741533;3637.836297366625;3640.3629364861044;3905.1408690088133;4109.178164367138;4120;4128.710990230655;4175.394567787654;4861.683990540603;4890;4913.336699545515;4946.3817022872145;4963;1193.5643490126042;1217.190568272107;1236.1594116001206;1244.8381710377773;1259.6221133659865;835.1815221083373;838.8238469921384;853.2406158518924;859.7791136586063;867.3624885708999;4384.632298558807;4389.410247953722;4395.1429471252795;4397.538258482878;4402.889927751832;5033.270175824485;5048.949510504922;5052.317937078521;5073.720945347967;5078.492150784892;4357.934630980474;4376.824927002948;4377.846775362847;4379.562043795595;4390.956090439118;2279.384566167159;2386.6658667786523;2390.8924098415264;2403.591389463795;2409.638554216862;4272.6154646082;4273.166732487197;4273.914521709548;4281.443412356436;4288.24955632763;4532.841350552781;4578.725276483422;4601.12578610063;4618.168729628699;4641.976790116028;4255.872193868628;4284.357346398066;4464.013513986245;4870.683405578555;4875.536824001714;5147.691138531551;5148.742562871917;5153.793848246178;5163.974180129076;5169;5064.265681476091;5073.264376665436;5086.567641750493;5094.7962081516325;5097.986295413365;4665.5567721066445;4825.927611085766;4847.151748444078;4863.659543831898;4874.122657921608;3627.3108109459117;3635.763675361093;3637.7813432500407;3639.872604458831;3641.380965235969;5076.82231121909;5109.77365432301;5124.692518448905;5132.358455193101;5143.819966301162;4770.212914869007;4797.544233297831;4998.400191976986;5001.42483614389;5012.147934851011;4951.638299467531;4961.429435614806;4961.70229786214;4976.303317535476;4985.302057711996;4860.313057261627;4938.802447902188;4945.530174633404;4949.7030178189425;4968.726720030433;4893.314935909047;4989.382697544252;5006.949930500648;5021.271915572149;5033.245013247895;4922.852314430573;4925.87207123472;4927.28554359623;4931.632816248292;4943.65394422387 01:04:22 INFO - PROCESS | 5553 | |5;yui.html;653.4445721137033;686.1320429656486;707.2114592229659;726.9745558905436;756.8458101395371;12898.74202515949;14196.219207943546;14212.644683882909;14363.784543231834;14961.326740296685;15063.322150503254;15340.232988350594;15445.768313475306;15451.381944722198;15453.690926181469;749.8725216713158;770.3144201660526;772.2702046565997;772.3975299266581;772.5673622771238;615.5967841064111;737.9926200738005;749.8387846613005;751.5227830327726;755.0976582983337;794.0986979777965;796.8087658961865;797.0515087046397;797.4457751862458;797.8683517219652;789.2226157235119;789.5657388436366;790.1742678900505;790.833924875771;791.1060501633146;467.621226806288;471.22718741264356;474.67010427752723;479.1877767184624;564.3425409398046;12280.140390172692;12928.03039772021;12949.158304710163;12956.287404192766;12971.092023558354;10829;11715.472803723853;11740.823887641693;11743.236689615147;12242.081843861746;11268.558354679051;11375.431228438545;11610.36143012134;11650.417479126094;11846.466908989116;3631.110377957391;3631.7094632429607;3641.635836416337;3658.835352409148;3693.963060369416;49944.50055499471;50021;50087.24869126966;50431.747841260556;50985.49014509882;9713.44584866418;9951.751206219902;10048.59805607782;10133.898661013443;10136.189104871593;16551.586210344838;16563.42028029013;17251.568710782332;19159.712604310946;19255.32606358799;6493.22081350241;6498;6663.20041595002;6698.196216453959;6803.183617965876;3658.158623516606;3756.549214094326;3762;3787;3899.259140763246;2823.4070845122756;2936.456755500239;2938.5004549226683;2940.8823647053878;2942.3085574889883;508.90330837140823;525.511274514705;530.4854291337397;534.4922323792413;558.3774091887516;539.8164624027771;545.3455852976444;551.6497024389541;554.7475898466188;562.6455333140095;8479.00743325318;8775.780605484913;8822.86765698515;8849.734507964771;8870.334724895529;599.7301214453513;611.9755209791648;626.4330780643525;629.1600713048041;633.6641579962627;4160.979195104005;4252.893677658083;4259.61663450291;4292.265240236105;4393.868183954486;58635;82928.58535707282;83705;86098;87129.56435217784;53276.60255288521;56077.43922560804;72211;92941;95081;45358;50174.74912625414;53052.73473632684;56071.719641401534;72009.63995179991;9079.818403632022;9091.945081679041;9232;9367.812643747224;9587.616495340108;45860.770696146305;46733.766331168124;48022.5197748032;48206;48299;60100;61215.69392153011;70725.29274707392;71539.64230178816;72333.638331808;11350.318980861175;11901.523939042687;12149;12245.87754122483;12590.307533085403;13521.661958451117;14026.789598155832;14036.613775658367;14120.43518259258;14189.503367382093;12252.75494490123;12410.75178496407;13166.210027398387;13515.932420337835;13622.86377136216;12261.75476490483;12517.248965062125;12858.549950752053;13088.149270297401;14019.649508762363;11821.645350639494;11822.586209482972;12082.577109801116;12289.1397602167;12412.62762117138;9299.209567186865;9978.750531236778;10131.54766621742;10461.738456538647;10565.577376905145;9161;10492.685219443429;10504;10527.315724477885;10565.683029509128 01:04:22 INFO - PROCESS | 5553 | __end_tp_report 01:04:22 INFO - PROCESS | 5553 | __start_cc_report 01:04:22 INFO - PROCESS | 5553 | _x_x_mozilla_cycle_collect,1010 01:04:22 INFO - PROCESS | 5553 | __end_cc_report 01:04:22 INFO - PROCESS | 5553 | __startTimestamp1472198662313__endTimestamp 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | ------- Summary: start ------- 01:04:22 INFO - PROCESS | 5553 | Number of tests: 6 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | [#0] dojo.html Cycles:165 Average:4620.60 Median:4763.95 stddev:488.20 (10.2%) stddev-sans-first:462.74 01:04:22 INFO - PROCESS | 5553 | Values: 2581.1 2592.7 2595.9 2637.6 2650.6 4502.0 4567.5 4601.8 4695.4 4764.0 4564.2 4606.7 4609.1 4615.4 4624.7 4212.9 4233.4 4261.2 4308.5 4324.2 4281.3 4308.2 4340.5 4356.6 4413.4 4271.3 4363.8 4376.6 4385.2 4442.1 4374.1 4400.7 4405.6 4430.8 4435.0 4109.7 4164.5 4166.6 4295.3 4374.2 4574.8 4579.7 4585.3 4588.4 4677.4 4963.5 5000.0 5006.0 5040.0 5057.8 5033.9 5068.2 5077.9 5101.6 5173.0 4488.8 4628.0 4753.9 4759.6 4769.8 5058.0 5110.9 5111.0 5112.2 5161.8 4887.0 4905.9 4911.2 4932.5 4963.5 4748.8 4944.7 4967.9 4979.7 4989.8 4982.7 5001.5 5010.4 5022.8 5030.9 4958.0 4967.5 4977.6 4977.8 5035.8 4062.3 4193.3 4204.7 4205.2 4258.8 3650.8 3691.7 3713.1 3739.1 3815.6 4232.4 4267.8 4281.7 4289.1 4355.1 4957.0 4994.6 5005.8 5008.3 5011.8 4130.4 4254.8 4263.7 4281.9 4357.0 4514.7 4515.6 4531.1 4535.7 4589.1 4700.7 4704.6 4708.4 4710.3 4769.6 4818.0 4996.1 5050.7 5084.3 5142.7 4756.5 4759.8 4778.0 4778.7 4848.6 4985.6 5001.7 5002.0 5003.8 5063.4 4741.1 4904.0 4962.1 4967.7 5038.6 4793.6 4831.9 4860.4 4862.6 4909.0 4770.9 4792.4 4796.7 4798.1 4860.0 4621.1 4790.1 4835.9 4861.1 4921.8 4897.1 4970.1 4978.0 4979.6 5046.5 4793.4 4793.9 4807.9 4837.2 4879.7 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | [#1] ext.html Cycles:180 Average:43622.40 Median:35044.32 stddev:77977.38 (222.5%) stddev-sans-first:78129.10 01:04:22 INFO - PROCESS | 5553 | Values: 561.1 570.4 570.4 571.7 573.6 27859.7 38074.4 39247.6 39431.4 42719.8 39548.6 40142.6 40156.6 40158.4 40197.8 7465.3 7612.4 7615.2 7616.8 7621.2 7623.3 7710.6 7714.7 7716.4 7716.7 7728.1 7761.8 7772.4 7778.3 7779.0 7689.4 7705.5 7711.0 7728.4 7730.5 7547.2 7607.3 7609.0 7612.0 7616.0 37763.8 38087.2 38090.0 38112.0 38115.4 3178.4 3194.5 3245.4 3268.4 3281.5 28237.1 28445.4 28689.4 29211.4 29757.3 3390.2 3421.0 3431.9 3433.8 3437.3 242423.0 243352.0 244423.0 244676.8 244842.0 30885.7 50772.7 51206.5 51233.0 51330.2 31085.2 32883.0 32930.0 33038.0 33090.7 12301.8 12354.9 12378.5 12379.8 12382.4 11451.6 11620.2 11621.1 11629.9 11631.7 7700.8 7733.3 7768.8 7774.2 7792.3 2971.5 2997.9 3023.5 3058.3 3060.9 832.5 852.6 898.3 913.5 935.4 26387.5 27213.9 27509.2 27571.6 27757.0 826.6 908.0 936.2 986.6 1024.1 14008.5 14453.8 14495.0 14650.4 14690.6 352531.0 356021.0 356314.0 356743.0 356844.0 47577.8 47886.9 48005.5 48069.8 48083.0 1076.8 1141.8 1177.3 1198.4 1206.3 26241.9 27242.3 27613.9 28225.6 28485.9 40046.8 40601.4 40613.0 40616.1 40650.6 278099.0 278356.0 278497.0 278768.0 279247.0 24284.4 25107.0 25145.7 26332.2 26471.2 39322.6 39746.4 40402.6 40568.8 41066.2 35149.8 35226.5 35283.0 35822.6 36022.0 34492.3 34558.8 34761.0 34775.8 34783.7 33963.7 34194.0 34938.8 35228.6 35259.6 30268.7 32130.5 32233.4 32266.4 32283.0 24245.4 24287.6 24677.9 24885.3 25044.9 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | [#2] jquery.html Cycles:180 Average:23398.68 Median:38267.40 stddev:59610.22 (155.8%) stddev-sans-first:59752.28 01:04:22 INFO - PROCESS | 5553 | Values: 332.0 355.5 362.2 362.2 381.2 12482.6 15864.6 16303.3 16944.2 18070.6 16976.2 17000.4 17230.7 17365.4 17488.9 4914.3 4926.4 5130.1 5148.8 5149.0 3623.9 5020.3 5105.3 5587.6 5825.5 5914.9 5917.5 5918.3 5922.1 5923.6 5175.7 5436.9 5460.3 5466.2 5908.4 5249.2 5253.9 5254.5 5266.0 5271.5 11935.4 12164.5 12195.8 12381.1 12502.0 1854.3 1857.6 1884.5 2087.2 2216.1 8702.6 8772.7 9265.5 9336.7 12258.6 1593.6 1707.5 1720.9 1723.3 1727.5 61826.0 71799.6 72084.0 72614.6 72631.6 9749.8 9919.7 9939.7 10200.4 10307.7 13825.9 13850.4 13857.9 13869.1 13869.4 6811.4 6991.5 7026.1 7255.7 7258.8 6580.1 6730.6 6781.6 6801.4 7115.7 4194.2 4286.9 4298.1 4430.8 4445.4 1787.7 1791.6 1803.2 1809.8 1849.1 799.9 812.8 883.0 883.6 933.2 16415.7 16548.4 16750.3 16985.7 17541.7 821.8 827.6 846.7 860.1 885.0 9123.8 10263.7 10490.8 10500.4 10649.6 352701.0 357939.0 359120.0 360563.0 364132.0 80046.6 80936.2 81232.2 81533.6 82300.0 906.5 913.7 934.7 942.7 943.6 15713.8 15744.4 16441.9 16444.6 16580.8 33838.3 34706.0 34984.7 38112.0 38422.8 49663.3 49721.0 50540.5 50644.0 50746.0 7418.7 7603.0 7765.9 7776.5 7877.5 11839.8 12249.1 12356.9 12750.9 12981.3 10081.7 10634.4 10792.9 10833.7 11058.9 10540.5 10619.6 10651.8 10767.7 11220.4 10141.9 10684.7 10763.8 10803.9 10934.5 7508.2 7658.7 7703.1 7794.4 8073.2 7764.3 10334.3 10855.6 10937.5 11137.2 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | [#3] mootools.html Cycles:180 Average:5107.92 Median:5028.28 stddev:2890.39 (57.5%) stddev-sans-first:2883.80 01:04:22 INFO - PROCESS | 5553 | Values: 1229.5 1335.9 1397.6 1443.6 1684.6 7533.8 7853.4 7889.8 8158.2 8167.3 7980.8 8093.4 8099.8 8099.9 8101.7 1795.6 2157.6 2167.1 2189.8 2192.5 2213.2 2224.1 2224.6 2226.4 2228.3 2175.2 2190.6 2205.9 2206.2 2221.1 2081.2 2151.7 2160.8 2162.1 2162.5 2185.5 2195.6 2197.7 2201.4 2208.1 8118.2 8178.8 8179.6 8183.2 8184.7 4446.6 4567.6 4618.1 4625.3 4634.1 2900.7 2912.5 3051.5 3073.3 3077.4 936.8 947.9 955.2 960.8 962.7 10707.6 10809.9 10817.9 10818.5 10831.0 3980.6 3984.6 4146.6 4152.6 4155.2 8394.9 8466.0 8467.6 8470.3 8476.0 4590.2 4591.6 4591.9 4597.3 4597.9 3551.2 4160.1 4227.3 4268.1 4284.1 3296.4 3332.6 3412.1 3442.8 3447.0 1022.9 1031.1 1044.1 1048.1 1060.4 692.1 704.5 767.8 832.0 870.9 4878.4 5092.6 5112.8 5165.7 5281.0 451.1 458.8 460.2 460.7 614.8 3509.3 3581.6 3593.7 3601.3 3704.8 9037.7 9510.3 9513.2 9517.8 9518.3 9394.2 9494.1 9495.5 9499.7 9505.0 7119.7 7182.0 7210.5 7212.8 7257.0 4935.3 5143.5 5150.4 5293.6 5328.7 8748.3 8806.0 8814.5 8835.4 8862.2 8616.2 8806.0 8837.6 8895.5 8988.9 5768.6 6143.3 6229.6 6239.6 6293.3 7583.1 7747.9 7750.3 7803.8 7809.0 6824.8 6878.6 6907.9 6993.2 7042.5 6808.2 6892.6 6894.8 6907.7 6917.8 6359.5 6389.4 6428.3 6454.7 6539.5 4484.3 4623.4 4650.3 4656.2 4717.6 4709.8 4752.2 4762.8 4946.8 4964.0 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | [#4] prototype.html Cycles:180 Average:4080.53 Median:4574.78 stddev:1190.35 (26.0%) stddev-sans-first:1158.99 01:04:22 INFO - PROCESS | 5553 | Values: 278.8 299.7 301.5 302.4 307.1 4582.8 4724.9 4730.4 4784.9 4811.5 4588.4 4706.6 4713.9 4720.4 4722.7 3764.4 3771.5 3779.2 3781.8 3788.4 3578.7 3630.9 3799.7 3805.6 3805.7 3688.7 3715.2 3729.9 3739.9 3753.5 3725.4 3725.8 3730.9 3740.5 3741.0 3276.5 3308.1 3327.8 3332.5 3335.4 4425.2 4570.8 4584.6 4648.9 4672.7 4212.8 4219.7 4219.9 4245.8 4260.5 4929.3 4934.9 4939.4 4941.8 4957.5 3324.2 3502.7 3615.9 3621.9 3626.3 5118.2 5125.6 5145.2 5149.2 5155.6 3585.7 3588.6 3591.3 3595.2 3597.2 3630.2 3631.8 3633.5 3637.8 3640.4 3905.1 4109.2 4120.0 4128.7 4175.4 4861.7 4890.0 4913.3 4946.4 4963.0 1193.6 1217.2 1236.2 1244.8 1259.6 835.2 838.8 853.2 859.8 867.4 4384.6 4389.4 4395.1 4397.5 4402.9 5033.3 5048.9 5052.3 5073.7 5078.5 4357.9 4376.8 4377.8 4379.6 4391.0 2279.4 2386.7 2390.9 2403.6 2409.6 4272.6 4273.2 4273.9 4281.4 4288.2 4532.8 4578.7 4601.1 4618.2 4642.0 4255.9 4284.4 4464.0 4870.7 4875.5 5147.7 5148.7 5153.8 5164.0 5169.0 5064.3 5073.3 5086.6 5094.8 5098.0 4665.6 4825.9 4847.2 4863.7 4874.1 3627.3 3635.8 3637.8 3639.9 3641.4 5076.8 5109.8 5124.7 5132.4 5143.8 4770.2 4797.5 4998.4 5001.4 5012.1 4951.6 4961.4 4961.7 4976.3 4985.3 4860.3 4938.8 4945.5 4949.7 4968.7 4893.3 4989.4 5006.9 5021.3 5033.2 4922.9 4925.9 4927.3 4931.6 4943.7 01:04:22 INFO - PROCESS | 5553 | 01:04:22 INFO - PROCESS | 5553 | [#5] yui.html Cycles:180 Average:16576.30 Median:476.93 stddev:22044.32 (4622.1%) stddev-sans-first:22073.74 01:04:22 INFO - PROCESS | 5553 | Values: 653.4 686.1 707.2 727.0 756.8 12898.7 14196.2 14212.6 14363.8 14961.3 15063.3 15340.2 15445.8 15451.4 15453.7 749.9 770.3 772.3 772.4 772.6 615.6 738.0 749.8 751.5 755.1 794.1 796.8 797.1 797.4 797.9 789.2 789.6 790.2 790.8 791.1 467.6 471.2 474.7 479.2 564.3 12280.1 12928.0 12949.2 12956.3 12971.1 10829.0 11715.5 11740.8 11743.2 12242.1 11268.6 11375.4 11610.4 11650.4 11846.5 3631.1 3631.7 3641.6 3658.8 3694.0 49944.5 50021.0 50087.2 50431.7 50985.5 9713.4 9951.8 10048.6 10133.9 10136.2 16551.6 16563.4 17251.6 19159.7 19255.3 6493.2 6498.0 6663.2 6698.2 6803.2 3658.2 3756.5 3762.0 3787.0 3899.3 2823.4 2936.5 2938.5 2940.9 2942.3 508.9 525.5 530.5 534.5 558.4 539.8 545.3 551.6 554.7 562.6 8479.0 8775.8 8822.9 8849.7 8870.3 599.7 612.0 626.4 629.2 633.7 4161.0 4252.9 4259.6 4292.3 4393.9 58635.0 82928.6 83705.0 86098.0 87129.6 53276.6 56077.4 72211.0 92941.0 95081.0 45358.0 50174.7 53052.7 56071.7 72009.6 9079.8 9091.9 9232.0 9367.8 9587.6 45860.8 46733.8 48022.5 48206.0 48299.0 60100.0 61215.7 70725.3 71539.6 72333.6 11350.3 11901.5 12149.0 12245.9 12590.3 13521.7 14026.8 14036.6 14120.4 14189.5 12252.8 12410.8 13166.2 13515.9 13622.9 12261.8 12517.2 12858.5 13088.1 14019.6 11821.6 11822.6 12082.6 12289.1 12412.6 9299.2 9978.8 10131.5 10461.7 10565.6 9161.0 10492.7 10504.0 10527.3 10565.7 01:04:22 INFO - PROCESS | 5553 | -------- Summary: end -------- 01:04:22 INFO - PROCESS | 5553 | 01:04:23 INFO - TEST-INFO | 5553: exit 0 01:04:23 INFO - TEST-OK | dromaeo_css | took 1120165ms 01:04:23 INFO - TEST-START | kraken 01:04:23 INFO - operating with platform_type : linux_ 01:04:23 INFO - Initialising browser for kraken test... 01:04:23 INFO - TEST-INFO | started process 5859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF0t5I4/profile http://localhost:38472/getInfo.html) 01:04:27 INFO - PROCESS | 5859 | __metrics Screen width/height:1600/1200 01:04:27 INFO - PROCESS | 5859 | colorDepth:24 01:04:27 INFO - PROCESS | 5859 | Browser inner width/height: 1024/697 01:04:27 INFO - PROCESS | 5859 | __metrics 01:04:27 INFO - PROCESS | 5859 | 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" 01:04:27 INFO - PROCESS | 5859 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:04:28 INFO - PROCESS | 5859 | console.error: PushService: 01:04:28 INFO - PROCESS | 5859 | stateChangeProcessEnqueue: Error transitioning state 01:04:28 INFO - PROCESS | 5859 | UnknownError 01:04:29 INFO - TEST-INFO | 5859: exit 0 01:04:29 INFO - Browser initialized. 01:04:29 INFO - Running cycle 1/1 for kraken test... 01:04:29 INFO - TEST-INFO | started process 5941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF0t5I4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:04:41 INFO - PROCESS | 5941 | RSS: Main: 180477952 01:04:41 INFO - PROCESS | 5941 | 01:04:44 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38472/tests/kraken/driver.html?testName=audio-beat-detection) 01:04:45 INFO - PROCESS | 5941 | RSS: Main: 238772224 01:04:45 INFO - PROCESS | 5941 | 01:04:47 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38472/tests/kraken/driver.html?testName=audio-dft) 01:04:48 INFO - PROCESS | 5941 | RSS: Main: 224690176 01:04:48 INFO - PROCESS | 5941 | 01:04:51 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38472/tests/kraken/driver.html?testName=audio-fft) 01:04:52 INFO - PROCESS | 5941 | RSS: Main: 303882240 01:04:52 INFO - PROCESS | 5941 | 01:04:54 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38472/tests/kraken/driver.html?testName=audio-oscillator) 01:04:55 INFO - PROCESS | 5941 | RSS: Main: 212684800 01:04:55 INFO - PROCESS | 5941 | 01:04:57 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:04:57 INFO - PROCESS | 5941 | RSS: Main: 215965696 01:04:57 INFO - PROCESS | 5941 | 01:05:01 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38472/tests/kraken/driver.html?testName=imaging-darkroom) 01:05:01 INFO - PROCESS | 5941 | RSS: Main: 255774720 01:05:01 INFO - PROCESS | 5941 | 01:05:05 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38472/tests/kraken/driver.html?testName=imaging-desaturate) 01:05:05 INFO - PROCESS | 5941 | RSS: Main: 249450496 01:05:05 INFO - PROCESS | 5941 | 01:05:08 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38472/tests/kraken/driver.html?testName=json-parse-financial) 01:05:09 INFO - PROCESS | 5941 | RSS: Main: 252751872 01:05:09 INFO - PROCESS | 5941 | 01:05:11 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:05:11 INFO - PROCESS | 5941 | RSS: Main: 216170496 01:05:11 INFO - PROCESS | 5941 | 01:05:13 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:05:14 INFO - PROCESS | 5941 | RSS: Main: 223989760 01:05:14 INFO - PROCESS | 5941 | 01:05:16 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:05:17 INFO - PROCESS | 5941 | RSS: Main: 222982144 01:05:17 INFO - PROCESS | 5941 | 01:05:19 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:05:20 INFO - PROCESS | 5941 | RSS: Main: 223535104 01:05:20 INFO - PROCESS | 5941 | 01:05:23 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:05:24 INFO - PROCESS | 5941 | RSS: Main: 221503488 01:05:24 INFO - PROCESS | 5941 | 01:05:25 INFO - PROCESS | 5941 | Cycle 1(1): loaded http://localhost:38472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38472/tests/kraken/driver.html?testName=ai-astar) 01:05:26 INFO - PROCESS | 5941 | RSS: Main: 272179200 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | __start_tp_report 01:05:26 INFO - PROCESS | 5941 | _x_x_mozilla_page_load 01:05:26 INFO - PROCESS | 5941 | _x_x_mozilla_page_load_details 01:05:26 INFO - PROCESS | 5941 | |i|pagename|runs| 01:05:26 INFO - PROCESS | 5941 | |0;ai-astar;114;116;130;116;115;117;115;114;115;115 01:05:26 INFO - PROCESS | 5941 | |1;audio-beat-detection;154;129;152;180;122;157;145;126;178;127 01:05:26 INFO - PROCESS | 5941 | |2;audio-dft;164;163;163;160;164;162;162;163;161;162 01:05:26 INFO - PROCESS | 5941 | |3;audio-fft;75;76;77;161;77;77;75;76;164;77 01:05:26 INFO - PROCESS | 5941 | |4;audio-oscillator;83;83;144;84;83;83;141;83;83;150 01:05:26 INFO - PROCESS | 5941 | |5;imaging-gaussian-blur;117;117;117;116;116;116;118;117;117;117 01:05:26 INFO - PROCESS | 5941 | |6;imaging-darkroom;149;148;147;145;147;145;146;146;147;146 01:05:26 INFO - PROCESS | 5941 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 01:05:26 INFO - PROCESS | 5941 | |8;json-parse-financial;65;63;64;65;62;66;64;64;64;63 01:05:26 INFO - PROCESS | 5941 | |9;json-stringify-tinderbox;65;66;65;65;65;64;64;66;66;66 01:05:26 INFO - PROCESS | 5941 | |10;stanford-crypto-aes;92;82;91;83;85;83;98;82;84;92 01:05:26 INFO - PROCESS | 5941 | |11;stanford-crypto-ccm;154;132;129;132;129;130;133;140;175;144 01:05:26 INFO - PROCESS | 5941 | |12;stanford-crypto-pbkdf2;182;176;179;175;175;178;176;173;179;175 01:05:26 INFO - PROCESS | 5941 | |13;stanford-crypto-sha256-iterative;69;73;70;73;68;69;69;69;68;68 01:05:26 INFO - PROCESS | 5941 | __end_tp_report 01:05:26 INFO - PROCESS | 5941 | __start_cc_report 01:05:26 INFO - PROCESS | 5941 | _x_x_mozilla_cycle_collect,1982 01:05:26 INFO - PROCESS | 5941 | __end_cc_report 01:05:26 INFO - PROCESS | 5941 | __startTimestamp1472198726142__endTimestamp 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | ------- Summary: start ------- 01:05:26 INFO - PROCESS | 5941 | Number of tests: 14 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#0] ai-astar Cycles:10 Average:116.70 Median:115.50 stddev:4.76 (4.1%) stddev-sans-first:4.95 01:05:26 INFO - PROCESS | 5941 | Values: 114.0 116.0 130.0 116.0 115.0 117.0 115.0 114.0 115.0 115.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:153.00 stddev:21.13 (13.8%) stddev-sans-first:22.26 01:05:26 INFO - PROCESS | 5941 | Values: 154.0 129.0 152.0 180.0 122.0 157.0 145.0 126.0 178.0 127.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 01:05:26 INFO - PROCESS | 5941 | Values: 164.0 163.0 163.0 160.0 164.0 162.0 162.0 163.0 161.0 162.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:36.38 (47.6%) stddev-sans-first:37.97 01:05:26 INFO - PROCESS | 5941 | Values: 75.0 76.0 77.0 161.0 77.0 77.0 75.0 76.0 164.0 77.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.00 stddev:29.96 (36.1%) stddev-sans-first:31.00 01:05:26 INFO - PROCESS | 5941 | Values: 83.0 83.0 144.0 84.0 83.0 83.0 141.0 83.0 83.0 150.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 01:05:26 INFO - PROCESS | 5941 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 118.0 117.0 117.0 117.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.26 (0.9%) stddev-sans-first:1.00 01:05:26 INFO - PROCESS | 5941 | Values: 149.0 148.0 147.0 145.0 147.0 145.0 146.0 146.0 147.0 146.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:05:26 INFO - PROCESS | 5941 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 01:05:26 INFO - PROCESS | 5941 | Values: 65.0 63.0 64.0 65.0 62.0 66.0 64.0 64.0 64.0 63.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 01:05:26 INFO - PROCESS | 5941 | Values: 65.0 66.0 65.0 65.0 65.0 64.0 64.0 66.0 66.0 66.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:88.00 stddev:5.59 (6.4%) stddev-sans-first:5.66 01:05:26 INFO - PROCESS | 5941 | Values: 92.0 82.0 91.0 83.0 85.0 83.0 98.0 82.0 84.0 92.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:136.50 stddev:14.74 (10.8%) stddev-sans-first:14.71 01:05:26 INFO - PROCESS | 5941 | Values: 154.0 132.0 129.0 132.0 129.0 130.0 133.0 140.0 175.0 144.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:2.66 (1.5%) stddev-sans-first:2.05 01:05:26 INFO - PROCESS | 5941 | Values: 182.0 176.0 179.0 175.0 175.0 178.0 176.0 173.0 179.0 175.0 01:05:26 INFO - PROCESS | 5941 | 01:05:26 INFO - PROCESS | 5941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:1.90 (2.7%) stddev-sans-first:2.00 01:05:26 INFO - PROCESS | 5941 | Values: 69.0 73.0 70.0 73.0 68.0 69.0 69.0 69.0 68.0 68.0 01:05:26 INFO - PROCESS | 5941 | -------- Summary: end -------- 01:05:26 INFO - PROCESS | 5941 | 01:05:27 INFO - TEST-INFO | 5941: exit 0 01:05:27 INFO - TEST-OK | kraken | took 64156ms 01:05:27 INFO - SUITE-END | took 1184s 01:05:27 INFO - Completed test suite (00:19:44) 01:05:27 INFO - javascript benchmark 01:05:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.148221087041, 2592.6620167122123, 2595.85722785247, 2637.5516162252416, 2650.628911952327, 4502.0, 4567.474740404855, 4601.838935637254, 4695.366125573047, 4763.9523604763945, 4564.155631208228, 4606.654500912428, 4609.147307748069, 4615.446146462421, 4624.653151013671, 4212.936805947921, 4233.407322974786, 4261.190373828978, 4308.46144231971, 4324.200022995756, 4281.250781113293, 4308.181445525356, 4340.500842403132, 4356.564343565634, 4413.44831896013, 4271.273883439822, 4363.847265345714, 4376.606105450509, 4385.166818304512, 4442.089371678798, 4374.103308821684, 4400.669949753766, 4405.625521830648, 4430.778461076966, 4435.0, 4109.732867363612, 4164.500259968823, 4166.64583510402, 4295.312749960022, 4374.234508960951, 4574.771261436915, 4579.702319349265, 4585.266357382803, 4588.426446694163, 4677.368555245032, 4963.478834722338, 4999.975000124976, 5006.048850718352, 5040.042391945555, 5057.797688092472, 5033.949660503385, 5068.189089745623, 5077.898442031175, 5101.642884998052, 5172.974135129338, 4488.753118578509, 4627.953720462752, 4753.857384278477, 4759.595434388081, 4769.785359658824, 5058.013687331008, 5110.872228194325, 5110.974445127825, 5112.156494178494, 5161.793528258902, 4887.0, 4905.852824415273, 4911.214205727067, 4932.53140951609, 4963.503649635008, 4748.8337908173735, 4944.678595891328, 4967.850964471072, 4979.701217926936, 4989.800407983713, 4982.676126051795, 5001.549860512571, 5010.423801262828, 5022.824201152942, 5030.949690503121, 4957.950420495749, 4967.528084831935, 4977.552020318189, 4977.751112444435, 5035.84892453227, 4062.289099407651, 4193.287141186006, 4204.747715137101, 4205.201011807808, 4258.8296468140925, 3650.79920604364, 3691.667749902522, 3713.1088538750505, 3739.0652336915773, 3815.5993620669983, 4232.36514522824, 4267.786610669454, 4281.743095414286, 4289.120730250291, 4355.107203023436, 4956.975215123901, 4994.550490455804, 5005.7997680092385, 5008.29883816266, 5011.824586139468, 4130.401091841666, 4254.7659878706345, 4263.722858014219, 4281.871543853689, 4357.041450880801, 4514.6614003949835, 4515.571020753023, 4531.13908357411, 4535.727856328631, 4589.059242855206, 4700.717956922527, 4704.6236301096515, 4708.3643708100335, 4710.26990816424, 4769.642276829321, 4817.975910120567, 4996.100701873697, 5050.722210278323, 5084.339035925306, 5142.6914385137015, 4756.500567440369, 4759.809607615656, 4778.0, 4778.713277203379, 4848.5636292733825, 4985.551300382983, 5001.699898006132, 5001.955435864156, 5003.799848006184, 5063.367079115111, 4741.122892264942, 4903.95096049035, 4962.106820772151, 4967.726775027409, 5038.571721403721, 4793.640476964172, 4831.903361932812, 4860.441049279378, 4862.562369386772, 4908.950910490992, 4770.880727981689, 4792.400949881265, 4796.712197268175, 4798.1123492154065, 4860.027994401064, 4621.075784843112, 4790.113828941657, 4835.854924352275, 4861.124997500484, 4921.803127874988, 4897.069556784199, 4970.080535101018, 4977.9751101244265, 4979.576735977337, 5046.520580544842, 4793.376861008047, 4793.880152996064, 4807.903841923212, 4837.201861692782, 4879.658423910292], "value": 4589.427750641952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1190431023293, 570.3725901508338, 570.4210226619981, 571.7112858006706, 573.5755540899734, 27859.721402785966, 38074.42888356673, 39247.60752392475, 39431.40852887209, 42719.78640106803, 39548.60451395485, 40142.59857401425, 40156.59843401565, 40158.397624035664, 40197.79901100498, 7465.328120469143, 7612.352949999256, 7615.238476152396, 7616.847663046736, 7621.23787621239, 7623.313901748841, 7710.57591832449, 7714.691412343527, 7716.4212684048925, 7716.729914452995, 7728.149903510609, 7761.844763104735, 7772.41706871984, 7778.338841198477, 7779.0, 7689.423293253, 7705.499142555716, 7710.961445192795, 7728.381729461629, 7730.458867879251, 7547.207543207939, 7607.277308655669, 7609.048868891388, 7612.048493938258, 7615.961920190419, 37763.81118094419, 38087.23825523474, 38090.047748806224, 38112.04719882025, 38115.42826857599, 3178.3802158579088, 3194.520821876714, 3245.3996010738088, 3268.3626692794915, 3281.4913688378338, 28237.086000418138, 28445.431091378057, 28689.426211475864, 29211.41577168466, 29757.256068598243, 3390.1524618845287, 3420.9828950855085, 3431.879884204066, 3433.776804507724, 3437.2781715839706, 242423.0, 243352.0, 244423.0, 244676.77661611757, 244842.0, 30885.69114308873, 50772.74613626908, 51206.48793512092, 51233.0, 51330.23004654933, 31085.222869428446, 32883.0, 32930.0, 33038.0, 33090.66909330924, 12301.815472767916, 12354.876451235552, 12378.504859805507, 12379.814302785466, 12382.442790074288, 11451.599194028335, 11620.244684095507, 11621.07031437483, 11629.88370116305, 11631.709207269885, 7700.768976930701, 7733.265339792823, 7768.7669369918995, 7774.1837107104075, 7792.259735325135, 2971.524556071018, 2997.925051873721, 3023.516237402005, 3058.2507285714696, 3060.8622611982514, 832.5088197963231, 852.6461518469889, 898.3307435960121, 913.4701872913694, 935.3826474526916, 26387.472250555264, 27213.86393068022, 27509.17472475829, 27571.586426203623, 27757.0, 826.5990994367727, 908.0, 936.2135805923058, 986.5609803637456, 1024.0680980307884, 14008.509702160376, 14453.78319325211, 14495.0, 14650.413983440756, 14690.55928322152, 352531.0, 356021.0, 356314.0, 356743.0, 356844.0, 47577.76211118991, 47886.92961098276, 48005.51925490084, 48069.75965120152, 48083.0, 1076.8492411062457, 1141.7716456708692, 1177.31127290536, 1198.4187668980712, 1206.3184300870155, 26241.868790655924, 27242.318942026606, 27613.86193069022, 28225.576616351183, 28485.857570712844, 40046.79976600215, 40601.390979135926, 40613.0, 40616.11066395297, 40650.593494064684, 278099.0, 278356.0, 278497.0, 278768.0, 279247.0, 24284.392890177885, 25107.0, 25145.748542514342, 26332.21003369902, 26471.205863824118, 39322.6067739319, 39746.40380394354, 40402.59597403988, 40568.79715601403, 41066.1786764269, 35149.8242508796, 35226.47160292546, 35283.0, 35822.641773581934, 36022.0, 34492.31015379728, 34558.82720586381, 34761.0, 34775.826120869235, 34783.652163478044, 33963.66036339605, 34194.0, 34938.82530587331, 35228.647713522536, 35259.64740352564, 30268.697313026587, 32130.518042229854, 32233.35533289368, 32266.35467290594, 32283.0, 24245.393865153514, 24287.63568546438, 24677.87661061755, 24885.253442396755, 25044.874775626005], "value": 16034.459391409082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.98008119512843, 355.4951968205148, 362.1615959054788, 362.16520919281055, 381.2299155705475, 12482.625521234355, 15864.603384915368, 16303.266353014113, 16944.23750931208, 18070.638587228248, 16976.236069376875, 17000.4049858255, 17230.655386892253, 17365.392211272607, 17488.912555437237, 4914.287428322891, 4926.433460152075, 5130.050940576006, 5148.845534633967, 5149.0474262261605, 3623.9094022649515, 5020.297158397809, 5105.259737338084, 5587.608867379285, 5825.533957283428, 5914.852128696774, 5917.526597872182, 5918.348981612019, 5922.141289513018, 5923.5853490255695, 5175.689458632494, 5436.945630543683, 5460.26286451328, 5466.207399926989, 5908.350081491032, 5249.212618107276, 5253.86865328366, 5254.500822421864, 5266.0257852297445, 5271.525562699376, 11935.403229838561, 12164.5134194633, 12195.756084878341, 12381.071419643562, 12502.0, 1854.341708693408, 1857.600615867595, 1884.481767513931, 2087.1651339464183, 2216.1467834883524, 8702.608382622797, 8772.692955746517, 9265.536723163816, 9336.67321643746, 12258.570950016796, 1593.5936336234302, 1707.538964479596, 1720.8623310135285, 1723.319288880885, 1727.4731206981864, 61826.0, 71799.64100179519, 72084.0, 72614.63692681503, 72631.63684181598, 9749.756256093513, 9919.65281215154, 9939.701808945743, 10200.38797672142, 10307.74230644225, 13825.861741382658, 13850.376733047036, 13857.861421385858, 13869.09850859691, 13869.445222191, 6811.352921472452, 6991.510594258455, 7026.086608740831, 7255.673494692752, 7258.782236532912, 6580.144581204413, 6730.629815360202, 6781.62701051437, 6801.387875091265, 7115.679794409264, 4194.203101410722, 4286.914261714748, 4298.140371925565, 4430.800613972379, 4445.422095127613, 1787.6871547479138, 1791.6237590106223, 1803.1885651456896, 1809.80092189859, 1849.1031849552955, 799.94400391972, 812.7683610171073, 883.0418995389946, 883.6421249394006, 933.1788026536605, 16415.671686566202, 16548.420805272, 16750.329986800392, 16985.660286794442, 17541.736873946902, 821.7837600351394, 827.5696637748338, 846.716350022737, 860.1183786618766, 884.964601415949, 9123.77190570241, 10263.692089237335, 10490.790184196274, 10500.369977801356, 10649.627263045757, 352701.0, 357939.0, 359120.0, 360563.0, 364132.0, 80046.5997670008, 80936.19063809287, 81232.18767812246, 81533.59233203914, 82300.0, 906.4878343735768, 913.712180663089, 934.6868798952427, 942.6842007927421, 943.5848226780332, 15713.842861571238, 15744.370225190863, 16441.91779041097, 16444.588885277964, 16580.83419165841, 33838.3232335347, 34706.0, 34984.650153498136, 38112.0, 38422.80788596039, 49663.25505117499, 49721.0, 50540.49459505358, 50644.0, 50746.0, 7418.703251870081, 7602.96198519026, 7765.922340776746, 7776.455648104578, 7877.487963282369, 11839.763204735686, 12249.081318901297, 12356.876431235572, 12750.872491274968, 12981.286029268482, 10081.69754907354, 10634.361938283728, 10792.892071079188, 10833.67498975032, 11058.889411105785, 10540.472976350999, 10619.628313009007, 10651.786964260826, 10767.676969690609, 11220.38287894141, 10141.949290253502, 10684.679459616224, 10763.784724305313, 10803.945980270048, 10934.45327733626, 7508.211637778173, 7658.73194438192, 7703.061026511041, 7794.415418843496, 8073.19268073188, 7764.262395072459, 10334.276600637882, 10855.620053298097, 10937.507812148313, 11137.164712646421], "value": 8129.662583673675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.538922903911, 1335.8702582084793, 1397.6170629077421, 1443.6102252391854, 1684.6209602839356, 7533.811654708635, 7853.37173026158, 7889.842203155933, 8158.224968627986, 8167.305779008791, 7980.800479988004, 8093.352531797457, 8099.838003239932, 8099.878501822463, 8101.675932962675, 1795.6049669072784, 2157.6439887418555, 2167.1331467413042, 2189.8467107302495, 2192.5395666909967, 2213.1589995801573, 2224.065892325227, 2224.555088982202, 2226.4322597737555, 2228.253535065755, 2175.1516908405656, 2190.6494960806276, 2205.933821985335, 2206.2278202629113, 2221.0782525252002, 2081.2195426714984, 2151.6880052392394, 2160.7839216078423, 2162.0703097667997, 2162.4701948022835, 2185.4864106934856, 2195.648696208615, 2197.6703494475796, 2201.3836125884777, 2208.083645287204, 8118.228768267005, 8178.754637360829, 8179.550124743137, 8183.181681831828, 8184.672613095469, 4446.644268458548, 4567.588916997486, 4618.099470603233, 4625.32932724753, 4634.119517291738, 2900.695426980179, 2912.5485549739824, 3051.4659934511374, 3073.262417019899, 3077.3999070181326, 936.7517607833929, 947.9004704505996, 955.1546881010356, 960.7886265021684, 962.7448726087592, 10707.571697132184, 10809.891901081046, 10817.891821081766, 10818.513166907507, 10831.025207731342, 3980.641742243212, 3984.641382275609, 4146.564610715832, 4152.563980781974, 4155.210510003089, 8394.874076888851, 8466.0, 8467.576621168917, 8470.322374210049, 8475.957620211859, 4590.196715574761, 4591.609713174351, 4591.885202869888, 4597.287420449836, 4597.862064138081, 3551.200979779529, 4160.1471698301775, 4227.281362168439, 4268.061026574149, 4284.057507348379, 3296.3901678189613, 3332.583427071616, 3412.078738740576, 3442.7762195457217, 3446.965530344715, 1022.9079382855579, 1031.1029404418205, 1044.0916402729522, 1048.051513380392, 1060.3849767135043, 692.0795342194868, 704.5103652961245, 767.769669099268, 831.995840020796, 870.9085546017703, 4878.414590249122, 5092.6180536459915, 5112.846614601568, 5165.682750898497, 5281.0, 451.13157172442914, 458.7614440490993, 460.2245216809686, 460.67292222522383, 614.7848253111375, 3509.298140371936, 3581.6239294873662, 3593.658602432765, 3601.333753255656, 3704.814759262026, 9037.728868133967, 9510.28672849539, 9513.238940884712, 9517.809643807224, 9518.333716639769, 9394.248460123174, 9494.098060684224, 9495.477748723886, 9499.715008549754, 9505.0, 7119.679614417364, 7182.030425892438, 7210.531315464373, 7212.819679508054, 7256.963715181496, 4935.337433684149, 5143.485651434827, 5150.381954165524, 5293.629445938901, 5328.6802791832615, 8748.343874209588, 8805.955970220364, 8814.471131732116, 8835.425697329652, 8862.246709029805, 8616.181462761027, 8806.0, 8837.602307896032, 8895.4662720237, 8988.86516702263, 5768.567357448124, 6143.293521245114, 6229.626222426669, 6239.594426362272, 6293.307736149111, 7583.127940286938, 7747.883781743166, 7750.341220996278, 7803.765887023398, 7808.960955195188, 6824.829379265558, 6878.621675807879, 6907.896381554381, 6993.160820701549, 7042.50702450844, 6808.183018037867, 6892.586444813327, 6894.827629309308, 6907.6891539881835, 6917.757878474229, 6359.491240700825, 6389.393007664265, 6428.292887782433, 6454.741810327722, 6539.542232043711, 4484.327350897261, 4623.439951237596, 4650.302454631697, 4656.161890859677, 4717.622590192707, 4709.81160753566, 4752.192127338291, 4762.833300834593, 4946.802127914843, 4963.950360496348], "value": 4041.104447626302, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.84942131249124, 299.66138263761945, 301.5040258774316, 302.3574903330423, 307.1262258873505, 4582.793774280157, 4724.858254252378, 4730.408698912636, 4784.875554244754, 4811.494793046732, 4588.449386073676, 4706.552877476643, 4713.888833369968, 4720.433547974248, 4722.694114120121, 3764.416515440111, 3771.4531392948006, 3779.1874746929407, 3781.8109094545302, 3788.4238717671974, 3578.7494875358734, 3630.8729194478196, 3799.734018618698, 3805.5813860475328, 3805.7145714071416, 3688.7417880748358, 3715.238376132886, 3729.8508059677715, 3739.8691045813403, 3753.51204343435, 3725.3666876631037, 3725.795081270529, 3730.9067273318115, 3740.4576336431064, 3740.9625903740884, 3276.459384201604, 3308.139883630249, 3327.800331980089, 3332.5334453176574, 3335.4163021471145, 4425.247707889666, 4570.840020599263, 4584.633229341644, 4648.86053418398, 4672.74299913508, 4212.831486740527, 4219.746815191098, 4219.852305169335, 4245.766482843443, 4260.488741351027, 4929.260610908356, 4934.914318849883, 4939.3578834751615, 4941.827036053757, 4957.5042495750495, 3324.2354258520677, 3502.7390139549743, 3615.927681446383, 3621.9094522637147, 3626.2747450510005, 5118.155504341779, 5125.589952803767, 5145.22821576759, 5149.176131818928, 5155.551113221228, 3585.659362360572, 3588.551431071116, 3591.3356029134693, 3595.209054008114, 3597.226596281812, 3630.219502806909, 3631.763935344194, 3633.5458067741533, 3637.836297366625, 3640.3629364861044, 3905.1408690088133, 4109.178164367138, 4120.0, 4128.710990230655, 4175.394567787654, 4861.683990540603, 4890.0, 4913.336699545515, 4946.3817022872145, 4963.0, 1193.5643490126042, 1217.190568272107, 1236.1594116001206, 1244.8381710377773, 1259.6221133659865, 835.1815221083373, 838.8238469921384, 853.2406158518924, 859.7791136586063, 867.3624885708999, 4384.632298558807, 4389.410247953722, 4395.1429471252795, 4397.538258482878, 4402.889927751832, 5033.270175824485, 5048.949510504922, 5052.317937078521, 5073.720945347967, 5078.492150784892, 4357.934630980474, 4376.824927002948, 4377.846775362847, 4379.562043795595, 4390.956090439118, 2279.384566167159, 2386.6658667786523, 2390.8924098415264, 2403.591389463795, 2409.638554216862, 4272.6154646082, 4273.166732487197, 4273.914521709548, 4281.443412356436, 4288.24955632763, 4532.841350552781, 4578.725276483422, 4601.12578610063, 4618.168729628699, 4641.976790116028, 4255.872193868628, 4284.357346398066, 4464.013513986245, 4870.683405578555, 4875.536824001714, 5147.691138531551, 5148.742562871917, 5153.793848246178, 5163.974180129076, 5169.0, 5064.265681476091, 5073.264376665436, 5086.567641750493, 5094.7962081516325, 5097.986295413365, 4665.5567721066445, 4825.927611085766, 4847.151748444078, 4863.659543831898, 4874.122657921608, 3627.3108109459117, 3635.763675361093, 3637.7813432500407, 3639.872604458831, 3641.380965235969, 5076.82231121909, 5109.77365432301, 5124.692518448905, 5132.358455193101, 5143.819966301162, 4770.212914869007, 4797.544233297831, 4998.400191976986, 5001.42483614389, 5012.147934851011, 4951.638299467531, 4961.429435614806, 4961.70229786214, 4976.303317535476, 4985.302057711996, 4860.313057261627, 4938.802447902188, 4945.530174633404, 4949.7030178189425, 4968.726720030433, 4893.314935909047, 4989.382697544252, 5006.949930500648, 5021.271915572149, 5033.245013247895, 4922.852314430573, 4925.87207123472, 4927.28554359623, 4931.632816248292, 4943.65394422387], "value": 3703.5442030210506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.4445721137033, 686.1320429656486, 707.2114592229659, 726.9745558905436, 756.8458101395371, 12898.74202515949, 14196.219207943546, 14212.644683882909, 14363.784543231834, 14961.326740296685, 15063.322150503254, 15340.232988350594, 15445.768313475306, 15451.381944722198, 15453.690926181469, 749.8725216713158, 770.3144201660526, 772.2702046565997, 772.3975299266581, 772.5673622771238, 615.5967841064111, 737.9926200738005, 749.8387846613005, 751.5227830327726, 755.0976582983337, 794.0986979777965, 796.8087658961865, 797.0515087046397, 797.4457751862458, 797.8683517219652, 789.2226157235119, 789.5657388436366, 790.1742678900505, 790.833924875771, 791.1060501633146, 467.621226806288, 471.22718741264356, 474.67010427752723, 479.1877767184624, 564.3425409398046, 12280.140390172692, 12928.03039772021, 12949.158304710163, 12956.287404192766, 12971.092023558354, 10829.0, 11715.472803723853, 11740.823887641693, 11743.236689615147, 12242.081843861746, 11268.558354679051, 11375.431228438545, 11610.36143012134, 11650.417479126094, 11846.466908989116, 3631.110377957391, 3631.7094632429607, 3641.635836416337, 3658.835352409148, 3693.963060369416, 49944.50055499471, 50021.0, 50087.24869126966, 50431.747841260556, 50985.49014509882, 9713.44584866418, 9951.751206219902, 10048.59805607782, 10133.898661013443, 10136.189104871593, 16551.586210344838, 16563.42028029013, 17251.568710782332, 19159.712604310946, 19255.32606358799, 6493.22081350241, 6498.0, 6663.20041595002, 6698.196216453959, 6803.183617965876, 3658.158623516606, 3756.549214094326, 3762.0, 3787.0, 3899.259140763246, 2823.4070845122756, 2936.456755500239, 2938.5004549226683, 2940.8823647053878, 2942.3085574889883, 508.90330837140823, 525.511274514705, 530.4854291337397, 534.4922323792413, 558.3774091887516, 539.8164624027771, 545.3455852976444, 551.6497024389541, 554.7475898466188, 562.6455333140095, 8479.00743325318, 8775.780605484913, 8822.86765698515, 8849.734507964771, 8870.334724895529, 599.7301214453513, 611.9755209791648, 626.4330780643525, 629.1600713048041, 633.6641579962627, 4160.979195104005, 4252.893677658083, 4259.61663450291, 4292.265240236105, 4393.868183954486, 58635.0, 82928.58535707282, 83705.0, 86098.0, 87129.56435217784, 53276.60255288521, 56077.43922560804, 72211.0, 92941.0, 95081.0, 45358.0, 50174.74912625414, 53052.73473632684, 56071.719641401534, 72009.63995179991, 9079.818403632022, 9091.945081679041, 9232.0, 9367.812643747224, 9587.616495340108, 45860.770696146305, 46733.766331168124, 48022.5197748032, 48206.0, 48299.0, 60100.0, 61215.69392153011, 70725.29274707392, 71539.64230178816, 72333.638331808, 11350.318980861175, 11901.523939042687, 12149.0, 12245.87754122483, 12590.307533085403, 13521.661958451117, 14026.789598155832, 14036.613775658367, 14120.43518259258, 14189.503367382093, 12252.75494490123, 12410.75178496407, 13166.210027398387, 13515.932420337835, 13622.86377136216, 12261.75476490483, 12517.248965062125, 12858.549950752053, 13088.149270297401, 14019.649508762363, 11821.645350639494, 11822.586209482972, 12082.577109801116, 12289.1397602167, 12412.62762117138, 9299.209567186865, 9978.750531236778, 10131.54766621742, 10461.738456538647, 10565.577376905145, 9161.0, 10492.685219443429, 10504.0, 10527.315724477885, 10565.683029509128], "value": 6557.263068435728, "unit": "score"}], "name": "dromaeo_css", "value": 6234.413724366696, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 130.0, 116.0, 115.0, 117.0, 115.0, 114.0, 115.0, 115.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 152.0, 180.0, 122.0, 157.0, 145.0, 126.0, 178.0, 127.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 160.0, 164.0, 162.0, 162.0, 163.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 161.0, 77.0, 77.0, 75.0, 76.0, 164.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 144.0, 84.0, 83.0, 83.0, 141.0, 83.0, 83.0, 150.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 65.0, 62.0, 66.0, 64.0, 64.0, 64.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 82.0, 91.0, 83.0, 85.0, 83.0, 98.0, 82.0, 84.0, 92.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 129.0, 132.0, 129.0, 130.0, 133.0, 140.0, 175.0, 144.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 179.0, 175.0, 175.0, 178.0, 176.0, 173.0, 179.0, 175.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 70.0, 73.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1582.1999999999998, "alertThreshold": 2.0}]} 01:05:27 INFO - Return code: 0 01:05:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:05:27 INFO - # TBPL SUCCESS # 01:05:27 INFO - Running post-action listener: _resource_record_post_action 01:05:27 INFO - [mozharness: 2016-08-26 08:05:27.973392Z] Finished run-tests step (success) 01:05:27 INFO - Running post-run listener: _resource_record_post_run 01:05:28 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 495616; Write bytes: 420646912; Read time: 44; Write time: 257012 01:05:28 INFO - TinderboxPrint: CPU usage
13.0% 01:05:28 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 44 01:05:28 INFO - TinderboxPrint: I/O write bytes / time
420,646,912 / 257,012 01:05:28 INFO - TinderboxPrint: CPU idle
8,332.9 (87.0%) 01:05:28 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 01:05:28 INFO - TinderboxPrint: Swap in / out
0 / 0 01:05:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114565120; Read time: 0; Write time: 92300 01:05:28 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 491520; Write bytes: 294801408; Read time: 32; Write time: 162100 01:05:28 INFO - Running post-run listener: _upload_blobber_files 01:05:28 INFO - Blob upload gear active. 01:05:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:05:28 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 01:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:05:29 INFO - (blobuploader) - INFO - Open directory for files ... 01:05:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:05:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:05:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:05:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:05:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:05:29 INFO - (blobuploader) - INFO - Done attempting. 01:05:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:05:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:05:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:05:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:05:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:05:33 INFO - (blobuploader) - INFO - Done attempting. 01:05:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:05:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:05:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:05:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:05:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:05:34 INFO - (blobuploader) - INFO - Done attempting. 01:05:34 INFO - (blobuploader) - INFO - Iteration through files over. 01:05:34 INFO - Return code: 0 01:05:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:05:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:05:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ce04f1875c4d22121470a3a215d0ea1f7aae45159ef40826786cce0f8d2f41125ce0de21fcde692484db6e433888f5be55317d54c1349927eedd4b48917685a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23c1e0e236dfe3d25578e61b7a5262827489e7177dcec4cb44e1b347fbfedf5669a4a6932f7dc670de4599018bf301731beac40ee03ad129f593cf1aa5bc6a40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b881404a13fe7d9dac6ff8d919d72759f6b5de03eb62979c3fe60f59766272bcdbe74d2906c9842102d97e77a80ac67f0949122e95933d9ec562abc1b5b8e840"} 01:05:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:05:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:05:34 INFO - Contents: 01:05:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ce04f1875c4d22121470a3a215d0ea1f7aae45159ef40826786cce0f8d2f41125ce0de21fcde692484db6e433888f5be55317d54c1349927eedd4b48917685a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23c1e0e236dfe3d25578e61b7a5262827489e7177dcec4cb44e1b347fbfedf5669a4a6932f7dc670de4599018bf301731beac40ee03ad129f593cf1aa5bc6a40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b881404a13fe7d9dac6ff8d919d72759f6b5de03eb62979c3fe60f59766272bcdbe74d2906c9842102d97e77a80ac67f0949122e95933d9ec562abc1b5b8e840"} 01:05:34 INFO - Running post-run listener: copy_logs_to_upload_dir 01:05:34 INFO - Copying logs to upload dir... 01:05:34 INFO - mkdir: /builds/slave/test/build/upload/logs 01:05:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.800935 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-26 01:05:34.414053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 01:05:34.417405) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ce04f1875c4d22121470a3a215d0ea1f7aae45159ef40826786cce0f8d2f41125ce0de21fcde692484db6e433888f5be55317d54c1349927eedd4b48917685a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23c1e0e236dfe3d25578e61b7a5262827489e7177dcec4cb44e1b347fbfedf5669a4a6932f7dc670de4599018bf301731beac40ee03ad129f593cf1aa5bc6a40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b881404a13fe7d9dac6ff8d919d72759f6b5de03eb62979c3fe60f59766272bcdbe74d2906c9842102d97e77a80ac67f0949122e95933d9ec562abc1b5b8e840"} build_url:https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011628 build_url: 'https://queue.taskcluster.net/v1/task/Zx549VSQQUaC1Mtg7RqwsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ce04f1875c4d22121470a3a215d0ea1f7aae45159ef40826786cce0f8d2f41125ce0de21fcde692484db6e433888f5be55317d54c1349927eedd4b48917685a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23c1e0e236dfe3d25578e61b7a5262827489e7177dcec4cb44e1b347fbfedf5669a4a6932f7dc670de4599018bf301731beac40ee03ad129f593cf1aa5bc6a40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b881404a13fe7d9dac6ff8d919d72759f6b5de03eb62979c3fe60f59766272bcdbe74d2906c9842102d97e77a80ac67f0949122e95933d9ec562abc1b5b8e840"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 01:05:34.442950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:05:34.443287) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1472196444.168261-882641869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 01:05:34.528609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 01:05:34.529327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 01:05:34.529955) ========= ========= Total master_lag: 0.17 =========