builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1475069048.2 results: success (0) buildid: 20160928055820 builduid: 4e93caf776b74ef7acca6d06030913bb revision: 4b65f0d1008a9abd3dc47252e939be93f725b6fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.204235) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.204807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.205151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.268170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.268513) ========= 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-1475065001.553071-878618973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 06:24:08-- 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% 56.0K=0.2s 2016-09-28 06:24:08 (56.0 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.326514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.609600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.612983) ========= 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-1475065001.553071-878618973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017514 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.662749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:08.663141) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4b65f0d1008a9abd3dc47252e939be93f725b6fe --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 4b65f0d1008a9abd3dc47252e939be93f725b6fe --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-1475065001.553071-878618973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 06:24:09,081 truncating revision to first 12 chars 2016-09-28 06:24:09,081 Setting DEBUG logging. 2016-09-28 06:24:09,082 attempt 1/10 2016-09-28 06:24:09,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4b65f0d1008a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 06:24:09,391 unpacking tar archive at: autoland-4b65f0d1008a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:09.342336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:09.342698) ========= script_repo_revision: 4b65f0d1008a9abd3dc47252e939be93f725b6fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:09.343143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:09.343447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:24:09.353649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 06:24:09.353978) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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-1475065001.553071-878618973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:09 INFO - MultiFileLogger online at 20160928 06:24:09 in /builds/slave/test 06:24:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 06:24:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:09 INFO - {'append_to_log': False, 06:24:09 INFO - 'base_work_dir': '/builds/slave/test', 06:24:09 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:24:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:09 INFO - 'branch': 'Autoland-Non-PGO', 06:24:09 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:09 INFO - 'config_files': ('talos/linux_config.py',), 06:24:09 INFO - 'default_actions': ('clobber', 06:24:09 INFO - 'read-buildbot-config', 06:24:09 INFO - 'download-and-extract', 06:24:09 INFO - 'populate-webroot', 06:24:09 INFO - 'create-virtualenv', 06:24:09 INFO - 'install', 06:24:09 INFO - 'run-tests'), 06:24:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:09 INFO - 'download_minidump_stackwalk': True, 06:24:09 INFO - 'download_symbols': 'ondemand', 06:24:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:09 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:09 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:09 INFO - 'installer_path': 'installer.exe', 06:24:09 INFO - 'log_level': 'info', 06:24:09 INFO - 'log_name': 'talos', 06:24:09 INFO - 'log_to_console': True, 06:24:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:09 INFO - 'opt_config_files': (), 06:24:09 INFO - 'pip_index': False, 06:24:09 INFO - 'sps_profile': False, 06:24:09 INFO - 'sps_profile_interval': 0, 06:24:09 INFO - 'suite': 'dromaeojs-e10s', 06:24:09 INFO - 'system_bits': '32', 06:24:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:09 INFO - 'title': 'talos-linux64-ix-012', 06:24:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:09 INFO - 'use_talos_json': True, 06:24:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:09 INFO - 'work_dir': 'build'} 06:24:09 INFO - [mozharness: 2016-09-28 13:24:09.875984Z] Running clobber step. 06:24:09 INFO - Running pre-action listener: _resource_record_pre_action 06:24:09 INFO - Running main action method: clobber 06:24:09 INFO - rmtree: /builds/slave/test/build 06:24:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:10 INFO - Running post-action listener: _resource_record_post_action 06:24:10 INFO - [mozharness: 2016-09-28 13:24:10.338247Z] Finished clobber step (success) 06:24:10 INFO - [mozharness: 2016-09-28 13:24:10.338347Z] Running read-buildbot-config step. 06:24:10 INFO - Running pre-action listener: _resource_record_pre_action 06:24:10 INFO - Running main action method: read_buildbot_config 06:24:10 INFO - Using buildbot properties: 06:24:10 INFO - { 06:24:10 INFO - "project": "", 06:24:10 INFO - "product": "firefox", 06:24:10 INFO - "script_repo_revision": "production", 06:24:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 06:24:10 INFO - "repository": "", 06:24:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 06:24:10 INFO - "buildid": "20160928055820", 06:24:10 INFO - "pgo_build": "False", 06:24:10 INFO - "basedir": "/builds/slave/test", 06:24:10 INFO - "buildnumber": 507, 06:24:10 INFO - "slavename": "talos-linux64-ix-012", 06:24:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:24:10 INFO - "platform": "ubuntu64_hw", 06:24:10 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 06:24:10 INFO - "branch": "autoland", 06:24:10 INFO - "repo_path": "integration/autoland", 06:24:10 INFO - "revision": "4b65f0d1008a9abd3dc47252e939be93f725b6fe", 06:24:10 INFO - "stage_platform": "linux64", 06:24:10 INFO - "builduid": "4e93caf776b74ef7acca6d06030913bb", 06:24:10 INFO - "slavebuilddir": "test" 06:24:10 INFO - } 06:24:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:24:10 INFO - Running post-action listener: _resource_record_post_action 06:24:10 INFO - [mozharness: 2016-09-28 13:24:10.340776Z] Finished read-buildbot-config step (success) 06:24:10 INFO - [mozharness: 2016-09-28 13:24:10.340865Z] Running download-and-extract step. 06:24:10 INFO - Running pre-action listener: _resource_record_pre_action 06:24:10 INFO - Running main action method: download_and_extract 06:24:10 INFO - mkdir: /builds/slave/test/build/tests 06:24: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')]} 06:24:10 INFO - trying https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:24:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:24:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:24:11 INFO - Downloaded 1361 bytes. 06:24:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:24:11 INFO - Using the following test package requirements: 06:24:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:24:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'jsshell-linux-x86_64.zip'], 06:24:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:24:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:24:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:24:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:11 INFO - Fetch https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:24:11 INFO - Expected file size: 20413898 06:24:11 INFO - Content-Encoding None 06:24:11 INFO - Content-Type application/zip 06:24:11 INFO - Http code 200 06:24:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:24:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:24:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:15 INFO - Fetch https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:24:16 INFO - Expected file size: 20413898 06:24:16 INFO - Content-Encoding None 06:24:16 INFO - Content-Type application/zip 06:24:16 INFO - Http code 200 06:24:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:24:21 INFO - Fetch https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:24:21 INFO - Expected file size: 14414057 06:24:21 INFO - Content-Encoding None 06:24:21 INFO - Content-Type application/zip 06:24:21 INFO - Http code 200 06:24: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')]} 06:24:22 INFO - trying https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:24:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:24:23 INFO - Downloaded 55735218 bytes. 06:24:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:24:23 INFO - mkdir: /builds/slave/test/properties 06:24:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:23 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:23 INFO - Contents: 06:24:23 INFO - build_url:https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:24:24 INFO - Running post-action listener: _resource_record_post_action 06:24:24 INFO - Running post-action listener: set_extra_try_arguments 06:24:24 INFO - [mozharness: 2016-09-28 13:24:24.043470Z] Finished download-and-extract step (success) 06:24:24 INFO - [mozharness: 2016-09-28 13:24:24.043701Z] Running populate-webroot step. 06:24:24 INFO - Running pre-action listener: _resource_record_pre_action 06:24:24 INFO - Running main action method: populate_webroot 06:24:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:24 INFO - '--tppagecycles', 06:24:24 INFO - '7'], 06:24:24 INFO - 'tests': ['tsvgm']}}, 06:24:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['damp', 'tps']}, 06:24:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'tests': ['damp', 'tps']}, 06:24:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['dromaeo_dom']}, 06:24:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['basic_compositor_video']}, 06:24:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:24:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['a11yr', 06:24:24 INFO - 'ts_paint', 06:24:24 INFO - 'tpaint', 06:24:24 INFO - 'sessionrestore', 06:24:24 INFO - 'sessionrestore_no_auto_restore', 06:24:24 INFO - 'tabpaint']}, 06:24:24 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:24 INFO - 'ts_paint', 06:24:24 INFO - 'tpaint', 06:24:24 INFO - 'sessionrestore', 06:24:24 INFO - 'sessionrestore_no_auto_restore', 06:24:24 INFO - 'tabpaint']}, 06:24:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:24:24 INFO - 'ts_paint', 06:24:24 INFO - 'tpaint', 06:24:24 INFO - 'sessionrestore', 06:24:24 INFO - 'sessionrestore_no_auto_restore', 06:24:24 INFO - 'tabpaint']}, 06:24:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:24:24 INFO - 'ts_paint', 06:24:24 INFO - 'tpaint', 06:24:24 INFO - 'sessionrestore', 06:24:24 INFO - 'sessionrestore_no_auto_restore', 06:24:24 INFO - 'tabpaint']}, 06:24:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['a11yr', 06:24:24 INFO - 'ts_paint', 06:24:24 INFO - 'tpaint', 06:24:24 INFO - 'sessionrestore', 06:24:24 INFO - 'sessionrestore_no_auto_restore', 06:24:24 INFO - 'tabpaint']}, 06:24:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['a11yr', 06:24:24 INFO - 'ts_paint', 06:24:24 INFO - 'tpaint', 06:24:24 INFO - 'sessionrestore', 06:24:24 INFO - 'sessionrestore_no_auto_restore', 06:24:24 INFO - 'tabpaint']}, 06:24:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['tsvgx', 06:24:24 INFO - 'tsvgr_opacity', 06:24:24 INFO - 'tart', 06:24:24 INFO - 'tscrollx', 06:24:24 INFO - 'cart']}, 06:24:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:24 INFO - 'tsvgr_opacity', 06:24:24 INFO - 'tart', 06:24:24 INFO - 'tscrollx', 06:24:24 INFO - 'cart']}, 06:24:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'talos_options': ['--disable-e10s'], 06:24:24 INFO - 'tests': ['tp5o']}, 06:24:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'tests': ['tp5o']}, 06:24:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'talos_options': ['--disable-e10s', 06:24:24 INFO - '--xperf_path', 06:24:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:24 INFO - 'tests': ['tp5n']}, 06:24:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:24 INFO - 'talos_options': ['--xperf_path', 06:24:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:24 INFO - 'tests': ['tp5n']}}, 06:24:24 INFO - 'talos.zip': {'path': '', 06:24:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:24 INFO - Running post-action listener: _resource_record_post_action 06:24:24 INFO - [mozharness: 2016-09-28 13:24:24.065314Z] Finished populate-webroot step (success) 06:24:24 INFO - [mozharness: 2016-09-28 13:24:24.065401Z] Running create-virtualenv step. 06:24:24 INFO - Running pre-action listener: _resource_record_pre_action 06:24:24 INFO - Running main action method: create_virtualenv 06:24:24 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:24 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 06:24:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:24 INFO - Using real prefix '/usr' 06:24:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:24 INFO - Installing distribute.............................................................................................................................................................................................done. 06:24:26 INFO - Installing pip.................done. 06:24:26 INFO - Return code: 0 06:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:24:26 INFO - Reading from file tmpfile_stdout 06:24:26 INFO - Output received: 06:24:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:24:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24: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', 'pip>=1.5'] in /builds/slave/test/build 06:24: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 pip>=1.5 06:24:26 INFO - Using env: {'DISPLAY': ':0', 06:24:26 INFO - 'HOME': '/home/cltbld', 06:24:26 INFO - 'LANG': 'en_US.UTF-8', 06:24:26 INFO - 'LANGUAGE': 'en_US:en', 06:24:26 INFO - 'LOGNAME': 'cltbld', 06:24:26 INFO - 'MAIL': '/var/mail/cltbld', 06:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:26 INFO - 'MOZ_NO_REMOTE': '1', 06:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:26 INFO - 'NO_EM_RESTART': '1', 06:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:26 INFO - 'PWD': '/builds/slave/test', 06:24:26 INFO - 'SHELL': '/bin/bash', 06:24:26 INFO - 'SHLVL': '1', 06:24:26 INFO - 'TERM': 'linux', 06:24:26 INFO - 'TMOUT': '86400', 06:24:26 INFO - 'USER': 'cltbld', 06:24:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:26 INFO - '_': '/tools/buildbot/bin/python'} 06:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:27 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 06:24:27 INFO - Cleaning up... 06:24:27 INFO - Return code: 0 06:24:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:24:27 INFO - Using env: {'DISPLAY': ':0', 06:24:27 INFO - 'HOME': '/home/cltbld', 06:24:27 INFO - 'LANG': 'en_US.UTF-8', 06:24:27 INFO - 'LANGUAGE': 'en_US:en', 06:24:27 INFO - 'LOGNAME': 'cltbld', 06:24:27 INFO - 'MAIL': '/var/mail/cltbld', 06:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:27 INFO - 'MOZ_NO_REMOTE': '1', 06:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:27 INFO - 'NO_EM_RESTART': '1', 06:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:27 INFO - 'PWD': '/builds/slave/test', 06:24:27 INFO - 'SHELL': '/bin/bash', 06:24:27 INFO - 'SHLVL': '1', 06:24:27 INFO - 'TERM': 'linux', 06:24:27 INFO - 'TMOUT': '86400', 06:24:27 INFO - 'USER': 'cltbld', 06:24:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:27 INFO - '_': '/tools/buildbot/bin/python'} 06:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:27 INFO - Downloading/unpacking psutil>=3.1.1 06:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:24:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:29 INFO - Installing collected packages: psutil 06:24:29 INFO - Running setup.py install for psutil 06:24:29 INFO - building 'psutil._psutil_linux' extension 06:24:29 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 06:24:29 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 06:24:29 INFO - building 'psutil._psutil_posix' extension 06:24:29 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 06:24:29 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 06:24:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:29 INFO - Successfully installed psutil 06:24:29 INFO - Cleaning up... 06:24:29 INFO - Return code: 0 06:24:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:24:29 INFO - Using env: {'DISPLAY': ':0', 06:24:29 INFO - 'HOME': '/home/cltbld', 06:24:29 INFO - 'LANG': 'en_US.UTF-8', 06:24:29 INFO - 'LANGUAGE': 'en_US:en', 06:24:29 INFO - 'LOGNAME': 'cltbld', 06:24:29 INFO - 'MAIL': '/var/mail/cltbld', 06:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:29 INFO - 'MOZ_NO_REMOTE': '1', 06:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:29 INFO - 'NO_EM_RESTART': '1', 06:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:29 INFO - 'PWD': '/builds/slave/test', 06:24:29 INFO - 'SHELL': '/bin/bash', 06:24:29 INFO - 'SHLVL': '1', 06:24:29 INFO - 'TERM': 'linux', 06:24:29 INFO - 'TMOUT': '86400', 06:24:29 INFO - 'USER': 'cltbld', 06:24:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:29 INFO - '_': '/tools/buildbot/bin/python'} 06:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:24:31 INFO - Installing collected packages: mozsystemmonitor 06:24:31 INFO - Running setup.py install for mozsystemmonitor 06:24:32 INFO - Successfully installed mozsystemmonitor 06:24:32 INFO - Cleaning up... 06:24:32 INFO - Return code: 0 06:24:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:24:32 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')]} 06:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:32 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')]} 06:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:32 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:32 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 06:24:32 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 06:24:32 INFO - Using env: {'DISPLAY': ':0', 06:24:32 INFO - 'HOME': '/home/cltbld', 06:24:32 INFO - 'LANG': 'en_US.UTF-8', 06:24:32 INFO - 'LANGUAGE': 'en_US:en', 06:24:32 INFO - 'LOGNAME': 'cltbld', 06:24:32 INFO - 'MAIL': '/var/mail/cltbld', 06:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:32 INFO - 'MOZ_NO_REMOTE': '1', 06:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:32 INFO - 'NO_EM_RESTART': '1', 06:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:32 INFO - 'PWD': '/builds/slave/test', 06:24:32 INFO - 'SHELL': '/bin/bash', 06:24:32 INFO - 'SHLVL': '1', 06:24:32 INFO - 'TERM': 'linux', 06:24:32 INFO - 'TMOUT': '86400', 06:24:32 INFO - 'USER': 'cltbld', 06:24:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:32 INFO - '_': '/tools/buildbot/bin/python'} 06:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:32 INFO - Downloading/unpacking jsonschema==2.5.1 06:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:24:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:34 INFO - Downloading functools32-3.2.3-2.tar.gz 06:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:24:34 INFO - warning: no files found matching '*.txt' 06:24:34 INFO - no previously-included directories found matching 'build' 06:24:34 INFO - no previously-included directories found matching 'dist' 06:24:34 INFO - no previously-included directories found matching '.git*' 06:24:34 INFO - Installing collected packages: jsonschema, functools32 06:24:34 INFO - Running setup.py install for functools32 06:24:34 INFO - warning: no files found matching '*.txt' 06:24:34 INFO - no previously-included directories found matching 'build' 06:24:34 INFO - no previously-included directories found matching 'dist' 06:24:34 INFO - no previously-included directories found matching '.git*' 06:24:34 INFO - Successfully installed jsonschema functools32 06:24:34 INFO - Cleaning up... 06:24:34 INFO - Return code: 0 06:24:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:34 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:34 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 06:24:34 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 06:24:34 INFO - Using env: {'DISPLAY': ':0', 06:24:34 INFO - 'HOME': '/home/cltbld', 06:24:34 INFO - 'LANG': 'en_US.UTF-8', 06:24:34 INFO - 'LANGUAGE': 'en_US:en', 06:24:34 INFO - 'LOGNAME': 'cltbld', 06:24:34 INFO - 'MAIL': '/var/mail/cltbld', 06:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:34 INFO - 'MOZ_NO_REMOTE': '1', 06:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:34 INFO - 'NO_EM_RESTART': '1', 06:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:34 INFO - 'PWD': '/builds/slave/test', 06:24:34 INFO - 'SHELL': '/bin/bash', 06:24:34 INFO - 'SHLVL': '1', 06:24:34 INFO - 'TERM': 'linux', 06:24:34 INFO - 'TMOUT': '86400', 06:24:34 INFO - 'USER': 'cltbld', 06:24:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:34 INFO - '_': '/tools/buildbot/bin/python'} 06:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:24:34 INFO - Cleaning up... 06:24:34 INFO - Return code: 0 06:24:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:34 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:34 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 06:24:34 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 06:24:34 INFO - Using env: {'DISPLAY': ':0', 06:24:34 INFO - 'HOME': '/home/cltbld', 06:24:34 INFO - 'LANG': 'en_US.UTF-8', 06:24:34 INFO - 'LANGUAGE': 'en_US:en', 06:24:34 INFO - 'LOGNAME': 'cltbld', 06:24:34 INFO - 'MAIL': '/var/mail/cltbld', 06:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:34 INFO - 'MOZ_NO_REMOTE': '1', 06:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:34 INFO - 'NO_EM_RESTART': '1', 06:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:34 INFO - 'PWD': '/builds/slave/test', 06:24:34 INFO - 'SHELL': '/bin/bash', 06:24:34 INFO - 'SHLVL': '1', 06:24:34 INFO - 'TERM': 'linux', 06:24:34 INFO - 'TMOUT': '86400', 06:24:34 INFO - 'USER': 'cltbld', 06:24:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:34 INFO - '_': '/tools/buildbot/bin/python'} 06:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:24:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:24:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - Downloading docopt-0.6.1.tar.gz 06:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:24:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:24:37 INFO - Running setup.py install for blobuploader 06:24:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:24:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:24:37 INFO - Running setup.py install for requests 06:24:38 INFO - Running setup.py install for docopt 06:24:38 INFO - Successfully installed blobuploader requests docopt 06:24:38 INFO - Cleaning up... 06:24:38 INFO - Return code: 0 06:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:38 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:38 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 06:24:38 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 06:24:38 INFO - Using env: {'DISPLAY': ':0', 06:24:38 INFO - 'HOME': '/home/cltbld', 06:24:38 INFO - 'LANG': 'en_US.UTF-8', 06:24:38 INFO - 'LANGUAGE': 'en_US:en', 06:24:38 INFO - 'LOGNAME': 'cltbld', 06:24:38 INFO - 'MAIL': '/var/mail/cltbld', 06:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:38 INFO - 'MOZ_NO_REMOTE': '1', 06:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:38 INFO - 'NO_EM_RESTART': '1', 06:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:38 INFO - 'PWD': '/builds/slave/test', 06:24:38 INFO - 'SHELL': '/bin/bash', 06:24:38 INFO - 'SHLVL': '1', 06:24:38 INFO - 'TERM': 'linux', 06:24:38 INFO - 'TMOUT': '86400', 06:24:38 INFO - 'USER': 'cltbld', 06:24:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:38 INFO - '_': '/tools/buildbot/bin/python'} 06:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:38 INFO - Running setup.py (path:/tmp/pip-40cnvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:38 INFO - Running setup.py (path:/tmp/pip-Gk0iRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:38 INFO - Running setup.py (path:/tmp/pip-ZjR_Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:38 INFO - Running setup.py (path:/tmp/pip-m8t2Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:38 INFO - Running setup.py (path:/tmp/pip-ARoqc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:38 INFO - Running setup.py (path:/tmp/pip-J5oVW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:39 INFO - Running setup.py (path:/tmp/pip-MwiI1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:39 INFO - Running setup.py (path:/tmp/pip-EOhS_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:39 INFO - Running setup.py (path:/tmp/pip-qxo3Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:39 INFO - Running setup.py (path:/tmp/pip-cau4RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:39 INFO - Running setup.py (path:/tmp/pip-gs1sIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:39 INFO - Running setup.py (path:/tmp/pip-Yydgx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:39 INFO - Running setup.py (path:/tmp/pip-lJw7ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:39 INFO - Running setup.py (path:/tmp/pip-DcYt8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:39 INFO - Running setup.py (path:/tmp/pip-xxDE1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:39 INFO - Running setup.py (path:/tmp/pip-1qYfM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:39 INFO - Running setup.py (path:/tmp/pip-jN0UZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:24:39 INFO - Running setup.py install for manifestparser 06:24:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:24:39 INFO - Running setup.py install for mozcrash 06:24:40 INFO - Running setup.py install for mozdebug 06:24:40 INFO - Running setup.py install for mozdevice 06:24:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Running setup.py install for mozfile 06:24:40 INFO - Running setup.py install for mozhttpd 06:24:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Running setup.py install for mozinfo 06:24:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Running setup.py install for mozInstall 06:24:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Running setup.py install for mozleak 06:24:40 INFO - Running setup.py install for mozlog 06:24:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Running setup.py install for moznetwork 06:24:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:40 INFO - Running setup.py install for mozprocess 06:24:41 INFO - Running setup.py install for mozprofile 06:24:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:41 INFO - Running setup.py install for mozrunner 06:24:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:41 INFO - Running setup.py install for mozscreenshot 06:24:41 INFO - Running setup.py install for moztest 06:24:41 INFO - Running setup.py install for mozversion 06:24:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:41 INFO - Cleaning up... 06:24:41 INFO - Return code: 0 06:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:41 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')]} 06:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:41 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')]} 06:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:41 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:41 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 06:24:41 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 06:24:41 INFO - Using env: {'DISPLAY': ':0', 06:24:41 INFO - 'HOME': '/home/cltbld', 06:24:41 INFO - 'LANG': 'en_US.UTF-8', 06:24:41 INFO - 'LANGUAGE': 'en_US:en', 06:24:41 INFO - 'LOGNAME': 'cltbld', 06:24:41 INFO - 'MAIL': '/var/mail/cltbld', 06:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:41 INFO - 'MOZ_NO_REMOTE': '1', 06:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:41 INFO - 'NO_EM_RESTART': '1', 06:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:41 INFO - 'PWD': '/builds/slave/test', 06:24:41 INFO - 'SHELL': '/bin/bash', 06:24:41 INFO - 'SHLVL': '1', 06:24:41 INFO - 'TERM': 'linux', 06:24:41 INFO - 'TMOUT': '86400', 06:24:41 INFO - 'USER': 'cltbld', 06:24:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:41 INFO - '_': '/tools/buildbot/bin/python'} 06:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:41 INFO - Running setup.py (path:/tmp/pip-X4h_Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:41 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)) 06:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:41 INFO - Running setup.py (path:/tmp/pip-aWg9cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:42 INFO - Running setup.py (path:/tmp/pip-zlt6J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:42 INFO - Running setup.py (path:/tmp/pip-9sI7FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:42 INFO - Running setup.py (path:/tmp/pip-lfCyVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:42 INFO - Running setup.py (path:/tmp/pip-xQILnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:42 INFO - Running setup.py (path:/tmp/pip-LinwHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:42 INFO - Running setup.py (path:/tmp/pip-s7_Df_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:42 INFO - Running setup.py (path:/tmp/pip-kYiGWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:42 INFO - Running setup.py (path:/tmp/pip-IXpu39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:42 INFO - Running setup.py (path:/tmp/pip-YxSHKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:42 INFO - Running setup.py (path:/tmp/pip-rxR59o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:42 INFO - Running setup.py (path:/tmp/pip-m2W68n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:42 INFO - Running setup.py (path:/tmp/pip-TVUcoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:42 INFO - Running setup.py (path:/tmp/pip-_nmCEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:42 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)) 06:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:42 INFO - Running setup.py (path:/tmp/pip-JbUKB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:43 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)) 06:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:43 INFO - Running setup.py (path:/tmp/pip-_ciYOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:43 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)) 06:24:43 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)) 06:24:43 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)) 06:24:43 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)) 06:24:43 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)) 06:24:43 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)) 06:24:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:43 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 06:24:43 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 06:24:43 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 06:24:43 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 06:24:43 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 06:24:43 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 06:24:45 INFO - Downloading blessings-1.6.tar.gz 06:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:45 INFO - Installing collected packages: blessings 06:24:45 INFO - Running setup.py install for blessings 06:24:45 INFO - Successfully installed blessings 06:24:45 INFO - Cleaning up... 06:24:45 INFO - Return code: 0 06:24:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:45 INFO - Reading from file tmpfile_stdout 06:24:45 INFO - Current package versions: 06:24:45 INFO - argparse == 1.2.1 06:24:45 INFO - blessings == 1.6 06:24:45 INFO - blobuploader == 1.2.4 06:24:45 INFO - docopt == 0.6.1 06:24:45 INFO - functools32 == 3.2.3-2 06:24:45 INFO - jsonschema == 2.5.1 06:24:45 INFO - manifestparser == 1.1 06:24:45 INFO - mozInstall == 1.12 06:24:45 INFO - mozcrash == 0.17 06:24:45 INFO - mozdebug == 0.1 06:24:45 INFO - mozdevice == 0.48 06:24:45 INFO - mozfile == 1.2 06:24:45 INFO - mozhttpd == 0.7 06:24:45 INFO - mozinfo == 0.9 06:24:45 INFO - mozleak == 0.1 06:24:45 INFO - mozlog == 3.4 06:24:45 INFO - moznetwork == 0.27 06:24:45 INFO - mozprocess == 0.23 06:24:45 INFO - mozprofile == 0.28 06:24:45 INFO - mozrunner == 6.12 06:24:45 INFO - mozscreenshot == 0.1 06:24:45 INFO - mozsystemmonitor == 0.3 06:24:45 INFO - moztest == 0.7 06:24:45 INFO - mozversion == 1.4 06:24:45 INFO - psutil == 3.1.1 06:24:45 INFO - requests == 1.2.3 06:24:45 INFO - wsgiref == 0.1.2 06:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:45 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')]} 06:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:45 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')]} 06:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:45 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:45 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 06:24:45 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 06:24:45 INFO - Using env: {'DISPLAY': ':0', 06:24:45 INFO - 'HOME': '/home/cltbld', 06:24:45 INFO - 'LANG': 'en_US.UTF-8', 06:24:45 INFO - 'LANGUAGE': 'en_US:en', 06:24:45 INFO - 'LOGNAME': 'cltbld', 06:24:45 INFO - 'MAIL': '/var/mail/cltbld', 06:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:45 INFO - 'MOZ_NO_REMOTE': '1', 06:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:45 INFO - 'NO_EM_RESTART': '1', 06:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:45 INFO - 'PWD': '/builds/slave/test', 06:24:45 INFO - 'SHELL': '/bin/bash', 06:24:45 INFO - 'SHLVL': '1', 06:24:45 INFO - 'TERM': 'linux', 06:24:45 INFO - 'TMOUT': '86400', 06:24:45 INFO - 'USER': 'cltbld', 06:24:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:45 INFO - '_': '/tools/buildbot/bin/python'} 06:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 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)) 06:24:45 INFO - Cleaning up... 06:24:45 INFO - Return code: 0 06:24:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:24:45 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')]} 06:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:45 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')]} 06:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:45 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 0x7f385c159f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, '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-1475065001.553071-878618973', '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 06:24:45 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 06:24:45 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 06:24:45 INFO - Using env: {'DISPLAY': ':0', 06:24:45 INFO - 'HOME': '/home/cltbld', 06:24:45 INFO - 'LANG': 'en_US.UTF-8', 06:24:45 INFO - 'LANGUAGE': 'en_US:en', 06:24:45 INFO - 'LOGNAME': 'cltbld', 06:24:45 INFO - 'MAIL': '/var/mail/cltbld', 06:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:45 INFO - 'MOZ_NO_REMOTE': '1', 06:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:45 INFO - 'NO_EM_RESTART': '1', 06:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:45 INFO - 'PWD': '/builds/slave/test', 06:24:45 INFO - 'SHELL': '/bin/bash', 06:24:45 INFO - 'SHLVL': '1', 06:24:45 INFO - 'TERM': 'linux', 06:24:45 INFO - 'TMOUT': '86400', 06:24:45 INFO - 'USER': 'cltbld', 06:24:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:45 INFO - '_': '/tools/buildbot/bin/python'} 06:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:24:45 INFO - Cleaning up... 06:24:45 INFO - Return code: 0 06:24:45 INFO - Running post-action listener: _resource_record_post_action 06:24:45 INFO - Running post-action listener: _start_resource_monitoring 06:24:45 INFO - Starting resource monitoring. 06:24:45 INFO - [mozharness: 2016-09-28 13:24:45.935883Z] Finished create-virtualenv step (success) 06:24:45 INFO - [mozharness: 2016-09-28 13:24:45.936341Z] Running install step. 06:24:45 INFO - Running pre-action listener: _resource_record_pre_action 06:24:45 INFO - Running main action method: install 06:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:46 INFO - Reading from file tmpfile_stdout 06:24:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:24:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:24:46 INFO - Reading from file tmpfile_stdout 06:24:46 INFO - Output received: 06:24:46 INFO - Usage: mozinstall [options] installer 06:24:46 INFO - Options: 06:24:46 INFO - -h, --help show this help message and exit 06:24:46 INFO - -d DEST, --destination=DEST 06:24:46 INFO - Directory to install application into. [default: 06:24:46 INFO - "/builds/slave/test"] 06:24:46 INFO - --app=APP Application being installed. [default: firefox] 06:24:46 INFO - mkdir: /builds/slave/test/build/application 06:24:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:25:02 INFO - Reading from file tmpfile_stdout 06:25:02 INFO - Output received: 06:25:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:25:02 INFO - Running post-action listener: _resource_record_post_action 06:25:02 INFO - [mozharness: 2016-09-28 13:25:02.359424Z] Finished install step (success) 06:25:02 INFO - [mozharness: 2016-09-28 13:25:02.359669Z] Running run-tests step. 06:25:02 INFO - Running pre-action listener: _resource_record_pre_action 06:25:02 INFO - Running main action method: run_tests 06:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:02 INFO - Python 2.7.3 06:25:02 INFO - Return code: 0 06:25:02 INFO - grabbing minidump binary from tooltool 06:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:02 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 0x14c9f60>, '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 0x14cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:02 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 06:25:02 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 06:25:02 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 06:25:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:02 INFO - Return code: 0 06:25:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:25:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:25:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:02 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:25:02 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:25:02 INFO - Using env: {'DISPLAY': ':0', 06:25:02 INFO - 'HOME': '/home/cltbld', 06:25:02 INFO - 'LANG': 'en_US.UTF-8', 06:25:02 INFO - 'LANGUAGE': 'en_US:en', 06:25:02 INFO - 'LOGNAME': 'cltbld', 06:25:02 INFO - 'MAIL': '/var/mail/cltbld', 06:25:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:02 INFO - 'MOZ_NO_REMOTE': '1', 06:25:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:02 INFO - 'NO_EM_RESTART': '1', 06:25:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:02 INFO - 'PWD': '/builds/slave/test', 06:25:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:02 INFO - 'SHELL': '/bin/bash', 06:25:02 INFO - 'SHLVL': '1', 06:25:02 INFO - 'TERM': 'linux', 06:25:02 INFO - 'TMOUT': '86400', 06:25:02 INFO - 'USER': 'cltbld', 06:25:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475065001.553071-878618973', 06:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:02 INFO - '_': '/tools/buildbot/bin/python'} 06:25:02 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:25:02 INFO - mozversion application_buildid: 20160928055820 06:25:02 INFO - mozversion application_changeset: 4b65f0d1008a9abd3dc47252e939be93f725b6fe 06:25:02 INFO - mozversion application_display_name: Nightly 06:25:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:02 INFO - mozversion application_name: Firefox 06:25:02 INFO - mozversion application_remotingname: firefox 06:25:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:25:02 INFO - mozversion application_vendor: Mozilla 06:25:02 INFO - mozversion application_version: 52.0a1 06:25:02 INFO - mozversion platform_buildid: 20160928055820 06:25:02 INFO - mozversion platform_changeset: 4b65f0d1008a9abd3dc47252e939be93f725b6fe 06:25:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:25:02 INFO - mozversion platform_version: 52.0a1 06:25:02 INFO - using testdate: 1475069102 06:25:02 INFO - actual date: 1475069102 06:25:02 INFO - starting webserver on 'localhost:36894' 06:25:02 INFO - SUITE-START | Running 2 tests 06:25:02 INFO - TEST-START | dromaeo_css 06:25:02 INFO - operating with platform_type : linux_ 06:25:02 INFO - Initialising browser for dromaeo_css test... 06:25:02 INFO - TEST-INFO | started process 5583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXGsJ8P/profile http://localhost:36894/getInfo.html) 06:25:07 INFO - PROCESS | 5583 | __metrics Screen width/height:1600/1200 06:25:07 INFO - PROCESS | 5583 | colorDepth:24 06:25:07 INFO - PROCESS | 5583 | Browser inner width/height: 1024/697 06:25:07 INFO - PROCESS | 5583 | __metrics 06:25:07 ERROR - PROCESS | 5583 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:25:08 INFO - TEST-INFO | 5583: exit 0 06:25:08 INFO - Browser initialized. 06:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:08 INFO - TEST-INFO | started process 5701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXGsJ8P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:21 INFO - PROCESS | 5701 | RSS: Main: 186331136 06:25:21 INFO - PROCESS | 5701 | 06:26:10 INFO - PROCESS | 5701 | 1475069170717 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] 06:28:23 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36894/tests/dromaeo/cssquery-ext.html) 06:28:24 INFO - PROCESS | 5701 | RSS: Main: 197775360 06:28:24 INFO - PROCESS | 5701 | 06:31:27 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-ext.html (next: http://localhost:36894/tests/dromaeo/cssquery-jquery.html) 06:31:28 INFO - PROCESS | 5701 | RSS: Main: 196403200 06:31:28 INFO - PROCESS | 5701 | 06:34:30 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36894/tests/dromaeo/cssquery-mootools.html) 06:34:30 INFO - PROCESS | 5701 | RSS: Main: 198500352 06:34:30 INFO - PROCESS | 5701 | 06:37:32 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36894/tests/dromaeo/cssquery-prototype.html) 06:37:33 INFO - PROCESS | 5701 | RSS: Main: 195440640 06:37:33 INFO - PROCESS | 5701 | 06:40:36 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36894/tests/dromaeo/cssquery-yui.html) 06:40:37 INFO - PROCESS | 5701 | RSS: Main: 198647808 06:40:37 INFO - PROCESS | 5701 | 06:43:39 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-yui.html (next: http://localhost:36894/tests/dromaeo/cssquery-dojo.html) 06:43:40 INFO - PROCESS | 5701 | RSS: Main: 199106560 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | __start_tp_report 06:43:40 INFO - PROCESS | 5701 | _x_x_mozilla_page_load 06:43:40 INFO - PROCESS | 5701 | _x_x_mozilla_page_load_details 06:43:40 INFO - PROCESS | 5701 | |i|pagename|runs| 06:43:40 INFO - PROCESS | 5701 | |0;dojo.html;2652.801039922006;2662.0416650006;2670.9983756091465;2673.278214881982;2677.3708178578036;4744.928826067612;4853.878653033676;4890.462049174597;4892.828750993716;4956.900861982758;4764.285357196422;4796.640251981098;4817.855464336076;4845.733484658343;4924.729139897304;4335.6965012449145;4441.4004109445295;4446.310821822606;4551.476580193287;4584.97707511462;4521.095780843828;4561.908761824761;4564.246899261634;4567.972206253583;4579.107074120548;4332;4338.934915976263;4366.039471316305;4401.5378385269405;4453.755043472608;4374.300111982067;4384.254676704936;4429.446319210098;4433.423654924839;4433.844815431445;4324.567543245682;4360.209465941768;4360.542143074963;4377.846775362847;4412.580804823537;4722.268048452495;4729.077829823186;4751.3585665935;4769.332293478916;4816.54242846929;5140.357455318085;5167.793288268503;5175.171972484422;5219.921701174486;5234.895302093975;5199.610029247784;5199.974000129975;5206.219067139959;5212.661177023481;5272.683638981635;4721.598664113589;4772.3557319762085;4855.927161092586;4856.902861942776;4858.416989961227;5381.461853814587;5403.162509810985;5444.40111587725;5470.097433923358;5537.640053396597;5173.379194496609;5174.896502069938;5175.4565770593545;5176.844694659091;5178.119719647669;4993.50064993505;5076.162433198481;5087.949120508822;5319.388270348882;5353.892922141536;5147.459516750762;5176.663516871391;5195.454477279831;5197.298364720715;5201.271821944931;5052.696838189647;5063.772130254148;5076.796928122833;5110.233464980282;5176.767045482962;4361.5856493633055;4364.41080454141;4367.039251364695;4373.3877257183385;4419.46966364032;3781.9810900945868;3796.354619714655;3816.6183381662167;3840.3663395539425;3874.3413619684156;4305.246581848164;4345.065810850682;4347.6304514116655;4399.098184872094;4454.77726113693;5186.118359878829;5187.974060129751;5191.480851914778;5192.584593232532;5243.632945693841;4337.8264869404875;4402.911941761211;4404.273294906305;4414.955850441519;4440.911181776346;4553.3397657340165;4590.357349971006;4639.536046395334;4655.162070827284;4672.883177920579;4883.243097319921;4891.070696567641;4898.387701537308;4935.679180853233;4955.72743499111;5214;5225.346831646044;5227.503387178212;5237.869053273698;5289.523942845162;4754.952450475589;4798.832040878552;4811.927821082757;4894.094592500399;4907.190313598359;5046.091703493406;5134;5137.974310128426;5184.196449550326;5192.714400707997;5184.688918664892;5196.896062078662;5197.688138711689;5199.974000129975;5258.395284542174;4893.510648935078;4939.086269040239;4950.405951285725;4991.850244492671;4993.725345106054;4950.084234416644;5005.424376196784;5006.524380183877;5010.423801262901;5077.416097148875;4912.435069966999;4935.901281974412;4938.851834444972;4942.332785073969;5030.044291584587;4896.6327525436445;4954.900901981868;4971.328870602422;5007.749612519432;5039.0929632666475;4909.0672772173175;4926.433460152129;4952.5542701157065;4974.726390048582;4986.326845875906 06:43:40 INFO - PROCESS | 5701 | |1;ext.html;522.7699812082685;533.3839415475126;537.0440615704043;542.4656713137559;550.9889802203955;38053.61946380536;39948;40130.79934600327;40169.39745903814;40326.7983660082;39659.40510892339;40177.19645607086;40191.59808401922;40226;40268.79865600675;7680.385569154454;7820.921790782077;7821.8826717598995;7836.098848632395;7847.058352997648;7626.6186690665245;7715.807104822368;7720.189380115091;7728.613569321511;7732.420068494857;7721.72973945912;7750.767476975671;7752.651130699132;7755.88366174505;7756.146823849372;7632.923670763277;7695.961520192392;7706.537607743498;7729.111152217511;7745.22547745221;7518.624068796593;7583.241675832428;7654.8469030619635;7657.157712651604;7670.30967212948;37496.25007499862;37628.43557346642;37895.810520947496;37974.81012594947;37984.43023354652;3100.953485697716;3183.554302397666;3337.4493208620547;3409.4203985322306;3661.2677464506937;28151;28458;28848;28953.565696514568;29965.550516742267;3549.6272891346293;3553.34263161316;3615.349237137314;3633.8001409922445;3781.5273090863643;253564;256669.7166514174;256868;256969;257715;30469.23826904345;51840.48159518432;52477.47522524726;52542.47457525452;52641;31749.841250793597;32960.67039329624;33281;33353.3329333412;33382.66617333796;11475.827862582068;11588.36264005471;11590.88409115898;11600.129990250765;11662.766744665229;9102.726918192464;9132.680356187502;9161;9175.403598766192;9197.908020919838;7701.653425595861;7723.073231212291;7806.882896756553;7836.490628109269;7837.294643482114;3052.3590046090126;3055.3125546751803;3067.7392421643963;3080.7843450958667;3111.4554952883154;832.7335252719192;875.2035647560689;926.0276709455045;996.3573495095768;996.9950150249202;27593;28329.57505637417;28368.85815570909;28444.85777571099;28659.71340286612;902.909709029105;931.2456909903;950.3490109275168;960.2989817433313;992.7716625176106;13878.167309961233;14764.608176116391;14787;14870.851291487163;15031;359736;614503;630275.6972430217;631578;635534;48927;49608.50391496039;49806.0038799222;49853;49887.75056124769;1154.272808130889;1164.871864094949;1172.1794743679459;1182.2788099259444;1207.6799648093263;27758.306042349104;28670.713292866803;29427.264318392212;29895.10314690563;30145.698543015165;42687.35968960406;43508.347374790035;43761.343579846965;43774.12451750883;43777.343339850566;359335;359641;360000;363919;364184;24417.26748197557;25438.491230175663;25452;25515.744842551336;25846.741532584434;41334.1733165341;41336.58663413327;41736.58263417448;41788.79105604452;42346.78826605847;36281.63718362783;36350.09124771902;36472.81763591165;36575.634243658285;37200.44199337066;35316.47025294674;35717.642823572474;35927.1018224536;36121;36324.818375907955;34740;35001.29997400089;35063.82468087745;35351.469727954616;35612.64387356197;31309.217269568442;33283.167920802174;33547.496787547716;33659.32681346311;33868.153296167795;24926.626100608868;25365.239042828744;25566;25619.74380256248;25973.480530389665 06:43:40 INFO - PROCESS | 5701 | |2;jquery.html;363.56553918067914;363.6508951406648;371.65436144385717;377.3095235718635;390.9003204182933;15297.923510382447;16112.51662450127;16551.751723724137;16579.83420165798;16606.50180494587;15527.534173974798;16253.268602912867;16358.100304483249;16468.176591170453;16482.505524834243;4907.1412502812045;5191.896162076775;5197.064528384889;5199.402068762084;5205.947940520584;3676.889693309205;3900.941485877714;5062.544371006608;5693.629914055573;5955.731992060368;6009.308929473101;6016.33820279771;6032.638041717511;6035.185249991261;6041.607295525799;5786.392428794979;5917.644941303514;5934.109883517485;5955.791547295824;5972.6715030673295;5105.387353517602;5219;5221.06020916235;5229.398619158807;5247.658902171346;20230.696539551773;20461.693074603892;20573.279935202347;20658.380248592566;20750.48123796902;1921.5964647424057;1922.3367938061347;1984.642764302425;2062.2885104638876;2433.3551608823677;9007.198560287969;9190.310726695525;9309.674161404386;11621.593244236412;12167.756644867053;1656.9563856893908;1768.8408043276168;1772.831580999803;1883.1902282018727;1886.1323791056132;69924.3007569928;70499;70580;71442;71652.2834771656;9496.335256531976;9813.112132720311;9891.505424728735;10078.19374450057;10105.595776169019;13534.390952407166;13547.932260338832;13549.848262897764;13635.795463068062;13656.180629162282;6214.844628884223;6410.487161027107;6550.279469258473;6574.474042076622;6643.169603799525;5863.765449382062;5946.643201407929;6025.276966764016;6080.513558915276;6099.268087829489;4106.178764247163;4167.97916010418;4226.281532139544;4328.091100868853;4339.435873336446;1702.9829701703072;1705.2582126774892;1805.3590975203876;1805.647898659775;1866.2908094924114;811.2698571285772;885.6988623867916;890.3055616619048;906.7551761024487;918.2424499787702;15702.371905123895;16253.106079165524;16425.09661968579;16710.331586736393;16765.24556394965;807.3057170833079;811.1442428238265;823.0904850140628;845.5476320168681;887.2502735188755;8712.303015758724;9238.722838314861;9268.51703727414;9447;9541.284403669753;362078;363983;365727;368615;369449;73774.63112684402;76329;77794;77914.22085779184;78053.60973195097;871.1114663043786;874.8294082653948;879.3229213505565;883.3021912689032;887.5029983209423;14830.91739376989;14997.625059373602;15056.32246548886;15122.168280744665;15461.922690386476;35283.647163529065;35439.468407973385;35638.64361356457;36765.44851827278;37070.8146459266;50156.74921625369;50427;51637;51673.48326516687;51909;7389.926100738924;7438.404927605887;7610.961945190239;7611.771646850603;7649.273319034683;11221.214514983873;11224;11353.829692554453;11679.883201167879;12089.39553022363;9573.425594464354;9741.610335586498;10025.248106391904;10341.121004714683;10523.210759192938;9934.205263578751;10004.099631033241;10096.545655445376;10188.847167292644;10202.846957295498;9715.36850104741;9753.609855605697;9891.208703303575;10306;10626.309289896131;6584.670766461562;6669.666516674244;6858.485613578901;7530.924690753022;7561.6597253122645;9788.85316720264;10495.790084198426;10507.31702439339;10656.360618362924;10694.091002264584 06:43:40 INFO - PROCESS | 5701 | |3;mootools.html;1335.1721932401908;1364.563339731286;1413.2297897645788;1665.6169081111352;1683.2257161705606;6959.095317608717;7196.892046619305;7248.528845625031;7699.3070623643935;7710.807229819257;7560;7875.80310492238;7887.80280492988;7968.442209045369;8094.109647938737;2097.61194179077;2142.389419015581;2146.1200907627876;2146.37755051035;2147.8389120815923;2083.5416208434194;2109.56753865458;2170.8154806841358;2176.912923483059;2184.421128400975;2129.659254519277;2137.732783402075;2140.5718856228737;2150.9784902151014;2163.080690706451;2085.103405535619;2088.2795435574703;2094.6648536234284;2096.287262330815;2103.7054812326287;2070.9378718638463;2144.1959265275523;2146.431195733132;2148.6132496150685;2150.3011521255653;7883.724069657592;7889.9211007890335;7948.5628290444;7968.442209045369;7985.0417949845805;4325.091730736549;4447.866564003085;4470.351798989161;4474.77626118696;4475.57482039209;2856.0717766725897;2902.985485072561;2910.8690108945148;2940.8382538960564;2940.882364705409;939.375315415248;963.5086106085877;979.6620166042775;1011.7672935224866;1020.4489575629226;10111.3427627204;10127.594896204144;10149.441780702058;10161.949190254001;10222.0289072538;3849.287881741831;4031.9798401007806;4088.8568900088353;4191.245575796325;4196.412502249687;8831.69089081879;8926.464412135292;8955.104489551122;8955.2835773138;8993.685221017364;4435.645148388121;4439.933400998923;4441.489228738672;4442.844500442469;4460.50934397216;3535.487354333607;3669.119411341259;3991.5808840071954;4046.575109613448;4051.1897620476025;3619.2761447710564;3642.7996460194413;3756.417755247941;3759.191773768653;3779.2063666629765;1177.8468799056238;1201.621489230907;1208.2508844516456;1215.8844909733562;1224.1797995342963;805.1143741883998;821.1214001018852;824.8762685597088;826.5784449930578;837.2548431895618;5167.6641018333685;5277;5341.092014357569;5347.786088556414;5364.7049412282695;877.9956100219458;899.8741365469688;942.5899733615762;957.8802649668792;976.345848281653;3405.4551271796395;3548.3790336690977;3606.747527673038;3608.87368942091;3622.492851000862;9578.329516933747;10001.49992500372;10016.449095299682;10043.548040338203;10062.547185376676;9891.208703303719;9973.850392244121;9979.60081596728;10005.44970026641;10013.198944084455;7402.703891844266;7486;7489.138749043821;7501.924980750123;7570.205128461433;5203;5215.947840521698;5229.581633469237;5340.732963351895;5353.955978584138;8695.087015863497;8973.865392019256;9034.322425818222;9085.63657453721;9206.677766278148;8798.47209167452;9174.082591740773;9223.538823058687;9291.442513449214;9330.580123894306;6236.126942228001;6449.129752371759;6671.933280667131;6874.140732408449;6943.930560694328;7326.487145899736;7538.849223015399;7555.811104722426;7841.451098423056;7848.058233012075;6812.386885180357;6903.89644155328;6944.652767361713;7023.157221133497;7134.928650713427;6761.357671021246;6814.93185068143;6888.896666549906;6921.1002569667635;7046.929530704832;6182.05265341416;6195.2875419325555;6262.561620686691;6284.654344010941;6286.717097730521;4490.854832017945;4558.726476411426;4628.352030715635;4651.139539185261;4674.555917187861;4519.887002824956;4643.187442197534;4720.881977950578;4763.809447622057;4851.199552074009 06:43:40 INFO - PROCESS | 5701 | |4;prototype.html;283.3822267456944;287.7180363244021;297.5521839631355;301.9251464785363;302.586968787605;4826.407285595754;4943.826966056189;5015.473375295596;5033.5218154275335;5047.873803154918;4801.111794318053;4902.852914412573;4924.267031797351;4939.703617782936;4940.580050695687;3851.614838516154;3860.691144708431;3867.5358956925206;3884.922301553974;3892.026993251687;3661.5972243053243;3868.845246190163;3895.357266051098;3898.8635397761086;3901.161250331178;3818.5417749870053;3827.406751953438;3837.443570682249;3841.020539762371;3845.6731177849774;3820.541535015802;3826.368649172897;3834.7699138051807;3834.789086600236;3845.1348446599573;3355.2217324817884;3363.445031569788;3366.5960084789735;3372.207531230159;3377.2232386550986;4726.71639701619;4799.376081109468;4821.156297647897;4860.3195552622665;4863.610911127137;4376.474823021226;4380.948572342647;4384.802683879233;4386.824527018915;4387.937669295426;5193;5198.246254293144;5201.24581935621;5212.478752124757;5223.354643287353;3567.4113771227717;3662.981685091584;3664.59689434162;3674.2835147146316;3682.9263414731554;5403.432639572828;5457.754401051962;5461.918071228895;5466.671999680032;5468.179773034037;3754.605766394544;3754.9436758448646;3757.981210093932;3763.040424691741;3764.20951600167;3804.334241507725;3804.505414296124;3805.4101614249835;3806.790626515513;3813.913034785073;4213.073123912734;4321.157374312042;4333.393324934512;4339.869803905888;4365.148795984753;5196.870078247998;5198.16829307309;5208.8437346879655;5214.296070030573;5226.843194704165;1202.4108186988312;1237.307108019512;1240.9813852792036;1260.590308149855;1276.4256084761894;840.9453385529921;868.9695860644847;888.3337496877342;892.8035832116924;895.2032690905099;4403.889902752457;4477.485089214717;4478.619317357996;4486.955130448654;4491.30384790358;5223.9477605223465;5239.554637855748;5246.790128394898;5256.684598924076;5294.788208471618;4489.304157855538;4498.5726355996785;4502.144592527409;4511.120331535385;4523.7285762854335;2386.68973033508;2485.005997600938;2488.825782195265;2498.9750102499106;2507.874606269679;4404.515503294635;4413.911721765611;4414.955850441519;4425.911481770411;4443.8891526525285;4713.387259656222;4727.314539391769;4729;4751.809927602926;4834.444038935497;4148.979255103705;4381.605655491021;4411.272140096912;4414.646828253732;4417.514073451982;4640.535946405333;4658.510856360033;4667.463241727109;4675.812967481399;4681.929771053505;4534.161180181677;4597.402337696212;4606.673629816921;4616.492185859485;4660.533946605312;4087.7751723655483;4386.188555117314;4419.591322729185;4423.225935461346;4455.353973673864;3356.580427446569;3359.126627076929;3362.7477939154173;3366.4781958796425;3374;4648.976755116338;4654.604358629419;4672.602828759594;4696.436427628706;4713.787879545497;4899.603612970429;4973.905740737032;5074.188129899198;5098.923516147335;5132.384113906355;5114.207297868837;5150.356205474316;5164.638475306692;5168.328117344721;5170.560502357342;4884.877878053077;5083.822066227664;5087.567556757717;5089.465606111305;5094.286799848099;5112.795488180431;5133.178691409356;5146.819861304836;5157.638965272395;5187.740612969412;5033.723145227048;5048.192289233705;5050.621203409833;5055.6713813602;5076.543111120017 06:43:40 INFO - PROCESS | 5701 | |5;yui.html;634.5843472525496;730.4813582356527;752.3266676324689;752.6039197289025;782.628251580499;12878.29169395683;13435.26106064166;13757.862421375783;13800.171989680613;14030;13212.867871321283;13528.458861645522;13528.797068043963;13532.985026123055;13533.458661653522;617.7343742190878;709.1383968478298;729.3071581997098;736.4219088015908;737.1117803047315;632.0424556796457;693.2963042511855;723.1105739939877;725.1914115760915;758.0600055930634;809.9392545559107;812.7196117339538;814.1451475950258;815.6003558256441;815.8776183572452;813.2355585749376;814.1776805426532;814.360726829442;814.4339683919678;815.2377527012262;594.9345571987078;596.1653684841214;597.9760809567612;598.267122774602;598.3388355866748;13270.73458530824;13304.534341298007;13323.800142997863;13332.400041998133;13343.065985381027;13336.19982801035;13884.58346249614;14207.289635518286;14349.928250358786;14556.636084097876;10814.783704325948;10841.566337346496;10851.131909447304;10873.456327183689;10900.182486313479;3288.2601414681744;3326.6507016763135;3341.3818443588016;3344.414727422691;3430.1939044324563;62913;63096;64736.3526364735;65810.67094664495;65923.67038164778;9535.47554884474;9732.459664339303;9774.706758797247;9875.358101723365;10311.84532232017;18880.52798680044;18883.90558047201;18885.339013134748;18940.337088201846;18957.24171033171;6757.281166976849;6864.519483636098;6865.41643960269;6878.3465570770695;7034.964825175944;3802.1825307558456;3805.238952209569;3809.733318667722;3915.3735402335487;3945.546262179829;2995.1463832807544;3090.1502086926275;3123.5783169272313;3124.515700066448;3129.749620030392;494.6389135930719;501.7541404711665;515.9122949098662;521.072490966081;522.8745101175766;515.9406668233127;543.9891202175934;575.4619430832186;611.9020956646915;616.7532986805314;8212.384071194565;8717.30261579072;8809.383343166044;8809.779755506164;9032.774180645405;513.3224144129713;558.3746204251183;587.7325816753367;598.2014011294883;599.604261187614;3997.6801855852045;4119.134981653826;4344.283193273074;4379.715318504351;4396.340548917624;83890;95226;95596.52201738946;98084.50957745165;100052;77842;79871.60064199643;81826.59086704528;82023;84342;69326.306736933;69796.6510167446;70821.2917870825;71295.64352178205;71685.64157179077;7813.570253636105;7961;7978.651634859132;8084.353251739729;8196.918030819616;40824.59175408208;40901.59098408978;41676.79161604294;41808.58191418047;42620.78689606532;54725.72637136789;55327.44672553223;61942.38057619366;62031.37968620437;63187.6840615794;9693.673518355685;9789.118979291898;10144.529043288829;10147.18822494184;10582.047615714622;11313.660590181978;11347.54609815598;11477.367729606964;11504.318618042145;11520.193586448868;10644.574217031231;10763.623273185402;10774.138068954622;10937.56249750001;11165.33008019489;10350.585976560853;10402.947985260025;10409.895901040893;10454.215933804842;10984;10730.678079657622;10920.672379828618;10970.396628185206;11136.888631113909;11224.55101795919;8723.69467068675;9024.503652299187;9161.221296189899;9234.261259099121;9406.670766523139;9044.819103618023;9842.65550705722;9850;9866.703998880044;9873.45695986699 06:43:40 INFO - PROCESS | 5701 | __end_tp_report 06:43:40 INFO - PROCESS | 5701 | __start_cc_report 06:43:40 INFO - PROCESS | 5701 | _x_x_mozilla_cycle_collect,347 06:43:40 INFO - PROCESS | 5701 | __end_cc_report 06:43:40 INFO - PROCESS | 5701 | __startTimestamp1475070220017__endTimestamp 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | ------- Summary: start ------- 06:43:40 INFO - PROCESS | 5701 | Number of tests: 6 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | [#0] dojo.html Cycles:165 Average:4774.58 Median:4907.19 stddev:519.42 (10.6%) stddev-sans-first:493.63 06:43:40 INFO - PROCESS | 5701 | Values: 2652.8 2662.0 2671.0 2673.3 2677.4 4744.9 4853.9 4890.5 4892.8 4956.9 4764.3 4796.6 4817.9 4845.7 4924.7 4335.7 4441.4 4446.3 4551.5 4585.0 4521.1 4561.9 4564.2 4568.0 4579.1 4332.0 4338.9 4366.0 4401.5 4453.8 4374.3 4384.3 4429.4 4433.4 4433.8 4324.6 4360.2 4360.5 4377.8 4412.6 4722.3 4729.1 4751.4 4769.3 4816.5 5140.4 5167.8 5175.2 5219.9 5234.9 5199.6 5200.0 5206.2 5212.7 5272.7 4721.6 4772.4 4855.9 4856.9 4858.4 5381.5 5403.2 5444.4 5470.1 5537.6 5173.4 5174.9 5175.5 5176.8 5178.1 4993.5 5076.2 5087.9 5319.4 5353.9 5147.5 5176.7 5195.5 5197.3 5201.3 5052.7 5063.8 5076.8 5110.2 5176.8 4361.6 4364.4 4367.0 4373.4 4419.5 3782.0 3796.4 3816.6 3840.4 3874.3 4305.2 4345.1 4347.6 4399.1 4454.8 5186.1 5188.0 5191.5 5192.6 5243.6 4337.8 4402.9 4404.3 4415.0 4440.9 4553.3 4590.4 4639.5 4655.2 4672.9 4883.2 4891.1 4898.4 4935.7 4955.7 5214.0 5225.3 5227.5 5237.9 5289.5 4755.0 4798.8 4811.9 4894.1 4907.2 5046.1 5134.0 5138.0 5184.2 5192.7 5184.7 5196.9 5197.7 5200.0 5258.4 4893.5 4939.1 4950.4 4991.9 4993.7 4950.1 5005.4 5006.5 5010.4 5077.4 4912.4 4935.9 4938.9 4942.3 5030.0 4896.6 4954.9 4971.3 5007.7 5039.1 4909.1 4926.4 4952.6 4974.7 4986.3 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | [#1] ext.html Cycles:180 Average:52743.79 Median:37348.35 stddev:113520.92 (304.0%) stddev-sans-first:113771.67 06:43:40 INFO - PROCESS | 5701 | Values: 522.8 533.4 537.0 542.5 551.0 38053.6 39948.0 40130.8 40169.4 40326.8 39659.4 40177.2 40191.6 40226.0 40268.8 7680.4 7820.9 7821.9 7836.1 7847.1 7626.6 7715.8 7720.2 7728.6 7732.4 7721.7 7750.8 7752.7 7755.9 7756.1 7632.9 7696.0 7706.5 7729.1 7745.2 7518.6 7583.2 7654.8 7657.2 7670.3 37496.3 37628.4 37895.8 37974.8 37984.4 3101.0 3183.6 3337.4 3409.4 3661.3 28151.0 28458.0 28848.0 28953.6 29965.6 3549.6 3553.3 3615.3 3633.8 3781.5 253564.0 256669.7 256868.0 256969.0 257715.0 30469.2 51840.5 52477.5 52542.5 52641.0 31749.8 32960.7 33281.0 33353.3 33382.7 11475.8 11588.4 11590.9 11600.1 11662.8 9102.7 9132.7 9161.0 9175.4 9197.9 7701.7 7723.1 7806.9 7836.5 7837.3 3052.4 3055.3 3067.7 3080.8 3111.5 832.7 875.2 926.0 996.4 997.0 27593.0 28329.6 28368.9 28444.9 28659.7 902.9 931.2 950.3 960.3 992.8 13878.2 14764.6 14787.0 14870.9 15031.0 359736.0 614503.0 630275.7 631578.0 635534.0 48927.0 49608.5 49806.0 49853.0 49887.8 1154.3 1164.9 1172.2 1182.3 1207.7 27758.3 28670.7 29427.3 29895.1 30145.7 42687.4 43508.3 43761.3 43774.1 43777.3 359335.0 359641.0 360000.0 363919.0 364184.0 24417.3 25438.5 25452.0 25515.7 25846.7 41334.2 41336.6 41736.6 41788.8 42346.8 36281.6 36350.1 36472.8 36575.6 37200.4 35316.5 35717.6 35927.1 36121.0 36324.8 34740.0 35001.3 35063.8 35351.5 35612.6 31309.2 33283.2 33547.5 33659.3 33868.2 24926.6 25365.2 25566.0 25619.7 25973.5 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | [#2] jquery.html Cycles:180 Average:23537.37 Median:50291.87 stddev:60643.04 (120.6%) stddev-sans-first:60788.19 06:43:40 INFO - PROCESS | 5701 | Values: 363.6 363.7 371.7 377.3 390.9 15297.9 16112.5 16551.8 16579.8 16606.5 15527.5 16253.3 16358.1 16468.2 16482.5 4907.1 5191.9 5197.1 5199.4 5205.9 3676.9 3900.9 5062.5 5693.6 5955.7 6009.3 6016.3 6032.6 6035.2 6041.6 5786.4 5917.6 5934.1 5955.8 5972.7 5105.4 5219.0 5221.1 5229.4 5247.7 20230.7 20461.7 20573.3 20658.4 20750.5 1921.6 1922.3 1984.6 2062.3 2433.4 9007.2 9190.3 9309.7 11621.6 12167.8 1657.0 1768.8 1772.8 1883.2 1886.1 69924.3 70499.0 70580.0 71442.0 71652.3 9496.3 9813.1 9891.5 10078.2 10105.6 13534.4 13547.9 13549.8 13635.8 13656.2 6214.8 6410.5 6550.3 6574.5 6643.2 5863.8 5946.6 6025.3 6080.5 6099.3 4106.2 4168.0 4226.3 4328.1 4339.4 1703.0 1705.3 1805.4 1805.6 1866.3 811.3 885.7 890.3 906.8 918.2 15702.4 16253.1 16425.1 16710.3 16765.2 807.3 811.1 823.1 845.5 887.3 8712.3 9238.7 9268.5 9447.0 9541.3 362078.0 363983.0 365727.0 368615.0 369449.0 73774.6 76329.0 77794.0 77914.2 78053.6 871.1 874.8 879.3 883.3 887.5 14830.9 14997.6 15056.3 15122.2 15461.9 35283.6 35439.5 35638.6 36765.4 37070.8 50156.7 50427.0 51637.0 51673.5 51909.0 7389.9 7438.4 7611.0 7611.8 7649.3 11221.2 11224.0 11353.8 11679.9 12089.4 9573.4 9741.6 10025.2 10341.1 10523.2 9934.2 10004.1 10096.5 10188.8 10202.8 9715.4 9753.6 9891.2 10306.0 10626.3 6584.7 6669.7 6858.5 7530.9 7561.7 9788.9 10495.8 10507.3 10656.4 10694.1 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | [#3] mootools.html Cycles:180 Average:5142.39 Median:4742.35 stddev:2898.53 (61.1%) stddev-sans-first:2892.54 06:43:40 INFO - PROCESS | 5701 | Values: 1335.2 1364.6 1413.2 1665.6 1683.2 6959.1 7196.9 7248.5 7699.3 7710.8 7560.0 7875.8 7887.8 7968.4 8094.1 2097.6 2142.4 2146.1 2146.4 2147.8 2083.5 2109.6 2170.8 2176.9 2184.4 2129.7 2137.7 2140.6 2151.0 2163.1 2085.1 2088.3 2094.7 2096.3 2103.7 2070.9 2144.2 2146.4 2148.6 2150.3 7883.7 7889.9 7948.6 7968.4 7985.0 4325.1 4447.9 4470.4 4474.8 4475.6 2856.1 2903.0 2910.9 2940.8 2940.9 939.4 963.5 979.7 1011.8 1020.4 10111.3 10127.6 10149.4 10161.9 10222.0 3849.3 4032.0 4088.9 4191.2 4196.4 8831.7 8926.5 8955.1 8955.3 8993.7 4435.6 4439.9 4441.5 4442.8 4460.5 3535.5 3669.1 3991.6 4046.6 4051.2 3619.3 3642.8 3756.4 3759.2 3779.2 1177.8 1201.6 1208.3 1215.9 1224.2 805.1 821.1 824.9 826.6 837.3 5167.7 5277.0 5341.1 5347.8 5364.7 878.0 899.9 942.6 957.9 976.3 3405.5 3548.4 3606.7 3608.9 3622.5 9578.3 10001.5 10016.4 10043.5 10062.5 9891.2 9973.9 9979.6 10005.4 10013.2 7402.7 7486.0 7489.1 7501.9 7570.2 5203.0 5215.9 5229.6 5340.7 5354.0 8695.1 8973.9 9034.3 9085.6 9206.7 8798.5 9174.1 9223.5 9291.4 9330.6 6236.1 6449.1 6671.9 6874.1 6943.9 7326.5 7538.8 7555.8 7841.5 7848.1 6812.4 6903.9 6944.7 7023.2 7134.9 6761.4 6814.9 6888.9 6921.1 7046.9 6182.1 6195.3 6262.6 6284.7 6286.7 4490.9 4558.7 4628.4 4651.1 4674.6 4519.9 4643.2 4720.9 4763.8 4851.2 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | [#4] prototype.html Cycles:180 Average:4137.82 Median:4494.94 stddev:1203.40 (26.8%) stddev-sans-first:1171.48 06:43:40 INFO - PROCESS | 5701 | Values: 283.4 287.7 297.6 301.9 302.6 4826.4 4943.8 5015.5 5033.5 5047.9 4801.1 4902.9 4924.3 4939.7 4940.6 3851.6 3860.7 3867.5 3884.9 3892.0 3661.6 3868.8 3895.4 3898.9 3901.2 3818.5 3827.4 3837.4 3841.0 3845.7 3820.5 3826.4 3834.8 3834.8 3845.1 3355.2 3363.4 3366.6 3372.2 3377.2 4726.7 4799.4 4821.2 4860.3 4863.6 4376.5 4380.9 4384.8 4386.8 4387.9 5193.0 5198.2 5201.2 5212.5 5223.4 3567.4 3663.0 3664.6 3674.3 3682.9 5403.4 5457.8 5461.9 5466.7 5468.2 3754.6 3754.9 3758.0 3763.0 3764.2 3804.3 3804.5 3805.4 3806.8 3813.9 4213.1 4321.2 4333.4 4339.9 4365.1 5196.9 5198.2 5208.8 5214.3 5226.8 1202.4 1237.3 1241.0 1260.6 1276.4 840.9 869.0 888.3 892.8 895.2 4403.9 4477.5 4478.6 4487.0 4491.3 5223.9 5239.6 5246.8 5256.7 5294.8 4489.3 4498.6 4502.1 4511.1 4523.7 2386.7 2485.0 2488.8 2499.0 2507.9 4404.5 4413.9 4415.0 4425.9 4443.9 4713.4 4727.3 4729.0 4751.8 4834.4 4149.0 4381.6 4411.3 4414.6 4417.5 4640.5 4658.5 4667.5 4675.8 4681.9 4534.2 4597.4 4606.7 4616.5 4660.5 4087.8 4386.2 4419.6 4423.2 4455.4 3356.6 3359.1 3362.7 3366.5 3374.0 4649.0 4654.6 4672.6 4696.4 4713.8 4899.6 4973.9 5074.2 5098.9 5132.4 5114.2 5150.4 5164.6 5168.3 5170.6 4884.9 5083.8 5087.6 5089.5 5094.3 5112.8 5133.2 5146.8 5157.6 5187.7 5033.7 5048.2 5050.6 5055.7 5076.5 06:43:40 INFO - PROCESS | 5701 | 06:43:40 INFO - PROCESS | 5701 | [#5] yui.html Cycles:180 Average:17298.18 Median:566.92 stddev:24526.50 (4326.3%) stddev-sans-first:24563.39 06:43:40 INFO - PROCESS | 5701 | Values: 634.6 730.5 752.3 752.6 782.6 12878.3 13435.3 13757.9 13800.2 14030.0 13212.9 13528.5 13528.8 13533.0 13533.5 617.7 709.1 729.3 736.4 737.1 632.0 693.3 723.1 725.2 758.1 809.9 812.7 814.1 815.6 815.9 813.2 814.2 814.4 814.4 815.2 594.9 596.2 598.0 598.3 598.3 13270.7 13304.5 13323.8 13332.4 13343.1 13336.2 13884.6 14207.3 14349.9 14556.6 10814.8 10841.6 10851.1 10873.5 10900.2 3288.3 3326.7 3341.4 3344.4 3430.2 62913.0 63096.0 64736.4 65810.7 65923.7 9535.5 9732.5 9774.7 9875.4 10311.8 18880.5 18883.9 18885.3 18940.3 18957.2 6757.3 6864.5 6865.4 6878.3 7035.0 3802.2 3805.2 3809.7 3915.4 3945.5 2995.1 3090.2 3123.6 3124.5 3129.7 494.6 501.8 515.9 521.1 522.9 515.9 544.0 575.5 611.9 616.8 8212.4 8717.3 8809.4 8809.8 9032.8 513.3 558.4 587.7 598.2 599.6 3997.7 4119.1 4344.3 4379.7 4396.3 83890.0 95226.0 95596.5 98084.5 100052.0 77842.0 79871.6 81826.6 82023.0 84342.0 69326.3 69796.7 70821.3 71295.6 71685.6 7813.6 7961.0 7978.7 8084.4 8196.9 40824.6 40901.6 41676.8 41808.6 42620.8 54725.7 55327.4 61942.4 62031.4 63187.7 9693.7 9789.1 10144.5 10147.2 10582.0 11313.7 11347.5 11477.4 11504.3 11520.2 10644.6 10763.6 10774.1 10937.6 11165.3 10350.6 10402.9 10409.9 10454.2 10984.0 10730.7 10920.7 10970.4 11136.9 11224.6 8723.7 9024.5 9161.2 9234.3 9406.7 9044.8 9842.7 9850.0 9866.7 9873.5 06:43:40 INFO - PROCESS | 5701 | -------- Summary: end -------- 06:43:40 INFO - PROCESS | 5701 | 06:43:41 INFO - TEST-INFO | 5701: exit 0 06:43:41 INFO - TEST-OK | dromaeo_css | took 1118466ms 06:43:41 INFO - TEST-START | kraken 06:43:41 INFO - operating with platform_type : linux_ 06:43:41 INFO - Initialising browser for kraken test... 06:43:41 INFO - TEST-INFO | started process 6056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZGTDw/profile http://localhost:36894/getInfo.html) 06:43:45 INFO - PROCESS | 6056 | __metrics Screen width/height:1600/1200 06:43:45 INFO - PROCESS | 6056 | colorDepth:24 06:43:45 INFO - PROCESS | 6056 | Browser inner width/height: 1024/697 06:43:45 INFO - PROCESS | 6056 | __metrics 06:43:46 ERROR - PROCESS | 6056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:43:46 INFO - TEST-INFO | 6056: exit 0 06:43:46 INFO - Browser initialized. 06:43:46 INFO - Running cycle 1/1 for kraken test... 06:43:46 INFO - TEST-INFO | started process 6179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZGTDw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:59 INFO - PROCESS | 6179 | RSS: Main: 186441728 06:43:59 INFO - PROCESS | 6179 | 06:44:02 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:03 INFO - PROCESS | 6179 | RSS: Main: 200163328 06:44:03 INFO - PROCESS | 6179 | 06:44:06 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-dft) 06:44:06 INFO - PROCESS | 6179 | RSS: Main: 197861376 06:44:06 INFO - PROCESS | 6179 | 06:44:09 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-fft) 06:44:10 INFO - PROCESS | 6179 | RSS: Main: 194375680 06:44:10 INFO - PROCESS | 6179 | 06:44:12 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-oscillator) 06:44:13 INFO - PROCESS | 6179 | RSS: Main: 194596864 06:44:13 INFO - PROCESS | 6179 | 06:44:15 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:15 INFO - PROCESS | 6179 | RSS: Main: 194891776 06:44:15 INFO - PROCESS | 6179 | 06:44:19 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:19 INFO - PROCESS | 6179 | RSS: Main: 195231744 06:44:19 INFO - PROCESS | 6179 | 06:44:23 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:23 INFO - PROCESS | 6179 | RSS: Main: 193126400 06:44:23 INFO - PROCESS | 6179 | 06:44:26 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36894/tests/kraken/driver.html?testName=json-parse-financial) 06:44:27 INFO - PROCESS | 6179 | RSS: Main: 194445312 06:44:27 INFO - PROCESS | 6179 | 06:44:29 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:29 INFO - PROCESS | 6179 | RSS: Main: 194351104 06:44:29 INFO - PROCESS | 6179 | 06:44:31 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:44:32 INFO - PROCESS | 6179 | RSS: Main: 194162688 06:44:32 INFO - PROCESS | 6179 | 06:44:34 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:44:35 INFO - PROCESS | 6179 | RSS: Main: 195051520 06:44:35 INFO - PROCESS | 6179 | 06:44:38 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:44:38 INFO - PROCESS | 6179 | RSS: Main: 195088384 06:44:38 INFO - PROCESS | 6179 | 06:44:41 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:44:42 INFO - PROCESS | 6179 | RSS: Main: 195350528 06:44:42 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36894/tests/kraken/driver.html?testName=ai-astar) 06:44:44 INFO - PROCESS | 6179 | RSS: Main: 197578752 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | __start_tp_report 06:44:44 INFO - PROCESS | 6179 | _x_x_mozilla_page_load 06:44:44 INFO - PROCESS | 6179 | _x_x_mozilla_page_load_details 06:44:44 INFO - PROCESS | 6179 | |i|pagename|runs| 06:44:44 INFO - PROCESS | 6179 | |0;ai-astar;106;115;115;113;114;113;114;114;113;113 06:44:44 INFO - PROCESS | 6179 | |1;audio-beat-detection;154;130;130;178;129;129;132;126;158;126 06:44:44 INFO - PROCESS | 6179 | |2;audio-dft;167;171;163;162;163;164;163;163;166;164 06:44:44 INFO - PROCESS | 6179 | |3;audio-fft;77;78;78;107;77;77;78;77;104;79 06:44:44 INFO - PROCESS | 6179 | |4;audio-oscillator;84;83;123;83;83;84;102;83;83;107 06:44:44 INFO - PROCESS | 6179 | |5;imaging-gaussian-blur;118;118;117;118;118;118;119;118;118;118 06:44:44 INFO - PROCESS | 6179 | |6;imaging-darkroom;148;148;146;148;147;148;148;150;149;149 06:44:44 INFO - PROCESS | 6179 | |7;imaging-desaturate;95;98;97;96;96;97;97;97;96;96 06:44:44 INFO - PROCESS | 6179 | |8;json-parse-financial;71;66;65;65;66;70;65;67;66;69 06:44:44 INFO - PROCESS | 6179 | |9;json-stringify-tinderbox;65;68;66;66;68;66;67;67;66;67 06:44:44 INFO - PROCESS | 6179 | |10;stanford-crypto-aes;83;82;83;83;85;85;85;82;83;82 06:44:44 INFO - PROCESS | 6179 | |11;stanford-crypto-ccm;138;136;139;137;136;141;152;136;183;134 06:44:44 INFO - PROCESS | 6179 | |12;stanford-crypto-pbkdf2;178;178;175;175;178;175;173;179;178;174 06:44:44 INFO - PROCESS | 6179 | |13;stanford-crypto-sha256-iterative;76;68;71;71;71;69;71;70;69;74 06:44:44 INFO - PROCESS | 6179 | __end_tp_report 06:44:44 INFO - PROCESS | 6179 | __start_cc_report 06:44:44 INFO - PROCESS | 6179 | _x_x_mozilla_cycle_collect,857 06:44:44 INFO - PROCESS | 6179 | __end_cc_report 06:44:44 INFO - PROCESS | 6179 | __startTimestamp1475070284567__endTimestamp 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | ------- Summary: start ------- 06:44:44 INFO - PROCESS | 6179 | Number of tests: 14 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 06:44:44 INFO - PROCESS | 6179 | Values: 106.0 115.0 115.0 113.0 114.0 113.0 114.0 114.0 113.0 113.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:131.00 stddev:17.81 (13.6%) stddev-sans-first:18.07 06:44:44 INFO - PROCESS | 6179 | Values: 154.0 130.0 130.0 178.0 129.0 129.0 132.0 126.0 158.0 126.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.72 (1.7%) stddev-sans-first:2.74 06:44:44 INFO - PROCESS | 6179 | Values: 167.0 171.0 163.0 162.0 163.0 164.0 163.0 163.0 166.0 164.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.50 stddev:11.79 (15.2%) stddev-sans-first:12.29 06:44:44 INFO - PROCESS | 6179 | Values: 77.0 78.0 78.0 107.0 77.0 77.0 78.0 77.0 104.0 79.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:14.21 (17.1%) stddev-sans-first:14.81 06:44:44 INFO - PROCESS | 6179 | Values: 84.0 83.0 123.0 83.0 83.0 84.0 102.0 83.0 83.0 107.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:44:44 INFO - PROCESS | 6179 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 06:44:44 INFO - PROCESS | 6179 | Values: 148.0 148.0 146.0 148.0 147.0 148.0 148.0 150.0 149.0 149.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 06:44:44 INFO - PROCESS | 6179 | Values: 95.0 98.0 97.0 96.0 96.0 97.0 97.0 97.0 96.0 96.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.50 stddev:2.21 (3.3%) stddev-sans-first:1.81 06:44:44 INFO - PROCESS | 6179 | Values: 71.0 66.0 65.0 65.0 66.0 70.0 65.0 67.0 66.0 69.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 06:44:44 INFO - PROCESS | 6179 | Values: 65.0 68.0 66.0 66.0 68.0 66.0 67.0 67.0 66.0 67.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 06:44:44 INFO - PROCESS | 6179 | Values: 83.0 82.0 83.0 83.0 85.0 85.0 85.0 82.0 83.0 82.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:138.50 stddev:14.87 (10.7%) stddev-sans-first:15.65 06:44:44 INFO - PROCESS | 6179 | Values: 138.0 136.0 139.0 137.0 136.0 141.0 152.0 136.0 183.0 134.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:178.00 stddev:2.11 (1.2%) stddev-sans-first:2.15 06:44:44 INFO - PROCESS | 6179 | Values: 178.0 178.0 175.0 175.0 178.0 175.0 173.0 179.0 178.0 174.0 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:2.40 (3.4%) stddev-sans-first:1.74 06:44:44 INFO - PROCESS | 6179 | Values: 76.0 68.0 71.0 71.0 71.0 69.0 71.0 70.0 69.0 74.0 06:44:44 INFO - PROCESS | 6179 | -------- Summary: end -------- 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | 06:44:44 INFO - PROCESS | 6179 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 06:44:44 INFO - PROCESS | 6179 | 06:44:45 INFO - TEST-INFO | 6179: exit 0 06:44:45 INFO - TEST-OK | kraken | took 64722ms 06:44:45 INFO - SUITE-END | took 1183s 06:44:46 INFO - Completed test suite (00:19:43) 06:44:46 INFO - javascript benchmark 06:44:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6321.714528643975, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.801039922006, 2662.0416650006, 2670.9983756091465, 2673.278214881982, 2677.3708178578036, 4744.928826067612, 4853.878653033676, 4890.462049174597, 4892.828750993716, 4956.900861982758, 4764.285357196422, 4796.640251981098, 4817.855464336076, 4845.733484658343, 4924.729139897304, 4335.6965012449145, 4441.4004109445295, 4446.310821822606, 4551.476580193287, 4584.97707511462, 4521.095780843828, 4561.908761824761, 4564.246899261634, 4567.972206253583, 4579.107074120548, 4332.0, 4338.934915976263, 4366.039471316305, 4401.5378385269405, 4453.755043472608, 4374.300111982067, 4384.254676704936, 4429.446319210098, 4433.423654924839, 4433.844815431445, 4324.567543245682, 4360.209465941768, 4360.542143074963, 4377.846775362847, 4412.580804823537, 4722.268048452495, 4729.077829823186, 4751.3585665935, 4769.332293478916, 4816.54242846929, 5140.357455318085, 5167.793288268503, 5175.171972484422, 5219.921701174486, 5234.895302093975, 5199.610029247784, 5199.974000129975, 5206.219067139959, 5212.661177023481, 5272.683638981635, 4721.598664113589, 4772.3557319762085, 4855.927161092586, 4856.902861942776, 4858.416989961227, 5381.461853814587, 5403.162509810985, 5444.40111587725, 5470.097433923358, 5537.640053396597, 5173.379194496609, 5174.896502069938, 5175.4565770593545, 5176.844694659091, 5178.119719647669, 4993.50064993505, 5076.162433198481, 5087.949120508822, 5319.388270348882, 5353.892922141536, 5147.459516750762, 5176.663516871391, 5195.454477279831, 5197.298364720715, 5201.271821944931, 5052.696838189647, 5063.772130254148, 5076.796928122833, 5110.233464980282, 5176.767045482962, 4361.5856493633055, 4364.41080454141, 4367.039251364695, 4373.3877257183385, 4419.46966364032, 3781.9810900945868, 3796.354619714655, 3816.6183381662167, 3840.3663395539425, 3874.3413619684156, 4305.246581848164, 4345.065810850682, 4347.6304514116655, 4399.098184872094, 4454.77726113693, 5186.118359878829, 5187.974060129751, 5191.480851914778, 5192.584593232532, 5243.632945693841, 4337.8264869404875, 4402.911941761211, 4404.273294906305, 4414.955850441519, 4440.911181776346, 4553.3397657340165, 4590.357349971006, 4639.536046395334, 4655.162070827284, 4672.883177920579, 4883.243097319921, 4891.070696567641, 4898.387701537308, 4935.679180853233, 4955.72743499111, 5214.0, 5225.346831646044, 5227.503387178212, 5237.869053273698, 5289.523942845162, 4754.952450475589, 4798.832040878552, 4811.927821082757, 4894.094592500399, 4907.190313598359, 5046.091703493406, 5134.0, 5137.974310128426, 5184.196449550326, 5192.714400707997, 5184.688918664892, 5196.896062078662, 5197.688138711689, 5199.974000129975, 5258.395284542174, 4893.510648935078, 4939.086269040239, 4950.405951285725, 4991.850244492671, 4993.725345106054, 4950.084234416644, 5005.424376196784, 5006.524380183877, 5010.423801262901, 5077.416097148875, 4912.435069966999, 4935.901281974412, 4938.851834444972, 4942.332785073969, 5030.044291584587, 4896.6327525436445, 4954.900901981868, 4971.328870602422, 5007.749612519432, 5039.0929632666475, 4909.0672772173175, 4926.433460152129, 4952.5542701157065, 4974.726390048582, 4986.326845875906], "value": 4740.368426067154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.7699812082685, 533.3839415475126, 537.0440615704043, 542.4656713137559, 550.9889802203955, 38053.61946380536, 39948.0, 40130.79934600327, 40169.39745903814, 40326.7983660082, 39659.40510892339, 40177.19645607086, 40191.59808401922, 40226.0, 40268.79865600675, 7680.385569154454, 7820.921790782077, 7821.8826717598995, 7836.098848632395, 7847.058352997648, 7626.6186690665245, 7715.807104822368, 7720.189380115091, 7728.613569321511, 7732.420068494857, 7721.72973945912, 7750.767476975671, 7752.651130699132, 7755.88366174505, 7756.146823849372, 7632.923670763277, 7695.961520192392, 7706.537607743498, 7729.111152217511, 7745.22547745221, 7518.624068796593, 7583.241675832428, 7654.8469030619635, 7657.157712651604, 7670.30967212948, 37496.25007499862, 37628.43557346642, 37895.810520947496, 37974.81012594947, 37984.43023354652, 3100.953485697716, 3183.554302397666, 3337.4493208620547, 3409.4203985322306, 3661.2677464506937, 28151.0, 28458.0, 28848.0, 28953.565696514568, 29965.550516742267, 3549.6272891346293, 3553.34263161316, 3615.349237137314, 3633.8001409922445, 3781.5273090863643, 253564.0, 256669.7166514174, 256868.0, 256969.0, 257715.0, 30469.23826904345, 51840.48159518432, 52477.47522524726, 52542.47457525452, 52641.0, 31749.841250793597, 32960.67039329624, 33281.0, 33353.3329333412, 33382.66617333796, 11475.827862582068, 11588.36264005471, 11590.88409115898, 11600.129990250765, 11662.766744665229, 9102.726918192464, 9132.680356187502, 9161.0, 9175.403598766192, 9197.908020919838, 7701.653425595861, 7723.073231212291, 7806.882896756553, 7836.490628109269, 7837.294643482114, 3052.3590046090126, 3055.3125546751803, 3067.7392421643963, 3080.7843450958667, 3111.4554952883154, 832.7335252719192, 875.2035647560689, 926.0276709455045, 996.3573495095768, 996.9950150249202, 27593.0, 28329.57505637417, 28368.85815570909, 28444.85777571099, 28659.71340286612, 902.909709029105, 931.2456909903, 950.3490109275168, 960.2989817433313, 992.7716625176106, 13878.167309961233, 14764.608176116391, 14787.0, 14870.851291487163, 15031.0, 359736.0, 614503.0, 630275.6972430217, 631578.0, 635534.0, 48927.0, 49608.50391496039, 49806.0038799222, 49853.0, 49887.75056124769, 1154.272808130889, 1164.871864094949, 1172.1794743679459, 1182.2788099259444, 1207.6799648093263, 27758.306042349104, 28670.713292866803, 29427.264318392212, 29895.10314690563, 30145.698543015165, 42687.35968960406, 43508.347374790035, 43761.343579846965, 43774.12451750883, 43777.343339850566, 359335.0, 359641.0, 360000.0, 363919.0, 364184.0, 24417.26748197557, 25438.491230175663, 25452.0, 25515.744842551336, 25846.741532584434, 41334.1733165341, 41336.58663413327, 41736.58263417448, 41788.79105604452, 42346.78826605847, 36281.63718362783, 36350.09124771902, 36472.81763591165, 36575.634243658285, 37200.44199337066, 35316.47025294674, 35717.642823572474, 35927.1018224536, 36121.0, 36324.818375907955, 34740.0, 35001.29997400089, 35063.82468087745, 35351.469727954616, 35612.64387356197, 31309.217269568442, 33283.167920802174, 33547.496787547716, 33659.32681346311, 33868.153296167795, 24926.626100608868, 25365.239042828744, 25566.0, 25619.74380256248, 25973.480530389665], "value": 16539.072772888307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.56553918067914, 363.6508951406648, 371.65436144385717, 377.3095235718635, 390.9003204182933, 15297.923510382447, 16112.51662450127, 16551.751723724137, 16579.83420165798, 16606.50180494587, 15527.534173974798, 16253.268602912867, 16358.100304483249, 16468.176591170453, 16482.505524834243, 4907.1412502812045, 5191.896162076775, 5197.064528384889, 5199.402068762084, 5205.947940520584, 3676.889693309205, 3900.941485877714, 5062.544371006608, 5693.629914055573, 5955.731992060368, 6009.308929473101, 6016.33820279771, 6032.638041717511, 6035.185249991261, 6041.607295525799, 5786.392428794979, 5917.644941303514, 5934.109883517485, 5955.791547295824, 5972.6715030673295, 5105.387353517602, 5219.0, 5221.06020916235, 5229.398619158807, 5247.658902171346, 20230.696539551773, 20461.693074603892, 20573.279935202347, 20658.380248592566, 20750.48123796902, 1921.5964647424057, 1922.3367938061347, 1984.642764302425, 2062.2885104638876, 2433.3551608823677, 9007.198560287969, 9190.310726695525, 9309.674161404386, 11621.593244236412, 12167.756644867053, 1656.9563856893908, 1768.8408043276168, 1772.831580999803, 1883.1902282018727, 1886.1323791056132, 69924.3007569928, 70499.0, 70580.0, 71442.0, 71652.2834771656, 9496.335256531976, 9813.112132720311, 9891.505424728735, 10078.19374450057, 10105.595776169019, 13534.390952407166, 13547.932260338832, 13549.848262897764, 13635.795463068062, 13656.180629162282, 6214.844628884223, 6410.487161027107, 6550.279469258473, 6574.474042076622, 6643.169603799525, 5863.765449382062, 5946.643201407929, 6025.276966764016, 6080.513558915276, 6099.268087829489, 4106.178764247163, 4167.97916010418, 4226.281532139544, 4328.091100868853, 4339.435873336446, 1702.9829701703072, 1705.2582126774892, 1805.3590975203876, 1805.647898659775, 1866.2908094924114, 811.2698571285772, 885.6988623867916, 890.3055616619048, 906.7551761024487, 918.2424499787702, 15702.371905123895, 16253.106079165524, 16425.09661968579, 16710.331586736393, 16765.24556394965, 807.3057170833079, 811.1442428238265, 823.0904850140628, 845.5476320168681, 887.2502735188755, 8712.303015758724, 9238.722838314861, 9268.51703727414, 9447.0, 9541.284403669753, 362078.0, 363983.0, 365727.0, 368615.0, 369449.0, 73774.63112684402, 76329.0, 77794.0, 77914.22085779184, 78053.60973195097, 871.1114663043786, 874.8294082653948, 879.3229213505565, 883.3021912689032, 887.5029983209423, 14830.91739376989, 14997.625059373602, 15056.32246548886, 15122.168280744665, 15461.922690386476, 35283.647163529065, 35439.468407973385, 35638.64361356457, 36765.44851827278, 37070.8146459266, 50156.74921625369, 50427.0, 51637.0, 51673.48326516687, 51909.0, 7389.926100738924, 7438.404927605887, 7610.961945190239, 7611.771646850603, 7649.273319034683, 11221.214514983873, 11224.0, 11353.829692554453, 11679.883201167879, 12089.39553022363, 9573.425594464354, 9741.610335586498, 10025.248106391904, 10341.121004714683, 10523.210759192938, 9934.205263578751, 10004.099631033241, 10096.545655445376, 10188.847167292644, 10202.846957295498, 9715.36850104741, 9753.609855605697, 9891.208703303575, 10306.0, 10626.309289896131, 6584.670766461562, 6669.666516674244, 6858.485613578901, 7530.924690753022, 7561.6597253122645, 9788.85316720264, 10495.790084198426, 10507.31702439339, 10656.360618362924, 10694.091002264584], "value": 8094.15034532675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.1721932401908, 1364.563339731286, 1413.2297897645788, 1665.6169081111352, 1683.2257161705606, 6959.095317608717, 7196.892046619305, 7248.528845625031, 7699.3070623643935, 7710.807229819257, 7560.0, 7875.80310492238, 7887.80280492988, 7968.442209045369, 8094.109647938737, 2097.61194179077, 2142.389419015581, 2146.1200907627876, 2146.37755051035, 2147.8389120815923, 2083.5416208434194, 2109.56753865458, 2170.8154806841358, 2176.912923483059, 2184.421128400975, 2129.659254519277, 2137.732783402075, 2140.5718856228737, 2150.9784902151014, 2163.080690706451, 2085.103405535619, 2088.2795435574703, 2094.6648536234284, 2096.287262330815, 2103.7054812326287, 2070.9378718638463, 2144.1959265275523, 2146.431195733132, 2148.6132496150685, 2150.3011521255653, 7883.724069657592, 7889.9211007890335, 7948.5628290444, 7968.442209045369, 7985.0417949845805, 4325.091730736549, 4447.866564003085, 4470.351798989161, 4474.77626118696, 4475.57482039209, 2856.0717766725897, 2902.985485072561, 2910.8690108945148, 2940.8382538960564, 2940.882364705409, 939.375315415248, 963.5086106085877, 979.6620166042775, 1011.7672935224866, 1020.4489575629226, 10111.3427627204, 10127.594896204144, 10149.441780702058, 10161.949190254001, 10222.0289072538, 3849.287881741831, 4031.9798401007806, 4088.8568900088353, 4191.245575796325, 4196.412502249687, 8831.69089081879, 8926.464412135292, 8955.104489551122, 8955.2835773138, 8993.685221017364, 4435.645148388121, 4439.933400998923, 4441.489228738672, 4442.844500442469, 4460.50934397216, 3535.487354333607, 3669.119411341259, 3991.5808840071954, 4046.575109613448, 4051.1897620476025, 3619.2761447710564, 3642.7996460194413, 3756.417755247941, 3759.191773768653, 3779.2063666629765, 1177.8468799056238, 1201.621489230907, 1208.2508844516456, 1215.8844909733562, 1224.1797995342963, 805.1143741883998, 821.1214001018852, 824.8762685597088, 826.5784449930578, 837.2548431895618, 5167.6641018333685, 5277.0, 5341.092014357569, 5347.786088556414, 5364.7049412282695, 877.9956100219458, 899.8741365469688, 942.5899733615762, 957.8802649668792, 976.345848281653, 3405.4551271796395, 3548.3790336690977, 3606.747527673038, 3608.87368942091, 3622.492851000862, 9578.329516933747, 10001.49992500372, 10016.449095299682, 10043.548040338203, 10062.547185376676, 9891.208703303719, 9973.850392244121, 9979.60081596728, 10005.44970026641, 10013.198944084455, 7402.703891844266, 7486.0, 7489.138749043821, 7501.924980750123, 7570.205128461433, 5203.0, 5215.947840521698, 5229.581633469237, 5340.732963351895, 5353.955978584138, 8695.087015863497, 8973.865392019256, 9034.322425818222, 9085.63657453721, 9206.677766278148, 8798.47209167452, 9174.082591740773, 9223.538823058687, 9291.442513449214, 9330.580123894306, 6236.126942228001, 6449.129752371759, 6671.933280667131, 6874.140732408449, 6943.930560694328, 7326.487145899736, 7538.849223015399, 7555.811104722426, 7841.451098423056, 7848.058233012075, 6812.386885180357, 6903.89644155328, 6944.652767361713, 7023.157221133497, 7134.928650713427, 6761.357671021246, 6814.93185068143, 6888.896666549906, 6921.1002569667635, 7046.929530704832, 6182.05265341416, 6195.2875419325555, 6262.561620686691, 6284.654344010941, 6286.717097730521, 4490.854832017945, 4558.726476411426, 4628.352030715635, 4651.139539185261, 4674.555917187861, 4519.887002824956, 4643.187442197534, 4720.881977950578, 4763.809447622057, 4851.199552074009], "value": 4142.062301285731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.3822267456944, 287.7180363244021, 297.5521839631355, 301.9251464785363, 302.586968787605, 4826.407285595754, 4943.826966056189, 5015.473375295596, 5033.5218154275335, 5047.873803154918, 4801.111794318053, 4902.852914412573, 4924.267031797351, 4939.703617782936, 4940.580050695687, 3851.614838516154, 3860.691144708431, 3867.5358956925206, 3884.922301553974, 3892.026993251687, 3661.5972243053243, 3868.845246190163, 3895.357266051098, 3898.8635397761086, 3901.161250331178, 3818.5417749870053, 3827.406751953438, 3837.443570682249, 3841.020539762371, 3845.6731177849774, 3820.541535015802, 3826.368649172897, 3834.7699138051807, 3834.789086600236, 3845.1348446599573, 3355.2217324817884, 3363.445031569788, 3366.5960084789735, 3372.207531230159, 3377.2232386550986, 4726.71639701619, 4799.376081109468, 4821.156297647897, 4860.3195552622665, 4863.610911127137, 4376.474823021226, 4380.948572342647, 4384.802683879233, 4386.824527018915, 4387.937669295426, 5193.0, 5198.246254293144, 5201.24581935621, 5212.478752124757, 5223.354643287353, 3567.4113771227717, 3662.981685091584, 3664.59689434162, 3674.2835147146316, 3682.9263414731554, 5403.432639572828, 5457.754401051962, 5461.918071228895, 5466.671999680032, 5468.179773034037, 3754.605766394544, 3754.9436758448646, 3757.981210093932, 3763.040424691741, 3764.20951600167, 3804.334241507725, 3804.505414296124, 3805.4101614249835, 3806.790626515513, 3813.913034785073, 4213.073123912734, 4321.157374312042, 4333.393324934512, 4339.869803905888, 4365.148795984753, 5196.870078247998, 5198.16829307309, 5208.8437346879655, 5214.296070030573, 5226.843194704165, 1202.4108186988312, 1237.307108019512, 1240.9813852792036, 1260.590308149855, 1276.4256084761894, 840.9453385529921, 868.9695860644847, 888.3337496877342, 892.8035832116924, 895.2032690905099, 4403.889902752457, 4477.485089214717, 4478.619317357996, 4486.955130448654, 4491.30384790358, 5223.9477605223465, 5239.554637855748, 5246.790128394898, 5256.684598924076, 5294.788208471618, 4489.304157855538, 4498.5726355996785, 4502.144592527409, 4511.120331535385, 4523.7285762854335, 2386.68973033508, 2485.005997600938, 2488.825782195265, 2498.9750102499106, 2507.874606269679, 4404.515503294635, 4413.911721765611, 4414.955850441519, 4425.911481770411, 4443.8891526525285, 4713.387259656222, 4727.314539391769, 4729.0, 4751.809927602926, 4834.444038935497, 4148.979255103705, 4381.605655491021, 4411.272140096912, 4414.646828253732, 4417.514073451982, 4640.535946405333, 4658.510856360033, 4667.463241727109, 4675.812967481399, 4681.929771053505, 4534.161180181677, 4597.402337696212, 4606.673629816921, 4616.492185859485, 4660.533946605312, 4087.7751723655483, 4386.188555117314, 4419.591322729185, 4423.225935461346, 4455.353973673864, 3356.580427446569, 3359.126627076929, 3362.7477939154173, 3366.4781958796425, 3374.0, 4648.976755116338, 4654.604358629419, 4672.602828759594, 4696.436427628706, 4713.787879545497, 4899.603612970429, 4973.905740737032, 5074.188129899198, 5098.923516147335, 5132.384113906355, 5114.207297868837, 5150.356205474316, 5164.638475306692, 5168.328117344721, 5170.560502357342, 4884.877878053077, 5083.822066227664, 5087.567556757717, 5089.465606111305, 5094.286799848099, 5112.795488180431, 5133.178691409356, 5146.819861304836, 5157.638965272395, 5187.740612969412, 5033.723145227048, 5048.192289233705, 5050.621203409833, 5055.6713813602, 5076.543111120017], "value": 3755.602853086277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.5843472525496, 730.4813582356527, 752.3266676324689, 752.6039197289025, 782.628251580499, 12878.29169395683, 13435.26106064166, 13757.862421375783, 13800.171989680613, 14030.0, 13212.867871321283, 13528.458861645522, 13528.797068043963, 13532.985026123055, 13533.458661653522, 617.7343742190878, 709.1383968478298, 729.3071581997098, 736.4219088015908, 737.1117803047315, 632.0424556796457, 693.2963042511855, 723.1105739939877, 725.1914115760915, 758.0600055930634, 809.9392545559107, 812.7196117339538, 814.1451475950258, 815.6003558256441, 815.8776183572452, 813.2355585749376, 814.1776805426532, 814.360726829442, 814.4339683919678, 815.2377527012262, 594.9345571987078, 596.1653684841214, 597.9760809567612, 598.267122774602, 598.3388355866748, 13270.73458530824, 13304.534341298007, 13323.800142997863, 13332.400041998133, 13343.065985381027, 13336.19982801035, 13884.58346249614, 14207.289635518286, 14349.928250358786, 14556.636084097876, 10814.783704325948, 10841.566337346496, 10851.131909447304, 10873.456327183689, 10900.182486313479, 3288.2601414681744, 3326.6507016763135, 3341.3818443588016, 3344.414727422691, 3430.1939044324563, 62913.0, 63096.0, 64736.3526364735, 65810.67094664495, 65923.67038164778, 9535.47554884474, 9732.459664339303, 9774.706758797247, 9875.358101723365, 10311.84532232017, 18880.52798680044, 18883.90558047201, 18885.339013134748, 18940.337088201846, 18957.24171033171, 6757.281166976849, 6864.519483636098, 6865.41643960269, 6878.3465570770695, 7034.964825175944, 3802.1825307558456, 3805.238952209569, 3809.733318667722, 3915.3735402335487, 3945.546262179829, 2995.1463832807544, 3090.1502086926275, 3123.5783169272313, 3124.515700066448, 3129.749620030392, 494.6389135930719, 501.7541404711665, 515.9122949098662, 521.072490966081, 522.8745101175766, 515.9406668233127, 543.9891202175934, 575.4619430832186, 611.9020956646915, 616.7532986805314, 8212.384071194565, 8717.30261579072, 8809.383343166044, 8809.779755506164, 9032.774180645405, 513.3224144129713, 558.3746204251183, 587.7325816753367, 598.2014011294883, 599.604261187614, 3997.6801855852045, 4119.134981653826, 4344.283193273074, 4379.715318504351, 4396.340548917624, 83890.0, 95226.0, 95596.52201738946, 98084.50957745165, 100052.0, 77842.0, 79871.60064199643, 81826.59086704528, 82023.0, 84342.0, 69326.306736933, 69796.6510167446, 70821.2917870825, 71295.64352178205, 71685.64157179077, 7813.570253636105, 7961.0, 7978.651634859132, 8084.353251739729, 8196.918030819616, 40824.59175408208, 40901.59098408978, 41676.79161604294, 41808.58191418047, 42620.78689606532, 54725.72637136789, 55327.44672553223, 61942.38057619366, 62031.37968620437, 63187.6840615794, 9693.673518355685, 9789.118979291898, 10144.529043288829, 10147.18822494184, 10582.047615714622, 11313.660590181978, 11347.54609815598, 11477.367729606964, 11504.318618042145, 11520.193586448868, 10644.574217031231, 10763.623273185402, 10774.138068954622, 10937.56249750001, 11165.33008019489, 10350.585976560853, 10402.947985260025, 10409.895901040893, 10454.215933804842, 10984.0, 10730.678079657622, 10920.672379828618, 10970.396628185206, 11136.888631113909, 11224.55101795919, 8723.69467068675, 9024.503652299187, 9161.221296189899, 9234.261259099121, 9406.670766523139, 9044.819103618023, 9842.65550705722, 9850.0, 9866.703998880044, 9873.45695986699], "value": 6465.044013132049, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 130.0, 178.0, 129.0, 129.0, 132.0, 126.0, 158.0, 126.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 163.0, 162.0, 163.0, 164.0, 163.0, 163.0, 166.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 107.0, 77.0, 77.0, 78.0, 77.0, 104.0, 79.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 123.0, 83.0, 83.0, 84.0, 102.0, 83.0, 83.0, 107.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 148.0, 147.0, 148.0, 148.0, 150.0, 149.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 65.0, 65.0, 66.0, 70.0, 65.0, 67.0, 66.0, 69.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 66.0, 68.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 85.0, 85.0, 85.0, 82.0, 83.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 139.0, 137.0, 136.0, 141.0, 152.0, 136.0, 183.0, 134.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 175.0, 175.0, 178.0, 175.0, 173.0, 179.0, 178.0, 174.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 68.0, 71.0, 71.0, 71.0, 69.0, 71.0, 70.0, 69.0, 74.0], "value": 71.0, "unit": "score"}]}]} 06:44:46 INFO - Return code: 0 06:44:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:44:46 ERROR - # TBPL SUCCESS # 06:44:46 INFO - Running post-action listener: _resource_record_post_action 06:44:46 INFO - [mozharness: 2016-09-28 13:44:46.359799Z] Finished run-tests step (success) 06:44:46 INFO - Running post-run listener: _resource_record_post_run 06:44:46 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404168704; Read time: 12; Write time: 242092 06:44:46 INFO - TinderboxPrint: CPU usage
13.4% 06:44:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:44:46 INFO - TinderboxPrint: I/O write bytes / time
404,168,704 / 242,092 06:44:46 INFO - TinderboxPrint: CPU idle
8,283.5 (86.6%) 06:44:46 INFO - TinderboxPrint: CPU user
1,224.9 (12.8%) 06:44:46 INFO - TinderboxPrint: Swap in / out
0 / 0 06:44:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110436352; Read time: 0; Write time: 53316 06:44:46 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 293732352; Read time: 0; Write time: 188776 06:44:47 INFO - Running post-run listener: _upload_blobber_files 06:44:47 INFO - Blob upload gear active. 06:44:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:44:47 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 06:44:47 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'] 06:44:47 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 06:44:47 INFO - (blobuploader) - INFO - Open directory for files ... 06:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:48 INFO - (blobuploader) - INFO - Done attempting. 06:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:51 INFO - (blobuploader) - INFO - Done attempting. 06:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:52 INFO - (blobuploader) - INFO - Done attempting. 06:44:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:44:52 INFO - Return code: 0 06:44:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:44:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:44:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/94ef17feaf3465972ead3c845bfcbb84d2056fca5407d08f1afdab82adf4a12dd0d8f69828c66cdb2508af7c5ebdc4168cc61d735d1d0d4e3bccd42031025145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b4a98d85d774be4a2f3900eccd9ce38caec6c4a7925ac9428916475b5f3de8d01a020b878067cfdd928ef6d89c83ae965d55404ec044422a2358311d5b63f5ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d60af9935a37748d4e26229e99a5917b9368a877ca52123fd5915a5ab4cf96ec98d80dcdbf7515bba09b7e1fa6e12220d8825e2a29e6957901be72997f0dcaa3"} 06:44:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:44:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:44:52 INFO - Contents: 06:44:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/94ef17feaf3465972ead3c845bfcbb84d2056fca5407d08f1afdab82adf4a12dd0d8f69828c66cdb2508af7c5ebdc4168cc61d735d1d0d4e3bccd42031025145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b4a98d85d774be4a2f3900eccd9ce38caec6c4a7925ac9428916475b5f3de8d01a020b878067cfdd928ef6d89c83ae965d55404ec044422a2358311d5b63f5ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d60af9935a37748d4e26229e99a5917b9368a877ca52123fd5915a5ab4cf96ec98d80dcdbf7515bba09b7e1fa6e12220d8825e2a29e6957901be72997f0dcaa3"} 06:44:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:44:52 INFO - Copying logs to upload dir... 06:44:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:44:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.764654 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 06:44:52.144864) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 06:44:52.148544) ========= 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-1475065001.553071-878618973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/94ef17feaf3465972ead3c845bfcbb84d2056fca5407d08f1afdab82adf4a12dd0d8f69828c66cdb2508af7c5ebdc4168cc61d735d1d0d4e3bccd42031025145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b4a98d85d774be4a2f3900eccd9ce38caec6c4a7925ac9428916475b5f3de8d01a020b878067cfdd928ef6d89c83ae965d55404ec044422a2358311d5b63f5ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d60af9935a37748d4e26229e99a5917b9368a877ca52123fd5915a5ab4cf96ec98d80dcdbf7515bba09b7e1fa6e12220d8825e2a29e6957901be72997f0dcaa3"} build_url:https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/MbMYR-TWSW2M0seK5kgrJg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/94ef17feaf3465972ead3c845bfcbb84d2056fca5407d08f1afdab82adf4a12dd0d8f69828c66cdb2508af7c5ebdc4168cc61d735d1d0d4e3bccd42031025145", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b4a98d85d774be4a2f3900eccd9ce38caec6c4a7925ac9428916475b5f3de8d01a020b878067cfdd928ef6d89c83ae965d55404ec044422a2358311d5b63f5ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d60af9935a37748d4e26229e99a5917b9368a877ca52123fd5915a5ab4cf96ec98d80dcdbf7515bba09b7e1fa6e12220d8825e2a29e6957901be72997f0dcaa3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 06:44:52.180214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:44:52.180573) ========= 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-1475065001.553071-878618973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:44:52.261969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 06:44:52.262762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 06:44:52.263443) ========= ========= Total master_lag: 0.19 =========