builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1474682717.79 results: success (0) buildid: 20160923184124 builduid: d738e0ee1be54d9abbde2b60f2bf26a3 revision: 1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.794275) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.794820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.795190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.810270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.810613) ========= 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=523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 19:05:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.4M=0s 2016-09-23 19:05:19 (96.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.983503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:17.983841) ========= 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=523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013929 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.054459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.054816) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f --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 1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f --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=523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 19:05:19,202 truncating revision to first 12 chars 2016-09-23 19:05:19,202 Setting DEBUG logging. 2016-09-23 19:05:19,202 attempt 1/10 2016-09-23 19:05:19,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1e8a7c6dcea1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 19:05:19,766 unpacking tar archive at: autoland-1e8a7c6dcea1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.964720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.964996) ========= script_repo_revision: 1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.965372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.965637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 19:05:18.975833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-23 19:05:18.976111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:20 INFO - MultiFileLogger online at 20160923 19:05:20 in /builds/slave/test 19:05:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 19:05:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:20 INFO - {'append_to_log': False, 19:05:20 INFO - 'base_work_dir': '/builds/slave/test', 19:05:20 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 19:05:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:20 INFO - 'branch': 'Autoland-Non-PGO', 19:05:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:20 INFO - 'config_files': ('talos/linux_config.py',), 19:05:20 INFO - 'default_actions': ('clobber', 19:05:20 INFO - 'read-buildbot-config', 19:05:20 INFO - 'download-and-extract', 19:05:20 INFO - 'populate-webroot', 19:05:20 INFO - 'create-virtualenv', 19:05:20 INFO - 'install', 19:05:20 INFO - 'run-tests'), 19:05:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:20 INFO - 'download_minidump_stackwalk': True, 19:05:20 INFO - 'download_symbols': 'ondemand', 19:05:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:20 INFO - 'installer_path': 'installer.exe', 19:05:20 INFO - 'log_level': 'info', 19:05:20 INFO - 'log_name': 'talos', 19:05:20 INFO - 'log_to_console': True, 19:05:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:20 INFO - 'opt_config_files': (), 19:05:20 INFO - 'pip_index': False, 19:05:20 INFO - 'sps_profile': False, 19:05:20 INFO - 'sps_profile_interval': 0, 19:05:20 INFO - 'suite': 'dromaeojs', 19:05:20 INFO - 'system_bits': '32', 19:05:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:20 INFO - 'title': 'talos-linux64-ix-065', 19:05:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:20 INFO - 'use_talos_json': True, 19:05:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:20 INFO - 'work_dir': 'build'} 19:05:20 INFO - [mozharness: 2016-09-24 02:05:20.217713Z] Running clobber step. 19:05:20 INFO - Running pre-action listener: _resource_record_pre_action 19:05:20 INFO - Running main action method: clobber 19:05:20 INFO - rmtree: /builds/slave/test/build 19:05:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:21 INFO - Running post-action listener: _resource_record_post_action 19:05:21 INFO - [mozharness: 2016-09-24 02:05:21.208946Z] Finished clobber step (success) 19:05:21 INFO - [mozharness: 2016-09-24 02:05:21.209047Z] Running read-buildbot-config step. 19:05:21 INFO - Running pre-action listener: _resource_record_pre_action 19:05:21 INFO - Running main action method: read_buildbot_config 19:05:21 INFO - Using buildbot properties: 19:05:21 INFO - { 19:05:21 INFO - "project": "", 19:05:21 INFO - "product": "firefox", 19:05:21 INFO - "script_repo_revision": "production", 19:05:21 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 19:05:21 INFO - "repository": "", 19:05:21 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 19:05:21 INFO - "buildid": "20160923184124", 19:05:21 INFO - "pgo_build": "False", 19:05:21 INFO - "basedir": "/builds/slave/test", 19:05:21 INFO - "buildnumber": 517, 19:05:21 INFO - "slavename": "talos-linux64-ix-065", 19:05:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:05:21 INFO - "platform": "ubuntu64_hw", 19:05:21 INFO - "scheduler": "tests-autoland-linux64-talos", 19:05:21 INFO - "branch": "autoland", 19:05:21 INFO - "repo_path": "integration/autoland", 19:05:21 INFO - "revision": "1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f", 19:05:21 INFO - "stage_platform": "linux64", 19:05:21 INFO - "builduid": "d738e0ee1be54d9abbde2b60f2bf26a3", 19:05:21 INFO - "slavebuilddir": "test" 19:05:21 INFO - } 19:05:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:05:21 INFO - Running post-action listener: _resource_record_post_action 19:05:21 INFO - [mozharness: 2016-09-24 02:05:21.211520Z] Finished read-buildbot-config step (success) 19:05:21 INFO - [mozharness: 2016-09-24 02:05:21.211607Z] Running download-and-extract step. 19:05:21 INFO - Running pre-action listener: _resource_record_pre_action 19:05:21 INFO - Running main action method: download_and_extract 19:05:21 INFO - mkdir: /builds/slave/test/build/tests 19:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:21 INFO - trying https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:05:21 INFO - Downloading https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/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 19:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/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 19:05:21 INFO - Downloaded 1361 bytes. 19:05:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:05:21 INFO - Using the following test package requirements: 19:05:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:05:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:05:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:05:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'jsshell-linux-x86_64.zip'], 19:05:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:05:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:05:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:05:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:05:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:05:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:05:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:05:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:05:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:05:21 INFO - Fetch https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:05:22 INFO - Expected file size: 20378004 19:05:26 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 19:05:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:05:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:05:26 INFO - Fetch https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:05:27 INFO - Expected file size: 20378004 19:05:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:05:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:05:31 INFO - Fetch https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:05:32 INFO - Expected file size: 14414059 19:05: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')]} 19:05:32 INFO - trying https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:05:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/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 19:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/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 19:05:34 INFO - Downloaded 55728262 bytes. 19:05:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:05:34 INFO - mkdir: /builds/slave/test/properties 19:05:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:34 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:34 INFO - Contents: 19:05:34 INFO - build_url:https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:05:34 INFO - Running post-action listener: _resource_record_post_action 19:05:34 INFO - Running post-action listener: set_extra_try_arguments 19:05:34 INFO - [mozharness: 2016-09-24 02:05:34.703755Z] Finished download-and-extract step (success) 19:05:34 INFO - [mozharness: 2016-09-24 02:05:34.703982Z] Running populate-webroot step. 19:05:34 INFO - Running pre-action listener: _resource_record_pre_action 19:05:34 INFO - Running main action method: populate_webroot 19:05:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:34 INFO - '--tppagecycles', 19:05:34 INFO - '7'], 19:05:34 INFO - 'tests': ['tsvgm']}}, 19:05:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:05:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:05:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:05:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['damp', 'tps']}, 19:05:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'tests': ['damp', 'tps']}, 19:05:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['dromaeo_dom']}, 19:05:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['basic_compositor_video']}, 19:05:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:05:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['a11yr', 19:05:34 INFO - 'ts_paint', 19:05:34 INFO - 'tpaint', 19:05:34 INFO - 'sessionrestore', 19:05:34 INFO - 'sessionrestore_no_auto_restore', 19:05:34 INFO - 'tabpaint']}, 19:05:34 INFO - 'other-e10s': {'tests': ['a11yr', 19:05:34 INFO - 'ts_paint', 19:05:34 INFO - 'tpaint', 19:05:34 INFO - 'sessionrestore', 19:05:34 INFO - 'sessionrestore_no_auto_restore', 19:05:34 INFO - 'tabpaint']}, 19:05:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:05:34 INFO - 'ts_paint', 19:05:34 INFO - 'tpaint', 19:05:34 INFO - 'sessionrestore', 19:05:34 INFO - 'sessionrestore_no_auto_restore', 19:05:34 INFO - 'tabpaint']}, 19:05:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:05:34 INFO - 'ts_paint', 19:05:34 INFO - 'tpaint', 19:05:34 INFO - 'sessionrestore', 19:05:34 INFO - 'sessionrestore_no_auto_restore', 19:05:34 INFO - 'tabpaint']}, 19:05:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['a11yr', 19:05:34 INFO - 'ts_paint', 19:05:34 INFO - 'tpaint', 19:05:34 INFO - 'sessionrestore', 19:05:34 INFO - 'sessionrestore_no_auto_restore', 19:05:34 INFO - 'tabpaint']}, 19:05:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['a11yr', 19:05:34 INFO - 'ts_paint', 19:05:34 INFO - 'tpaint', 19:05:34 INFO - 'sessionrestore', 19:05:34 INFO - 'sessionrestore_no_auto_restore', 19:05:34 INFO - 'tabpaint']}, 19:05:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['tsvgx', 19:05:34 INFO - 'tsvgr_opacity', 19:05:34 INFO - 'tart', 19:05:34 INFO - 'tscrollx', 19:05:34 INFO - 'cart']}, 19:05:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:05:34 INFO - 'tsvgr_opacity', 19:05:34 INFO - 'tart', 19:05:34 INFO - 'tscrollx', 19:05:34 INFO - 'cart']}, 19:05:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'talos_options': ['--disable-e10s'], 19:05:34 INFO - 'tests': ['tp5o']}, 19:05:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'tests': ['tp5o']}, 19:05:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'talos_options': ['--disable-e10s', 19:05:34 INFO - '--xperf_path', 19:05:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:34 INFO - 'tests': ['tp5n']}, 19:05:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:34 INFO - 'talos_options': ['--xperf_path', 19:05:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:34 INFO - 'tests': ['tp5n']}}, 19:05:34 INFO - 'talos.zip': {'path': '', 19:05:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:34 INFO - Running post-action listener: _resource_record_post_action 19:05:34 INFO - [mozharness: 2016-09-24 02:05:34.719479Z] Finished populate-webroot step (success) 19:05:34 INFO - [mozharness: 2016-09-24 02:05:34.719567Z] Running create-virtualenv step. 19:05:34 INFO - Running pre-action listener: _resource_record_pre_action 19:05:34 INFO - Running main action method: create_virtualenv 19:05:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:34 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 19:05:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:34 INFO - Using real prefix '/usr' 19:05:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:37 INFO - Installing pip.................done. 19:05:37 INFO - Return code: 0 19:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:05:37 INFO - Reading from file tmpfile_stdout 19:05:37 INFO - Output received: 19:05:37 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) 19:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:37 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 19:05:37 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 19:05:37 INFO - Using env: {'DISPLAY': ':0', 19:05:37 INFO - 'HOME': '/home/cltbld', 19:05:37 INFO - 'LANG': 'en_US.UTF-8', 19:05:37 INFO - 'LANGUAGE': 'en_US:en', 19:05:37 INFO - 'LOGNAME': 'cltbld', 19:05:37 INFO - 'MAIL': '/var/mail/cltbld', 19:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:37 INFO - 'MOZ_NO_REMOTE': '1', 19:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:37 INFO - 'NO_EM_RESTART': '1', 19:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:37 INFO - 'PWD': '/builds/slave/test', 19:05:37 INFO - 'SHELL': '/bin/bash', 19:05:37 INFO - 'SHLVL': '1', 19:05:37 INFO - 'TERM': 'linux', 19:05:37 INFO - 'TMOUT': '86400', 19:05:37 INFO - 'USER': 'cltbld', 19:05:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:37 INFO - '_': '/tools/buildbot/bin/python'} 19:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:37 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 19:05:37 INFO - Cleaning up... 19:05:37 INFO - Return code: 0 19:05:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:37 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:37 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 19:05:37 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 19:05:37 INFO - Using env: {'DISPLAY': ':0', 19:05:37 INFO - 'HOME': '/home/cltbld', 19:05:37 INFO - 'LANG': 'en_US.UTF-8', 19:05:37 INFO - 'LANGUAGE': 'en_US:en', 19:05:37 INFO - 'LOGNAME': 'cltbld', 19:05:37 INFO - 'MAIL': '/var/mail/cltbld', 19:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:37 INFO - 'MOZ_NO_REMOTE': '1', 19:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:37 INFO - 'NO_EM_RESTART': '1', 19:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:37 INFO - 'PWD': '/builds/slave/test', 19:05:37 INFO - 'SHELL': '/bin/bash', 19:05:37 INFO - 'SHLVL': '1', 19:05:37 INFO - 'TERM': 'linux', 19:05:37 INFO - 'TMOUT': '86400', 19:05:37 INFO - 'USER': 'cltbld', 19:05:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:37 INFO - '_': '/tools/buildbot/bin/python'} 19:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:37 INFO - Downloading/unpacking psutil>=3.1.1 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:39 INFO - Installing collected packages: psutil 19:05:39 INFO - Running setup.py install for psutil 19:05:39 INFO - building 'psutil._psutil_linux' extension 19:05:39 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 19:05:40 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 19:05:40 INFO - building 'psutil._psutil_posix' extension 19:05:40 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 19:05:40 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 19:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:40 INFO - Successfully installed psutil 19:05:40 INFO - Cleaning up... 19:05:40 INFO - Return code: 0 19:05:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:05:40 INFO - Using env: {'DISPLAY': ':0', 19:05:40 INFO - 'HOME': '/home/cltbld', 19:05:40 INFO - 'LANG': 'en_US.UTF-8', 19:05:40 INFO - 'LANGUAGE': 'en_US:en', 19:05:40 INFO - 'LOGNAME': 'cltbld', 19:05:40 INFO - 'MAIL': '/var/mail/cltbld', 19:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:40 INFO - 'MOZ_NO_REMOTE': '1', 19:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:40 INFO - 'NO_EM_RESTART': '1', 19:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:40 INFO - 'PWD': '/builds/slave/test', 19:05:40 INFO - 'SHELL': '/bin/bash', 19:05:40 INFO - 'SHLVL': '1', 19:05:40 INFO - 'TERM': 'linux', 19:05:40 INFO - 'TMOUT': '86400', 19:05:40 INFO - 'USER': 'cltbld', 19:05:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:40 INFO - '_': '/tools/buildbot/bin/python'} 19:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:05:40 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 19:05:40 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 19:05:40 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 19:05:40 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 19:05:40 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 19:05:40 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 19:05:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:05:42 INFO - Installing collected packages: mozsystemmonitor 19:05:42 INFO - Running setup.py install for mozsystemmonitor 19:05:42 INFO - Successfully installed mozsystemmonitor 19:05:42 INFO - Cleaning up... 19:05:42 INFO - Return code: 0 19:05:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:42 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:42 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 19:05:42 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 19:05:42 INFO - Using env: {'DISPLAY': ':0', 19:05:42 INFO - 'HOME': '/home/cltbld', 19:05:42 INFO - 'LANG': 'en_US.UTF-8', 19:05:42 INFO - 'LANGUAGE': 'en_US:en', 19:05:42 INFO - 'LOGNAME': 'cltbld', 19:05:42 INFO - 'MAIL': '/var/mail/cltbld', 19:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:42 INFO - 'MOZ_NO_REMOTE': '1', 19:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:42 INFO - 'NO_EM_RESTART': '1', 19:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:42 INFO - 'PWD': '/builds/slave/test', 19:05:42 INFO - 'SHELL': '/bin/bash', 19:05:42 INFO - 'SHLVL': '1', 19:05:42 INFO - 'TERM': 'linux', 19:05:42 INFO - 'TMOUT': '86400', 19:05:42 INFO - 'USER': 'cltbld', 19:05:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:42 INFO - '_': '/tools/buildbot/bin/python'} 19:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:42 INFO - Downloading/unpacking jsonschema==2.5.1 19:05:42 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 19:05:42 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 19:05:42 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 19:05:42 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 19:05:42 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 19:05:42 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 19:05:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05:44 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 19:05:44 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 19:05:44 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 19:05:44 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 19:05:44 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 19:05:44 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 19:05:45 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:45 INFO - warning: no files found matching '*.txt' 19:05:45 INFO - no previously-included directories found matching 'build' 19:05:45 INFO - no previously-included directories found matching 'dist' 19:05:45 INFO - no previously-included directories found matching '.git*' 19:05:45 INFO - Installing collected packages: jsonschema, functools32 19:05:45 INFO - Running setup.py install for functools32 19:05:45 INFO - warning: no files found matching '*.txt' 19:05:45 INFO - no previously-included directories found matching 'build' 19:05:45 INFO - no previously-included directories found matching 'dist' 19:05:45 INFO - no previously-included directories found matching '.git*' 19:05:45 INFO - Successfully installed jsonschema functools32 19:05:45 INFO - Cleaning up... 19:05:45 INFO - Return code: 0 19:05:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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', '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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:05: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 functools32==3.2.3-2 19:05:45 INFO - Using env: {'DISPLAY': ':0', 19:05:45 INFO - 'HOME': '/home/cltbld', 19:05:45 INFO - 'LANG': 'en_US.UTF-8', 19:05:45 INFO - 'LANGUAGE': 'en_US:en', 19:05:45 INFO - 'LOGNAME': 'cltbld', 19:05:45 INFO - 'MAIL': '/var/mail/cltbld', 19:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:45 INFO - 'MOZ_NO_REMOTE': '1', 19:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:45 INFO - 'NO_EM_RESTART': '1', 19:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:45 INFO - 'PWD': '/builds/slave/test', 19:05:45 INFO - 'SHELL': '/bin/bash', 19:05:45 INFO - 'SHLVL': '1', 19:05:45 INFO - 'TERM': 'linux', 19:05:45 INFO - 'TMOUT': '86400', 19:05:45 INFO - 'USER': 'cltbld', 19:05:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:45 INFO - '_': '/tools/buildbot/bin/python'} 19:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:05:45 INFO - Cleaning up... 19:05:45 INFO - Return code: 0 19:05:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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', '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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:05: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 blobuploader==1.2.4 19:05:45 INFO - Using env: {'DISPLAY': ':0', 19:05:45 INFO - 'HOME': '/home/cltbld', 19:05:45 INFO - 'LANG': 'en_US.UTF-8', 19:05:45 INFO - 'LANGUAGE': 'en_US:en', 19:05:45 INFO - 'LOGNAME': 'cltbld', 19:05:45 INFO - 'MAIL': '/var/mail/cltbld', 19:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:45 INFO - 'MOZ_NO_REMOTE': '1', 19:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:45 INFO - 'NO_EM_RESTART': '1', 19:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:45 INFO - 'PWD': '/builds/slave/test', 19:05:45 INFO - 'SHELL': '/bin/bash', 19:05:45 INFO - 'SHLVL': '1', 19:05:45 INFO - 'TERM': 'linux', 19:05:45 INFO - 'TMOUT': '86400', 19:05:45 INFO - 'USER': 'cltbld', 19:05:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:45 INFO - '_': '/tools/buildbot/bin/python'} 19:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:45 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 19:05:45 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 19:05:45 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 19:05:45 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 19:05:45 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 19:05:45 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 19:05:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:47 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 19:05:47 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 19:05:47 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 19:05:47 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 19:05:47 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 19:05:47 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 19:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:48 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 19:05:48 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 19:05:48 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 19:05:48 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 19:05:48 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 19:05:48 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 19:05:48 INFO - Downloading docopt-0.6.1.tar.gz 19:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:48 INFO - Running setup.py install for blobuploader 19:05:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:48 INFO - Running setup.py install for requests 19:05:48 INFO - Running setup.py install for docopt 19:05:48 INFO - Successfully installed blobuploader requests docopt 19:05:48 INFO - Cleaning up... 19:05:49 INFO - Return code: 0 19:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:49 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')]} 19:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:49 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')]} 19:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:49 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:49 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 19:05:49 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 19:05:49 INFO - Using env: {'DISPLAY': ':0', 19:05:49 INFO - 'HOME': '/home/cltbld', 19:05:49 INFO - 'LANG': 'en_US.UTF-8', 19:05:49 INFO - 'LANGUAGE': 'en_US:en', 19:05:49 INFO - 'LOGNAME': 'cltbld', 19:05:49 INFO - 'MAIL': '/var/mail/cltbld', 19:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:49 INFO - 'MOZ_NO_REMOTE': '1', 19:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:49 INFO - 'NO_EM_RESTART': '1', 19:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:49 INFO - 'PWD': '/builds/slave/test', 19:05:49 INFO - 'SHELL': '/bin/bash', 19:05:49 INFO - 'SHLVL': '1', 19:05:49 INFO - 'TERM': 'linux', 19:05:49 INFO - 'TMOUT': '86400', 19:05:49 INFO - 'USER': 'cltbld', 19:05:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:49 INFO - '_': '/tools/buildbot/bin/python'} 19:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:49 INFO - Running setup.py (path:/tmp/pip-LDwxv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:49 INFO - Running setup.py (path:/tmp/pip-ZKWCCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:49 INFO - Running setup.py (path:/tmp/pip-LO7gxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:49 INFO - Running setup.py (path:/tmp/pip-x6MPeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:49 INFO - Running setup.py (path:/tmp/pip-gJKfFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:49 INFO - Running setup.py (path:/tmp/pip-f8M78H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:49 INFO - Running setup.py (path:/tmp/pip-ksOoJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:49 INFO - Running setup.py (path:/tmp/pip-m4s9c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:49 INFO - Running setup.py (path:/tmp/pip-Q97xYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:49 INFO - Running setup.py (path:/tmp/pip-TaVdYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:49 INFO - Running setup.py (path:/tmp/pip-ludDgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:50 INFO - Running setup.py (path:/tmp/pip-QWwnGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:50 INFO - Running setup.py (path:/tmp/pip-FjSpCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:50 INFO - Running setup.py (path:/tmp/pip-LUSMMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:50 INFO - Running setup.py (path:/tmp/pip-qsAAtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:50 INFO - Running setup.py (path:/tmp/pip-7IgDyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:50 INFO - Running setup.py (path:/tmp/pip-9YIIaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:50 INFO - Running setup.py install for manifestparser 19:05:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:50 INFO - Running setup.py install for mozcrash 19:05:50 INFO - Running setup.py install for mozdebug 19:05:50 INFO - Running setup.py install for mozdevice 19:05:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:50 INFO - Running setup.py install for mozfile 19:05:50 INFO - Running setup.py install for mozhttpd 19:05:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozinfo 19:05:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozInstall 19:05:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozleak 19:05:51 INFO - Running setup.py install for mozlog 19:05:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for moznetwork 19:05:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozprocess 19:05:51 INFO - Running setup.py install for mozprofile 19:05:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozrunner 19:05:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:51 INFO - Running setup.py install for mozscreenshot 19:05:52 INFO - Running setup.py install for moztest 19:05:52 INFO - Running setup.py install for mozversion 19:05:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:52 INFO - Cleaning up... 19:05:52 INFO - Return code: 0 19:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:52 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')]} 19:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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')]} 19:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:52 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 19:05:52 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 19:05:52 INFO - Using env: {'DISPLAY': ':0', 19:05:52 INFO - 'HOME': '/home/cltbld', 19:05:52 INFO - 'LANG': 'en_US.UTF-8', 19:05:52 INFO - 'LANGUAGE': 'en_US:en', 19:05:52 INFO - 'LOGNAME': 'cltbld', 19:05:52 INFO - 'MAIL': '/var/mail/cltbld', 19:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:52 INFO - 'MOZ_NO_REMOTE': '1', 19:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:52 INFO - 'NO_EM_RESTART': '1', 19:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:52 INFO - 'PWD': '/builds/slave/test', 19:05:52 INFO - 'SHELL': '/bin/bash', 19:05:52 INFO - 'SHLVL': '1', 19:05:52 INFO - 'TERM': 'linux', 19:05:52 INFO - 'TMOUT': '86400', 19:05:52 INFO - 'USER': 'cltbld', 19:05:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:52 INFO - '_': '/tools/buildbot/bin/python'} 19:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:52 INFO - Running setup.py (path:/tmp/pip-bLo8q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:52 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)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:52 INFO - Running setup.py (path:/tmp/pip-e9jXaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:52 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)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:52 INFO - Running setup.py (path:/tmp/pip-O01k2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:52 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)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:52 INFO - Running setup.py (path:/tmp/pip-JLnJyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:52 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)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:52 INFO - Running setup.py (path:/tmp/pip-xk_32g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:52 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)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:52 INFO - Running setup.py (path:/tmp/pip-P8Z3HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:52 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)) 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:52 INFO - Running setup.py (path:/tmp/pip-5Y_4KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:53 INFO - Running setup.py (path:/tmp/pip-EqbDSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:53 INFO - Running setup.py (path:/tmp/pip-SQlFlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:53 INFO - Running setup.py (path:/tmp/pip-AAPcdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:53 INFO - Running setup.py (path:/tmp/pip-CI5ihv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:53 INFO - Running setup.py (path:/tmp/pip-ok66uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:53 INFO - Running setup.py (path:/tmp/pip-hFap_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:53 INFO - Running setup.py (path:/tmp/pip-kntEZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:53 INFO - Running setup.py (path:/tmp/pip-batQc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:53 INFO - Running setup.py (path:/tmp/pip-6bgX1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:53 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)) 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:53 INFO - Running setup.py (path:/tmp/pip-UUBbaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:53 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)) 19:05:53 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)) 19:05:53 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)) 19:05:53 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)) 19:05:53 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)) 19:05:53 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)) 19:05:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:53 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 19:05:53 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 19:05:53 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 19:05:53 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 19:05:53 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 19:05:53 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 19:05:55 INFO - Downloading blessings-1.6.tar.gz 19:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:55 INFO - Installing collected packages: blessings 19:05:55 INFO - Running setup.py install for blessings 19:05:55 INFO - Successfully installed blessings 19:05:55 INFO - Cleaning up... 19:05:55 INFO - Return code: 0 19:05:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:56 INFO - Reading from file tmpfile_stdout 19:05:56 INFO - Current package versions: 19:05:56 INFO - argparse == 1.2.1 19:05:56 INFO - blessings == 1.6 19:05:56 INFO - blobuploader == 1.2.4 19:05:56 INFO - docopt == 0.6.1 19:05:56 INFO - functools32 == 3.2.3-2 19:05:56 INFO - jsonschema == 2.5.1 19:05:56 INFO - manifestparser == 1.1 19:05:56 INFO - mozInstall == 1.12 19:05:56 INFO - mozcrash == 0.17 19:05:56 INFO - mozdebug == 0.1 19:05:56 INFO - mozdevice == 0.48 19:05:56 INFO - mozfile == 1.2 19:05:56 INFO - mozhttpd == 0.7 19:05:56 INFO - mozinfo == 0.9 19:05:56 INFO - mozleak == 0.1 19:05:56 INFO - mozlog == 3.4 19:05:56 INFO - moznetwork == 0.27 19:05:56 INFO - mozprocess == 0.23 19:05:56 INFO - mozprofile == 0.28 19:05:56 INFO - mozrunner == 6.12 19:05:56 INFO - mozscreenshot == 0.1 19:05:56 INFO - mozsystemmonitor == 0.3 19:05:56 INFO - moztest == 0.7 19:05:56 INFO - mozversion == 1.4 19:05:56 INFO - psutil == 3.1.1 19:05:56 INFO - requests == 1.2.3 19:05:56 INFO - wsgiref == 0.1.2 19:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:56 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')]} 19:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:56 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')]} 19:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:56 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:56 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 19:05:56 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 19:05:56 INFO - Using env: {'DISPLAY': ':0', 19:05:56 INFO - 'HOME': '/home/cltbld', 19:05:56 INFO - 'LANG': 'en_US.UTF-8', 19:05:56 INFO - 'LANGUAGE': 'en_US:en', 19:05:56 INFO - 'LOGNAME': 'cltbld', 19:05:56 INFO - 'MAIL': '/var/mail/cltbld', 19:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:56 INFO - 'MOZ_NO_REMOTE': '1', 19:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:56 INFO - 'NO_EM_RESTART': '1', 19:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:56 INFO - 'PWD': '/builds/slave/test', 19:05:56 INFO - 'SHELL': '/bin/bash', 19:05:56 INFO - 'SHLVL': '1', 19:05:56 INFO - 'TERM': 'linux', 19:05:56 INFO - 'TMOUT': '86400', 19:05:56 INFO - 'USER': 'cltbld', 19:05:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:56 INFO - '_': '/tools/buildbot/bin/python'} 19:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 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)) 19:05:56 INFO - Cleaning up... 19:05:56 INFO - Return code: 0 19:05:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:56 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')]} 19:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:56 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')]} 19:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:56 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 0x7fce1da99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', '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 19:05:56 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 19:05:56 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 19:05:56 INFO - Using env: {'DISPLAY': ':0', 19:05:56 INFO - 'HOME': '/home/cltbld', 19:05:56 INFO - 'LANG': 'en_US.UTF-8', 19:05:56 INFO - 'LANGUAGE': 'en_US:en', 19:05:56 INFO - 'LOGNAME': 'cltbld', 19:05:56 INFO - 'MAIL': '/var/mail/cltbld', 19:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:56 INFO - 'MOZ_NO_REMOTE': '1', 19:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:56 INFO - 'NO_EM_RESTART': '1', 19:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:56 INFO - 'PWD': '/builds/slave/test', 19:05:56 INFO - 'SHELL': '/bin/bash', 19:05:56 INFO - 'SHLVL': '1', 19:05:56 INFO - 'TERM': 'linux', 19:05:56 INFO - 'TMOUT': '86400', 19:05:56 INFO - 'USER': 'cltbld', 19:05:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:56 INFO - '_': '/tools/buildbot/bin/python'} 19:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:56 INFO - Cleaning up... 19:05:56 INFO - Return code: 0 19:05:56 INFO - Running post-action listener: _resource_record_post_action 19:05:56 INFO - Running post-action listener: _start_resource_monitoring 19:05:56 INFO - Starting resource monitoring. 19:05:56 INFO - [mozharness: 2016-09-24 02:05:56.635579Z] Finished create-virtualenv step (success) 19:05:56 INFO - [mozharness: 2016-09-24 02:05:56.636084Z] Running install step. 19:05:56 INFO - Running pre-action listener: _resource_record_pre_action 19:05:56 INFO - Running main action method: install 19:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:56 INFO - Reading from file tmpfile_stdout 19:05:56 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:56 INFO - Reading from file tmpfile_stdout 19:05:56 INFO - Output received: 19:05:56 INFO - Usage: mozinstall [options] installer 19:05:56 INFO - Options: 19:05:56 INFO - -h, --help show this help message and exit 19:05:56 INFO - -d DEST, --destination=DEST 19:05:56 INFO - Directory to install application into. [default: 19:05:56 INFO - "/builds/slave/test"] 19:05:56 INFO - --app=APP Application being installed. [default: firefox] 19:05:56 INFO - mkdir: /builds/slave/test/build/application 19:05:56 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'] 19:05:56 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 19:06:13 INFO - Reading from file tmpfile_stdout 19:06:13 INFO - Output received: 19:06:13 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:13 INFO - Running post-action listener: _resource_record_post_action 19:06:13 INFO - [mozharness: 2016-09-24 02:06:13.057245Z] Finished install step (success) 19:06:13 INFO - [mozharness: 2016-09-24 02:06:13.057493Z] Running run-tests step. 19:06:13 INFO - Running pre-action listener: _resource_record_pre_action 19:06:13 INFO - Running main action method: run_tests 19:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:13 INFO - Python 2.7.3 19:06:13 INFO - Return code: 0 19:06:13 INFO - grabbing minidump binary from tooltool 19:06:13 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')]} 19:06:13 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 0x2449f60>, '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 0x244ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:13 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 19:06:13 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 19:06:13 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 19:06:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:13 INFO - Return code: 0 19:06:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:06:13 INFO - Using env: {'DISPLAY': ':0', 19:06:13 INFO - 'HOME': '/home/cltbld', 19:06:13 INFO - 'LANG': 'en_US.UTF-8', 19:06:13 INFO - 'LANGUAGE': 'en_US:en', 19:06:13 INFO - 'LOGNAME': 'cltbld', 19:06:13 INFO - 'MAIL': '/var/mail/cltbld', 19:06:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:13 INFO - 'MOZ_NO_REMOTE': '1', 19:06:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:13 INFO - 'NO_EM_RESTART': '1', 19:06:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:13 INFO - 'PWD': '/builds/slave/test', 19:06:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:13 INFO - 'SHELL': '/bin/bash', 19:06:13 INFO - 'SHLVL': '1', 19:06:13 INFO - 'TERM': 'linux', 19:06:13 INFO - 'TMOUT': '86400', 19:06:13 INFO - 'USER': 'cltbld', 19:06:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570', 19:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:13 INFO - '_': '/tools/buildbot/bin/python'} 19:06:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:06:13 INFO - mozversion application_buildid: 20160923184124 19:06:13 INFO - mozversion application_changeset: 1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f 19:06:13 INFO - mozversion application_display_name: Nightly 19:06:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:13 INFO - mozversion application_name: Firefox 19:06:13 INFO - mozversion application_remotingname: firefox 19:06:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:06:13 INFO - mozversion application_vendor: Mozilla 19:06:13 INFO - mozversion application_version: 52.0a1 19:06:13 INFO - mozversion platform_buildid: 20160923184124 19:06:13 INFO - mozversion platform_changeset: 1e8a7c6dcea1d73db0da4c61b2dfe4b4cbaec79f 19:06:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:06:13 INFO - mozversion platform_version: 52.0a1 19:06:13 INFO - using testdate: 1474682773 19:06:13 INFO - actual date: 1474682773 19:06:13 INFO - starting webserver on 'localhost:53212' 19:06:13 INFO - SUITE-START | Running 2 tests 19:06:13 INFO - TEST-START | dromaeo_css 19:06:13 INFO - operating with platform_type : linux_ 19:06:13 INFO - Initialising browser for dromaeo_css test... 19:06:13 INFO - TEST-INFO | started process 28536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpukZLna/profile http://localhost:53212/getInfo.html) 19:06:17 INFO - PROCESS | 28536 | __metrics Screen width/height:1600/1200 19:06:17 INFO - PROCESS | 28536 | colorDepth:24 19:06:17 INFO - PROCESS | 28536 | Browser inner width/height: 1024/697 19:06:17 INFO - PROCESS | 28536 | __metrics 19:06:18 INFO - PROCESS | 28536 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:06:18 INFO - PROCESS | 28536 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:06:18 INFO - PROCESS | 28536 | console.error: PushService: 19:06:18 INFO - PROCESS | 28536 | stateChangeProcessEnqueue: Error transitioning state 19:06:18 INFO - PROCESS | 28536 | UnknownError 19:06:19 INFO - TEST-INFO | 28536: exit 0 19:06:19 INFO - Browser initialized. 19:06:19 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:19 INFO - TEST-INFO | started process 28617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpukZLna/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:31 INFO - PROCESS | 28617 | RSS: Main: 174964736 19:06:31 INFO - PROCESS | 28617 | 19:07:22 INFO - PROCESS | 28617 | 1474682842852 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] 19:09:36 INFO - PROCESS | 28617 | Cycle 1(1): loaded http://localhost:53212/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53212/tests/dromaeo/cssquery-ext.html) 19:09:37 INFO - PROCESS | 28617 | RSS: Main: 303972352 19:09:37 INFO - PROCESS | 28617 | 19:12:40 INFO - PROCESS | 28617 | Cycle 1(1): loaded http://localhost:53212/tests/dromaeo/cssquery-ext.html (next: http://localhost:53212/tests/dromaeo/cssquery-jquery.html) 19:12:41 INFO - PROCESS | 28617 | RSS: Main: 276045824 19:12:41 INFO - PROCESS | 28617 | 19:15:43 INFO - PROCESS | 28617 | Cycle 1(1): loaded http://localhost:53212/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53212/tests/dromaeo/cssquery-mootools.html) 19:15:44 INFO - PROCESS | 28617 | RSS: Main: 219627520 19:15:44 INFO - PROCESS | 28617 | 19:18:46 INFO - PROCESS | 28617 | Cycle 1(1): loaded http://localhost:53212/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53212/tests/dromaeo/cssquery-prototype.html) 19:18:47 INFO - PROCESS | 28617 | RSS: Main: 261513216 19:18:47 INFO - PROCESS | 28617 | 19:21:50 INFO - PROCESS | 28617 | Cycle 1(1): loaded http://localhost:53212/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53212/tests/dromaeo/cssquery-yui.html) 19:21:50 INFO - PROCESS | 28617 | RSS: Main: 221978624 19:21:50 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | Cycle 1(1): loaded http://localhost:53212/tests/dromaeo/cssquery-yui.html (next: http://localhost:53212/tests/dromaeo/cssquery-dojo.html) 19:24:54 INFO - PROCESS | 28617 | RSS: Main: 308813824 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | __start_tp_report 19:24:54 INFO - PROCESS | 28617 | _x_x_mozilla_page_load 19:24:54 INFO - PROCESS | 28617 | _x_x_mozilla_page_load_details 19:24:54 INFO - PROCESS | 28617 | |i|pagename|runs| 19:24:54 INFO - PROCESS | 28617 | |0;dojo.html;2621.2398404462706;2651.8541480218582;2675.0770984010514;2689.233568432996;2700.3249187703063;4656.604188643969;4706.317583950329;4772.8090876364995;4783.162946484369;4863.440704319004;4763.047390521892;4791.616670666347;4804.759762011903;4816.807327706896;4901.166801643721;4373.693841431085;4437.866863994085;4451.28779395296;4458.108378324332;4471.463424389078;4369.453818272716;4398.604125628693;4441.9555804442025;4463.218936686083;4481.193385190664;4417.491988421324;4453.109378124372;4518.615917646987;4519.864404067883;4534.9319760203625;4224.091820258659;4271.2738834397915;4278.764667943262;4408.338749187616;4423.955760442386;4276.23027854986;4336.869893903188;4348.630366418858;4352.717073390251;4354.695171338008;4627.838025669085;4637.118947399983;4670.322803193518;4746.955669752649;4840.661153719241;5018.774155163026;5041.672291301091;5045.722485263309;5069.645124841262;5106.361704786902;4960.33035540201;5016.724080175552;5084.567811736007;5094.184930411154;5164.302819119408;4711.575958163782;4745.430548334222;4753.47711751707;4765.332853400527;4766.547178018082;5187.377514698261;5229.058769421541;5238.633295669343;5242.685438873604;5307.840764777063;4847.079054979543;4901.436334821541;5015.498450154955;5017.974910125426;5024.346834911438;5077.8730531737;5096.745162741922;5108.386993560722;5211.348581427322;5216.139337009351;5086.364204474441;5098.745062746848;5102.183650615883;5146.073706732749;5162.3030890830005;5061.215511595708;5065.974670126626;5070.340855688811;5072.949270507322;5119.488051194925;4140.792960351971;4171.270027745132;4297.935530967038;4307.8492252771;4346.1090476452255;3740.9064773380883;3746.28820524105;3747.9812600937366;3754.699624030071;3853.344931361675;4382.9342559861625;4383.430154080013;4388.4733831940375;4391.714538554984;4441.378207051015;5105.33630628016;5133.614978876599;5156.639035267495;5161.612879034087;5211;4231.61915427613;4291.6137547620865;4292.205941900758;4350.869473915787;4388.956110438855;4552.863414097583;4565.041341318294;4566.611837993808;4573.6569757268335;4592.609628181642;4871.732054737024;4873.293372460902;4927.531884470969;4932.186189278729;4933.235348520913;5196.350456192976;5198.636095473432;5202.817901373433;5207.3490813648295;5272.103742363884;4779.402574678165;4855.393075865517;4866.099771542276;4868.9756551217015;4874.293227482066;5037.899242015213;5053.949460505348;5064.366954130734;5095.286659867696;5138.07514647367;5134.717590532557;5151.768170432414;5157.484251574812;5163.845084647466;5169.844904652867;4775.21209000511;4995.325631039908;5021.974890125526;5024;5027.824026159067;4896.36347274852;4901.2893130496595;4922.630802689884;4954.8761280968265;5040.218766091261;4893.804247830047;4917.336159618406;4921.409430868319;4927.334809800775;4992.226204938241;4953.628477864247;5019.799208031638;5027.497250274943;5032.144535428913;5042.39491261051;4857.805687772449;4877.634177436636;4887.095887260868;4910.165271903857;5009.073321435546 19:24:54 INFO - PROCESS | 28617 | |1;ext.html;555.9492559063369;565.6125553995513;567.6792612174121;570.9457601527855;574.8534123798431;27218.45563088737;36109.81945090274;37392.25215495692;37426;42095.36856947141;40325;40562.59437405625;40602.59397406025;40605.79697101518;40636.59363406365;7554.773356799291;7741.380689544823;7745.457817952745;7750.224977502261;7753.922460775405;7363.558186508827;7529.698812047539;9638.084381983736;9869.555869985868;9882.851757223647;9999.900000999969;10070.043345882166;10091.29360944734;10095.04097110777;10095.697129086138;9947.502624868765;9974.650887218913;10019.749506262366;10034.698959031168;10044.347117437343;9782.217422606174;9871.40771553709;9872.062154095349;9872.506374681308;9873.654422095264;37510;37881.43177852334;37904;37910.43134352987;37937.620623793686;2998;3011.969880301213;3180.236743181643;3281.409346317662;3294.9670503295138;26020.609690854653;26024.8698756505;26232.73767262322;26584.601230981552;30465.086047418612;3340.682635149657;3349.43059679855;3379.4761811919193;3392.881249156292;3396.711279541217;250550;251948;252091;252417;252481;30008.799648014272;31078.68921310803;51304.74347628238;51649.225261621104;51674;33197.3360532788;33355.666443335744;33366.8331658345;33386;33392;12760.29818359999;12894.161879477804;12906.67733306675;12910.67723306906;12914.67713307175;8953.686620968365;10631.84052239217;10730.141588672888;10744.516496757664;10753.247272690836;7195.676194571257;7498.700051997968;7683.502861570012;7726.961365193138;7858.410619203468;2993.745531629836;3016.849157542114;3045.802022868551;3070.109668196198;3081.8150910944964;762.8359902620963;799.9680012799423;882.6292956958093;897.9685711000084;943.099340130174;25259.62110568343;27213.727862721516;27411.451770964868;27756.444871102463;27803.16590502288;905.7961958559404;918.5040078357612;980.4558470049191;991.8264303746815;1016.3241444439365;13446.93276533611;14127.929360353133;14357.856421435861;14528.709425811636;14536.491222807363;373738;588326;599920;600277;602276;48198;48793.756031219615;48808.9227062074;48860.51139488631;48871;1151.424287856072;1196.9341686207167;1217.4156404925686;1224.6387315741877;1229.3710833145938;27177.59233611458;28406.573901391082;28629.856850715612;28759.137225883256;29472;41406;41734.791326043174;41807.58192418037;41851.37222941719;41914.58085419229;327105;331470;331596;332559;332863;23994.640080398458;25285;25586.872065639553;25650.871745641154;25658;34675.306493870485;37671;37944.810275948446;38741;39259.80370098131;31842.44963353986;32561.34877302488;33222.5016624746;33238.833805830815;33620.327593448485;32680;32754.578131951883;32958.67041329556;32980.83509582533;34179.658203417646;32646.83676581602;33016.66983330136;33089.172770680925;33265;33337.33325333528;28488.430231394843;29420.852895735385;29630;29752.404951900407;29874.551881721356;23653.52692946166;23845;23893.163739269043;24173.51652966966;24209.39476513101 19:24:54 INFO - PROCESS | 28617 | |2;jquery.html;349.536863655656;369.98335074921624;372.0995191636238;374.37853163748184;398.95212574491063;12376.814347784779;13242.271675057867;13710.383032763537;16178.191090445489;16934.83065169351;15565.844341556582;16210.432634857782;16322.102284374354;16581.50255492334;17027.57431064224;4389.978050109761;4689.202835517953;4693.225617773063;4694;4733.431988161426;3460.2733425980573;4624.676272660915;4697.741624210667;4702.694324868889;4717.764111794414;3581.6776490115885;3623.7825730456125;4265.997490589709;5976.910346344808;6079;6038.456538911475;6040.063790112539;6040.426159514839;6051.576389652726;6060.30306514752;4637.721736695776;4877.414710234759;4914.827981020683;5004.924926126111;5010.0981823271795;12110.576129835501;12286.201396909262;12327.506899724;12347.073969452327;12367.072469564819;1807.4667972948012;1843.7050071988551;2032.8881911494861;2118.7457505099487;2246.584381889356;8573.957130214372;8705.659625348757;9190.586423610954;9252.074792520694;9363.719088427359;1646.6295083606212;1707.897526148435;1714.7053974249486;1766.6731654643932;1807.3132209760206;48991;62645.37354626486;66008.6699566504;69294.3070569298;70235;8331.583420828934;8492.660293588311;8811.162939520735;8812.559372031374;9794.698245912205;11780.882191177978;11891.28652280866;11896.22674526153;11904.226225295328;11921.880781192078;6825.283345248777;6959.408450281681;6970.407515361251;7049.541779784297;7098.503104782616;6275.3724627537795;6724.630145342053;6851.417629501549;7051.1891132519395;7145.535540189871;3577.266660334625;3697.8335974881193;3736.7197460190596;3806.9619303807162;3835.271298453285;1782.0911335219132;1784.348712719848;1794.7078103765268;1809.4933418642802;1840.2271046160645;819.8401311744271;821.0639870547581;824.9298809601131;848.9575521223915;855.8844555984863;16149.273282702072;16222.918885405497;16623.83376166247;16902.32390704358;17024.744628830576;838.1995194589275;840.2731637133958;872.6945569050908;885.9291256699448;936.6628013914985;9152.450852948845;9276.257899368034;10250;10269.640562580274;10580.788384232426;363098;365397;366846;367525.48711769347;371176;78155.60922195352;79608.20391796008;83398.16601834026;83766.58116709377;83860;864.6157482175952;874.5976850648773;900.3652425040331;901.1034021148868;905.4612505559181;15628.765568516708;15670.843291567395;16080.195990200677;16487.505374838773;16520.917395413428;38808.417873732484;39514.40728389019;39595.60404395919;39949.40075898806;40500.79749601351;49593;52720.472795271555;53215.46784532105;53350.19974700305;53386.19920701115;4764.618830493621;6591.110200123114;6996.930030699627;7012.158540975116;7496.137944136276;9726.902730972599;12035.458404371999;12041.45813438415;12095.21381110225;12264.570740024057;10391.53238104272;10450.320729152581;10613;10651.360918344924;10975.670729878117;10295.897041029793;10350.948245258725;10424.635137770141;10436.94781526118;10586.788264234827;10416.479176041319;10495.475226238505;10560.313579617301;10769;11056.557737690724;6808.863822723617;6985.860282794214;7003.964980175067;7117.893231601426;7309.122905251404;8790;10481.79036419252;10580.20648451354;10846.457677115955;11133.332000079698 19:24:54 INFO - PROCESS | 28617 | |3;mootools.html;1136.3977092141167;1351.763441397755;1388.0283801339062;1455.5851582299047;1693.4411644157428;6968.372846443819;7490.513116647421;7840.803979900498;8094.838103237932;8098.635561399737;8048.315893149074;8113.472624279432;8117.553534555597;8117.837643247146;8118.878216826753;2142.550064486456;2163.7836216378314;2166.490874644457;2169.3600387885613;2169.8264138868853;2064.0917996081675;2131.3179782469615;2139.6362618354915;2145.2169957965384;2145.9892700536475;2136.529963408048;2136.7756385579523;2147.291393840037;2152.709384233132;2204.0522575292616;2091.518950641346;2098.08733201058;2100.9894950525227;2104.0111147760604;2104.326615483046;2097.475631092227;2143.9892800536054;2147.387994421598;2147.6456384696507;2148.9570208595896;7886.605669716549;7970.123286438487;7985.281324680748;8066;8078.151794061598;4723;4885.389326334208;4898.412190537123;4964.131277026542;4966.528179822911;2897.826130432181;3091.3508163285737;3105.0840002199407;3128.2492201871614;3145.5281707743793;939.7133874168376;945.7635591102224;958.0563145301873;963.2246041936238;964.5273815830262;10993.340399576051;11094.891970525574;11103.111751059896;11111.833322500088;11136.33182009082;4098.139390727981;4289.978550107229;4321.67587430944;4499.842505512292;4527.049319642846;8423;8561.0582835888;8563.400561960727;8579.142085791496;8582.82834343322;4810.2063159578975;4816.518348165156;4830.879228019257;4831.106245344622;4837.419509658864;3650.7261955353456;3807.162424266657;4115.8765237042935;4456.799444025027;4486.573775491323;3469.7224222062678;3487.3548393547276;3584.372734771405;3593.2274560969518;3595.442706380515;1027.440045175381;1044.3211912257093;1050.3330385205297;1056.9577216911237;1059.247933966892;673.3939454490998;744.3672878053611;769.9461037727306;793.3415265329878;800.8158123631597;4798.47216806151;4937.185364414831;5010.624203184776;5091.66904151229;5195.116830138885;396.45883369200834;409.7561950639365;412.579169247366;416.6604217562677;418.21793246629;3218.8873389431255;3373.4265174920324;3485.128717820545;3574.356615809127;3603.94594081089;9741.902580974242;10195.031472010147;10206.642767503101;10213.234007449471;10237.18102551794;10058.849117263248;10078.647247346307;10094.899051009395;10098.949505252427;10132.848007279898;7436.66535005926;7629.771106866803;7640.083190017233;7643.235676432312;7643.885341719879;4993.3259010034635;5069.112905241642;5207.088759467002;5208.817691380935;5418.051840927743;9164.221041211571;9172.587233574639;9202.815943680955;9312;9334.159925606456;8329.208725171098;8686.39195256326;9030.683926062557;9052.81894362096;9379.390339627902;6061.272647282354;7202.207757146814;7321.6705248265025;7432.405407567489;7435.107787065586;7489.925100748923;7537.170911199873;7559.470837041355;7632.389408847168;7699.461037727306;6918.584884906721;6941.757038503628;6961.825954351182;6983.755568555076;7011.719531218694;6869.107016088076;6876.346747059021;6888.207856096613;6952.374286314053;6980.406665433495;6204.81385558434;6330.746770129143;6331.556791024584;6333.081703152925;6334.733053389248;4351.216780979454;4372.715773474842;4373.540778218368;4390.582894625006;4495.325701144854;4142.792860357031;4205.095904380573;4236.745795252295;4306.354046892991;4349.217140914539 19:24:54 INFO - PROCESS | 28617 | |4;prototype.html;287.2817955112218;288.73003741501697;295.8889370414095;298.8670041831386;299.8575676553639;4655.906881862361;4797.920467894722;4817.20516114841;4851.466338702744;4888.535589119037;4589.196890544158;4698.177818881699;4703.90592188156;4709.199436095863;4725.9839134586055;3734.8319325630277;3736.532933383327;3742.513473248474;3746.9625303746884;3747.1943532140585;3505.211327451316;3740.6446387593137;3748.2878253131817;3753.9061523461996;3758.830852611639;3301.9174520637057;3565.5721313442423;3659.359612067891;3693.150575367667;3706.814659267039;3702.5186725725753;3704.907377315575;3705.3330400527893;3706.962930370689;3707.6663100320966;3266.7749593902286;3275.918102047444;3280.4423248047888;3281.2289112058647;3291.7860339077884;4454.599086082236;4611.538846115395;4629;4631.4673812511655;4648.000679853814;4233.206083984555;4239.7668128252935;4243.321068629005;4251.213525497793;4254.404383386328;4959.231319145502;4959.355283813117;4959.504049595048;4972.552470277692;4973.825916092919;3476.5837742768786;3608.747387682863;3626.220362622049;3626.564812222524;3631.6186800385844;5156;5187.610929180289;5196.740162991873;5199.4401679496;5207.505286997767;3634.6547078027547;3638.9090272742865;3641.089727568108;3644.398674218777;3645.6172101929446;3680.4479328100465;3684.5946945835935;3694.9076273093387;3696.390095634244;3697.7041836653;3981.92036159281;4193.706440549132;4202.747835129902;4206.305959516707;4228.85199018039;4973.154563724175;4990.775415106329;4995.225740010304;4996.225585034325;4997.500249975046;1233.2662066070673;1248.2635245205372;1256.114439320277;1283.2941881964882;1305.269049332358;860.3934226370394;861.3453775130946;877.741066385405;879.7536689726886;883.7746374674417;4401.977990110029;4404.361367601679;4408.470983481939;4414.470263568328;4414.909563305635;5104.566111880457;5105.8723531912;5106.795728170906;5107.846764597068;5109.718965456861;4364.672649551297;4371.388005679208;4379.277419225856;4386.4736231652405;4393.51671316155;2308.8499247548857;2388.5342358239977;2403.4231784371973;2411.409204744849;2414.177296141402;4228.154369126187;4241.639460645818;4246.8725938221905;4250.256205164084;4267.274563324242;4529.479109902403;4547.886302842389;4560.95439045612;4587.197240482902;4589.816407343669;4086.6322031017353;4199.853005144805;4241.26438447206;4254.255505286563;4259.212045771542;4413.382126502228;4480.879780054986;4486.6540037987825;4490.326451032372;4535.886602834956;4398.714083584557;4407.471103467605;4414.4702635683925;4425.668074894332;4428.918408348071;4245.596668316505;4277.272863613131;4285.785710714515;4539.409876716006;4904.141775189399;3605.891823245307;3609;3611.169431030825;3618.782873027627;3622.5471816022996;4946.095753134997;5191.195364718475;5198.532132107977;5210.6613070150315;5221.582273418194;4860.295257187618;4918.581920536794;4968.751562421792;4995.17579599362;5029;5036.924446133385;5037.647364684437;5040.395152581714;5046.9747651261505;5051.469595692546;4829.73436460984;4974.607110009203;4982;4983.476734942924;4995.675281106716;5067.746612669425;5095.235714642685;5095.847124586268;5096;5105.33630628016;4931.791711030821;4947.233178857283;4947.727874966911;4955.8017679292425;4959.70241785494 19:24:54 INFO - PROCESS | 28617 | |5;yui.html;654.8755736410081;674.6660403100465;717.7344382578447;722.9710811567537;770.9575973321466;11221.270617409862;11933.16467847251;11955.10336724747;11993.340366279852;12007.159498835073;12885.162464439805;12971.092023558354;12971.870281297184;13037;13073.869261307384;619.7923695561992;632.4750457120601;744.5867543513361;755.958422286774;768.535036303037;774.8682723936917;775.1202385292705;775.1899265267808;776.5069181070033;776.54572075336;823.9217274358956;825.8348330333957;826.3141592478229;826.3224156191925;829.854775414303;649.331188875459;666.3170250493234;800.2957397490229;817.0358976407837;824.381713714714;602.256213576233;603.4599033864666;603.4749767702083;603.6378173096107;603.8339456649456;13100.279484628341;13148.6712832179;13164.605061848064;13167.53913613019;13167.86832131676;12455.377231138498;12717.55488557896;13056.608301750963;13091;13211;12044.759104817942;12184.086193535431;12216;12341.69145771354;12454.937725311316;3297.422296807966;3381.408253555618;3401.2857299967036;3415.5047518109736;4143.875683729493;59876.40123598752;59982.400175998555;60824;61180.388196117914;61281.69359153176;10170.694879153638;10224.335418197794;10522.158227341793;10785.56857725698;10817.350958942488;17702.203400846993;17804.287828486715;17893.821061789477;17964.101794910464;18290.63418731618;6832.658367081626;6903.344182302673;6927.445804335641;6959.478039147084;6991.091158149408;3778.508793856781;3801.2777572261184;3816.580176180618;3888.066863952631;3893.454916311662;3032.529957856536;3138.1840721412595;3163.7785355024926;3169.112648458435;3169.144331030655;532.909405401075;534.0520575977671;535.8687121655141;535.9624826262125;551.01093537101;460.7350773305363;488.77561707921427;571.70271458842;575.9683217422998;592.2744637818638;8057.879131813028;8171.42800003994;8321.674128557728;8350.874736878952;8810.691625793195;464.8605418374474;467.77780554236466;515.6596646213482;525.5112745146973;551.5587529976003;3825.885223443301;3983.960160398417;4151.27352713274;4182;4209.452771139732;58192.4180758187;58602.413975860545;58697.70651146717;59758.103628445606;99452.5027374873;88648;89712.5514372437;91967.5401623001;93054.53472732728;93908.53045734728;76457.6177119122;81371.5931420339;81894.59052704698;82001;83628.58185709032;7394.522834850385;7474.364679002346;8411.789705257173;8490.872636910575;8679.522626255617;42623.786881065396;45056.549434506545;46302.6848657559;46958.76520617375;48632.73243548535;66391;66931.33068669251;67088.32911671016;67454.53272943513;68307.65846170737;12362.690932726753;12454.688632784253;12633.557825476431;12756.68108297263;13045.478180872658;13293.534726284533;13361;13420.597382078553;13585;14148;11588.47851846652;11722.824157637471;11964.760704785682;12040.638780836589;12433.12968092225;12436.626901192978;12965.675858103623;13387.665308366979;13394.866051339362;13397.998183795524;11807.291562506278;12423.068269879614;12770.361481926053;13047.804282935953;13158.868411315765;9839;10468.267221294436;10584.36493810343;10934.945325273322;11129.666110016713;10586.576536938435;11098.112151028059;11181.868424590391;11236.269642473213;11345.489452974802 19:24:54 INFO - PROCESS | 28617 | __end_tp_report 19:24:54 INFO - PROCESS | 28617 | __start_cc_report 19:24:54 INFO - PROCESS | 28617 | _x_x_mozilla_cycle_collect,1088 19:24:54 INFO - PROCESS | 28617 | __end_cc_report 19:24:54 INFO - PROCESS | 28617 | __startTimestamp1474683894288__endTimestamp 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | ------- Summary: start ------- 19:24:54 INFO - PROCESS | 28617 | Number of tests: 6 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | [#0] dojo.html Cycles:165 Average:4721.00 Median:4873.29 stddev:504.64 (10.4%) stddev-sans-first:478.56 19:24:54 INFO - PROCESS | 28617 | Values: 2621.2 2651.9 2675.1 2689.2 2700.3 4656.6 4706.3 4772.8 4783.2 4863.4 4763.0 4791.6 4804.8 4816.8 4901.2 4373.7 4437.9 4451.3 4458.1 4471.5 4369.5 4398.6 4442.0 4463.2 4481.2 4417.5 4453.1 4518.6 4519.9 4534.9 4224.1 4271.3 4278.8 4408.3 4424.0 4276.2 4336.9 4348.6 4352.7 4354.7 4627.8 4637.1 4670.3 4747.0 4840.7 5018.8 5041.7 5045.7 5069.6 5106.4 4960.3 5016.7 5084.6 5094.2 5164.3 4711.6 4745.4 4753.5 4765.3 4766.5 5187.4 5229.1 5238.6 5242.7 5307.8 4847.1 4901.4 5015.5 5018.0 5024.3 5077.9 5096.7 5108.4 5211.3 5216.1 5086.4 5098.7 5102.2 5146.1 5162.3 5061.2 5066.0 5070.3 5072.9 5119.5 4140.8 4171.3 4297.9 4307.8 4346.1 3740.9 3746.3 3748.0 3754.7 3853.3 4382.9 4383.4 4388.5 4391.7 4441.4 5105.3 5133.6 5156.6 5161.6 5211.0 4231.6 4291.6 4292.2 4350.9 4389.0 4552.9 4565.0 4566.6 4573.7 4592.6 4871.7 4873.3 4927.5 4932.2 4933.2 5196.4 5198.6 5202.8 5207.3 5272.1 4779.4 4855.4 4866.1 4869.0 4874.3 5037.9 5053.9 5064.4 5095.3 5138.1 5134.7 5151.8 5157.5 5163.8 5169.8 4775.2 4995.3 5022.0 5024.0 5027.8 4896.4 4901.3 4922.6 4954.9 5040.2 4893.8 4917.3 4921.4 4927.3 4992.2 4953.6 5019.8 5027.5 5032.1 5042.4 4857.8 4877.6 4887.1 4910.2 5009.1 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | [#1] ext.html Cycles:180 Average:50554.66 Median:182912.00 stddev:107860.80 (59.0%) stddev-sans-first:108098.06 19:24:54 INFO - PROCESS | 28617 | Values: 555.9 565.6 567.7 570.9 574.9 27218.5 36109.8 37392.3 37426.0 42095.4 40325.0 40562.6 40602.6 40605.8 40636.6 7554.8 7741.4 7745.5 7750.2 7753.9 7363.6 7529.7 9638.1 9869.6 9882.9 9999.9 10070.0 10091.3 10095.0 10095.7 9947.5 9974.7 10019.7 10034.7 10044.3 9782.2 9871.4 9872.1 9872.5 9873.7 37510.0 37881.4 37904.0 37910.4 37937.6 2998.0 3012.0 3180.2 3281.4 3295.0 26020.6 26024.9 26232.7 26584.6 30465.1 3340.7 3349.4 3379.5 3392.9 3396.7 250550.0 251948.0 252091.0 252417.0 252481.0 30008.8 31078.7 51304.7 51649.2 51674.0 33197.3 33355.7 33366.8 33386.0 33392.0 12760.3 12894.2 12906.7 12910.7 12914.7 8953.7 10631.8 10730.1 10744.5 10753.2 7195.7 7498.7 7683.5 7727.0 7858.4 2993.7 3016.8 3045.8 3070.1 3081.8 762.8 800.0 882.6 898.0 943.1 25259.6 27213.7 27411.5 27756.4 27803.2 905.8 918.5 980.5 991.8 1016.3 13446.9 14127.9 14357.9 14528.7 14536.5 373738.0 588326.0 599920.0 600277.0 602276.0 48198.0 48793.8 48808.9 48860.5 48871.0 1151.4 1196.9 1217.4 1224.6 1229.4 27177.6 28406.6 28629.9 28759.1 29472.0 41406.0 41734.8 41807.6 41851.4 41914.6 327105.0 331470.0 331596.0 332559.0 332863.0 23994.6 25285.0 25586.9 25650.9 25658.0 34675.3 37671.0 37944.8 38741.0 39259.8 31842.4 32561.3 33222.5 33238.8 33620.3 32680.0 32754.6 32958.7 32980.8 34179.7 32646.8 33016.7 33089.2 33265.0 33337.3 28488.4 29420.9 29630.0 29752.4 29874.6 23653.5 23845.0 23893.2 24173.5 24209.4 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | [#2] jquery.html Cycles:180 Average:23267.33 Median:19997.28 stddev:60871.76 (304.4%) stddev-sans-first:61018.20 19:24:54 INFO - PROCESS | 28617 | Values: 349.5 370.0 372.1 374.4 399.0 12376.8 13242.3 13710.4 16178.2 16934.8 15565.8 16210.4 16322.1 16581.5 17027.6 4390.0 4689.2 4693.2 4694.0 4733.4 3460.3 4624.7 4697.7 4702.7 4717.8 3581.7 3623.8 4266.0 5976.9 6079.0 6038.5 6040.1 6040.4 6051.6 6060.3 4637.7 4877.4 4914.8 5004.9 5010.1 12110.6 12286.2 12327.5 12347.1 12367.1 1807.5 1843.7 2032.9 2118.7 2246.6 8574.0 8705.7 9190.6 9252.1 9363.7 1646.6 1707.9 1714.7 1766.7 1807.3 48991.0 62645.4 66008.7 69294.3 70235.0 8331.6 8492.7 8811.2 8812.6 9794.7 11780.9 11891.3 11896.2 11904.2 11921.9 6825.3 6959.4 6970.4 7049.5 7098.5 6275.4 6724.6 6851.4 7051.2 7145.5 3577.3 3697.8 3736.7 3807.0 3835.3 1782.1 1784.3 1794.7 1809.5 1840.2 819.8 821.1 824.9 849.0 855.9 16149.3 16222.9 16623.8 16902.3 17024.7 838.2 840.3 872.7 885.9 936.7 9152.5 9276.3 10250.0 10269.6 10580.8 363098.0 365397.0 366846.0 367525.5 371176.0 78155.6 79608.2 83398.2 83766.6 83860.0 864.6 874.6 900.4 901.1 905.5 15628.8 15670.8 16080.2 16487.5 16520.9 38808.4 39514.4 39595.6 39949.4 40500.8 49593.0 52720.5 53215.5 53350.2 53386.2 4764.6 6591.1 6996.9 7012.2 7496.1 9726.9 12035.5 12041.5 12095.2 12264.6 10391.5 10450.3 10613.0 10651.4 10975.7 10295.9 10350.9 10424.6 10436.9 10586.8 10416.5 10495.5 10560.3 10769.0 11056.6 6808.9 6985.9 7004.0 7117.9 7309.1 8790.0 10481.8 10580.2 10846.5 11133.3 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | [#3] mootools.html Cycles:180 Average:5181.92 Median:4804.34 stddev:3003.61 (62.5%) stddev-sans-first:2996.64 19:24:54 INFO - PROCESS | 28617 | Values: 1136.4 1351.8 1388.0 1455.6 1693.4 6968.4 7490.5 7840.8 8094.8 8098.6 8048.3 8113.5 8117.6 8117.8 8118.9 2142.6 2163.8 2166.5 2169.4 2169.8 2064.1 2131.3 2139.6 2145.2 2146.0 2136.5 2136.8 2147.3 2152.7 2204.1 2091.5 2098.1 2101.0 2104.0 2104.3 2097.5 2144.0 2147.4 2147.6 2149.0 7886.6 7970.1 7985.3 8066.0 8078.2 4723.0 4885.4 4898.4 4964.1 4966.5 2897.8 3091.4 3105.1 3128.2 3145.5 939.7 945.8 958.1 963.2 964.5 10993.3 11094.9 11103.1 11111.8 11136.3 4098.1 4290.0 4321.7 4499.8 4527.0 8423.0 8561.1 8563.4 8579.1 8582.8 4810.2 4816.5 4830.9 4831.1 4837.4 3650.7 3807.2 4115.9 4456.8 4486.6 3469.7 3487.4 3584.4 3593.2 3595.4 1027.4 1044.3 1050.3 1057.0 1059.2 673.4 744.4 769.9 793.3 800.8 4798.5 4937.2 5010.6 5091.7 5195.1 396.5 409.8 412.6 416.7 418.2 3218.9 3373.4 3485.1 3574.4 3603.9 9741.9 10195.0 10206.6 10213.2 10237.2 10058.8 10078.6 10094.9 10098.9 10132.8 7436.7 7629.8 7640.1 7643.2 7643.9 4993.3 5069.1 5207.1 5208.8 5418.1 9164.2 9172.6 9202.8 9312.0 9334.2 8329.2 8686.4 9030.7 9052.8 9379.4 6061.3 7202.2 7321.7 7432.4 7435.1 7489.9 7537.2 7559.5 7632.4 7699.5 6918.6 6941.8 6961.8 6983.8 7011.7 6869.1 6876.3 6888.2 6952.4 6980.4 6204.8 6330.7 6331.6 6333.1 6334.7 4351.2 4372.7 4373.5 4390.6 4495.3 4142.8 4205.1 4236.7 4306.4 4349.2 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | [#4] prototype.html Cycles:180 Average:4039.11 Median:4405.92 stddev:1169.21 (26.5%) stddev-sans-first:1138.08 19:24:54 INFO - PROCESS | 28617 | Values: 287.3 288.7 295.9 298.9 299.9 4655.9 4797.9 4817.2 4851.5 4888.5 4589.2 4698.2 4703.9 4709.2 4726.0 3734.8 3736.5 3742.5 3747.0 3747.2 3505.2 3740.6 3748.3 3753.9 3758.8 3301.9 3565.6 3659.4 3693.2 3706.8 3702.5 3704.9 3705.3 3707.0 3707.7 3266.8 3275.9 3280.4 3281.2 3291.8 4454.6 4611.5 4629.0 4631.5 4648.0 4233.2 4239.8 4243.3 4251.2 4254.4 4959.2 4959.4 4959.5 4972.6 4973.8 3476.6 3608.7 3626.2 3626.6 3631.6 5156.0 5187.6 5196.7 5199.4 5207.5 3634.7 3638.9 3641.1 3644.4 3645.6 3680.4 3684.6 3694.9 3696.4 3697.7 3981.9 4193.7 4202.7 4206.3 4228.9 4973.2 4990.8 4995.2 4996.2 4997.5 1233.3 1248.3 1256.1 1283.3 1305.3 860.4 861.3 877.7 879.8 883.8 4402.0 4404.4 4408.5 4414.5 4414.9 5104.6 5105.9 5106.8 5107.8 5109.7 4364.7 4371.4 4379.3 4386.5 4393.5 2308.8 2388.5 2403.4 2411.4 2414.2 4228.2 4241.6 4246.9 4250.3 4267.3 4529.5 4547.9 4561.0 4587.2 4589.8 4086.6 4199.9 4241.3 4254.3 4259.2 4413.4 4480.9 4486.7 4490.3 4535.9 4398.7 4407.5 4414.5 4425.7 4428.9 4245.6 4277.3 4285.8 4539.4 4904.1 3605.9 3609.0 3611.2 3618.8 3622.5 4946.1 5191.2 5198.5 5210.7 5221.6 4860.3 4918.6 4968.8 4995.2 5029.0 5036.9 5037.6 5040.4 5047.0 5051.5 4829.7 4974.6 4982.0 4983.5 4995.7 5067.7 5095.2 5095.8 5096.0 5105.3 4931.8 4947.2 4947.7 4955.8 4959.7 19:24:54 INFO - PROCESS | 28617 | 19:24:54 INFO - PROCESS | 28617 | [#5] yui.html Cycles:180 Average:17618.69 Median:22758.64 stddev:24422.15 (107.3%) stddev-sans-first:24457.44 19:24:54 INFO - PROCESS | 28617 | Values: 654.9 674.7 717.7 723.0 771.0 11221.3 11933.2 11955.1 11993.3 12007.2 12885.2 12971.1 12971.9 13037.0 13073.9 619.8 632.5 744.6 756.0 768.5 774.9 775.1 775.2 776.5 776.5 823.9 825.8 826.3 826.3 829.9 649.3 666.3 800.3 817.0 824.4 602.3 603.5 603.5 603.6 603.8 13100.3 13148.7 13164.6 13167.5 13167.9 12455.4 12717.6 13056.6 13091.0 13211.0 12044.8 12184.1 12216.0 12341.7 12454.9 3297.4 3381.4 3401.3 3415.5 4143.9 59876.4 59982.4 60824.0 61180.4 61281.7 10170.7 10224.3 10522.2 10785.6 10817.4 17702.2 17804.3 17893.8 17964.1 18290.6 6832.7 6903.3 6927.4 6959.5 6991.1 3778.5 3801.3 3816.6 3888.1 3893.5 3032.5 3138.2 3163.8 3169.1 3169.1 532.9 534.1 535.9 536.0 551.0 460.7 488.8 571.7 576.0 592.3 8057.9 8171.4 8321.7 8350.9 8810.7 464.9 467.8 515.7 525.5 551.6 3825.9 3984.0 4151.3 4182.0 4209.5 58192.4 58602.4 58697.7 59758.1 99452.5 88648.0 89712.6 91967.5 93054.5 93908.5 76457.6 81371.6 81894.6 82001.0 83628.6 7394.5 7474.4 8411.8 8490.9 8679.5 42623.8 45056.5 46302.7 46958.8 48632.7 66391.0 66931.3 67088.3 67454.5 68307.7 12362.7 12454.7 12633.6 12756.7 13045.5 13293.5 13361.0 13420.6 13585.0 14148.0 11588.5 11722.8 11964.8 12040.6 12433.1 12436.6 12965.7 13387.7 13394.9 13398.0 11807.3 12423.1 12770.4 13047.8 13158.9 9839.0 10468.3 10584.4 10934.9 11129.7 10586.6 11098.1 11181.9 11236.3 11345.5 19:24:54 INFO - PROCESS | 28617 | -------- Summary: end -------- 19:24:54 INFO - PROCESS | 28617 | 19:24:55 INFO - TEST-INFO | 28617: exit 0 19:24:55 INFO - TEST-OK | dromaeo_css | took 1121879ms 19:24:55 INFO - TEST-START | kraken 19:24:55 INFO - operating with platform_type : linux_ 19:24:55 INFO - Initialising browser for kraken test... 19:24:55 INFO - TEST-INFO | started process 28923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIGanr/profile http://localhost:53212/getInfo.html) 19:24:59 INFO - PROCESS | 28923 | __metrics Screen width/height:1600/1200 19:24:59 INFO - PROCESS | 28923 | colorDepth:24 19:24:59 INFO - PROCESS | 28923 | Browser inner width/height: 1024/697 19:24:59 INFO - PROCESS | 28923 | __metrics 19:25:00 INFO - PROCESS | 28923 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:25:00 INFO - PROCESS | 28923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:00 INFO - PROCESS | 28923 | console.error: PushService: 19:25:00 INFO - PROCESS | 28923 | stateChangeProcessEnqueue: Error transitioning state 19:25:00 INFO - PROCESS | 28923 | UnknownError 19:25:01 INFO - TEST-INFO | 28923: exit 0 19:25:01 INFO - Browser initialized. 19:25:01 INFO - Running cycle 1/1 for kraken test... 19:25:01 INFO - TEST-INFO | started process 29003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIGanr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:13 INFO - PROCESS | 29003 | RSS: Main: 175276032 19:25:13 INFO - PROCESS | 29003 | 19:25:16 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53212/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:17 INFO - PROCESS | 29003 | RSS: Main: 238014464 19:25:17 INFO - PROCESS | 29003 | 19:25:20 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53212/tests/kraken/driver.html?testName=audio-dft) 19:25:20 INFO - PROCESS | 29003 | RSS: Main: 218124288 19:25:20 INFO - PROCESS | 29003 | 19:25:23 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53212/tests/kraken/driver.html?testName=audio-fft) 19:25:24 INFO - PROCESS | 29003 | RSS: Main: 300601344 19:25:24 INFO - PROCESS | 29003 | 19:25:26 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53212/tests/kraken/driver.html?testName=audio-oscillator) 19:25:27 INFO - PROCESS | 29003 | RSS: Main: 209514496 19:25:27 INFO - PROCESS | 29003 | 19:25:29 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53212/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:30 INFO - PROCESS | 29003 | RSS: Main: 213667840 19:25:30 INFO - PROCESS | 29003 | 19:25:33 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53212/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:34 INFO - PROCESS | 29003 | RSS: Main: 251150336 19:25:34 INFO - PROCESS | 29003 | 19:25:37 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53212/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:38 INFO - PROCESS | 29003 | RSS: Main: 244719616 19:25:38 INFO - PROCESS | 29003 | 19:25:41 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53212/tests/kraken/driver.html?testName=json-parse-financial) 19:25:41 INFO - PROCESS | 29003 | RSS: Main: 248197120 19:25:41 INFO - PROCESS | 29003 | 19:25:43 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53212/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:43 INFO - PROCESS | 29003 | RSS: Main: 211132416 19:25:43 INFO - PROCESS | 29003 | 19:25:45 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:46 INFO - PROCESS | 29003 | RSS: Main: 218632192 19:25:46 INFO - PROCESS | 29003 | 19:25:48 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:49 INFO - PROCESS | 29003 | RSS: Main: 223240192 19:25:49 INFO - PROCESS | 29003 | 19:25:52 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:52 INFO - PROCESS | 29003 | RSS: Main: 223854592 19:25:52 INFO - PROCESS | 29003 | 19:25:55 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:56 INFO - PROCESS | 29003 | RSS: Main: 222216192 19:25:56 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | Cycle 1(1): loaded http://localhost:53212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53212/tests/kraken/driver.html?testName=ai-astar) 19:25:58 INFO - PROCESS | 29003 | RSS: Main: 273018880 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | __start_tp_report 19:25:58 INFO - PROCESS | 29003 | _x_x_mozilla_page_load 19:25:58 INFO - PROCESS | 29003 | _x_x_mozilla_page_load_details 19:25:58 INFO - PROCESS | 29003 | |i|pagename|runs| 19:25:58 INFO - PROCESS | 29003 | |0;ai-astar;111;113;114;115;114;115;116;113;113;114 19:25:58 INFO - PROCESS | 29003 | |1;audio-beat-detection;152;124;126;167;124;127;125;130;161;123 19:25:58 INFO - PROCESS | 29003 | |2;audio-dft;162;162;163;161;161;163;161;164;162;162 19:25:58 INFO - PROCESS | 29003 | |3;audio-fft;77;77;77;113;77;78;77;77;103;77 19:25:58 INFO - PROCESS | 29003 | |4;audio-oscillator;83;85;114;83;85;85;117;84;84;119 19:25:58 INFO - PROCESS | 29003 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;117;117 19:25:58 INFO - PROCESS | 29003 | |6;imaging-darkroom;149;147;148;147;147;147;146;147;146;147 19:25:58 INFO - PROCESS | 29003 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;94 19:25:58 INFO - PROCESS | 29003 | |8;json-parse-financial;64;63;75;62;63;64;64;63;64;64 19:25:58 INFO - PROCESS | 29003 | |9;json-stringify-tinderbox;66;66;66;67;66;66;66;67;67;66 19:25:58 INFO - PROCESS | 29003 | |10;stanford-crypto-aes;82;92;85;94;89;83;82;85;82;82 19:25:58 INFO - PROCESS | 29003 | |11;stanford-crypto-ccm;138;141;133;137;133;134;135;134;172;138 19:25:58 INFO - PROCESS | 29003 | |12;stanford-crypto-pbkdf2;178;170;174;176;179;178;172;173;173;175 19:25:58 INFO - PROCESS | 29003 | |13;stanford-crypto-sha256-iterative;69;70;72;69;69;70;68;71;69;69 19:25:58 INFO - PROCESS | 29003 | __end_tp_report 19:25:58 INFO - PROCESS | 29003 | __start_cc_report 19:25:58 INFO - PROCESS | 29003 | _x_x_mozilla_cycle_collect,1989 19:25:58 INFO - PROCESS | 29003 | __end_cc_report 19:25:58 INFO - PROCESS | 29003 | __startTimestamp1474683958567__endTimestamp 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | ------- Summary: start ------- 19:25:58 INFO - PROCESS | 29003 | Number of tests: 14 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.40 (1.2%) stddev-sans-first:1.05 19:25:58 INFO - PROCESS | 29003 | Values: 111.0 113.0 114.0 115.0 114.0 115.0 116.0 113.0 113.0 114.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:128.50 stddev:17.12 (13.3%) stddev-sans-first:17.14 19:25:58 INFO - PROCESS | 29003 | Values: 152.0 124.0 126.0 167.0 124.0 127.0 125.0 130.0 161.0 123.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 19:25:58 INFO - PROCESS | 29003 | Values: 162.0 162.0 163.0 161.0 161.0 163.0 161.0 164.0 162.0 162.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:13.23 (17.2%) stddev-sans-first:13.84 19:25:58 INFO - PROCESS | 29003 | Values: 77.0 77.0 77.0 113.0 77.0 78.0 77.0 77.0 103.0 77.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:15.77 (18.8%) stddev-sans-first:16.23 19:25:58 INFO - PROCESS | 29003 | Values: 83.0 85.0 114.0 83.0 85.0 85.0 117.0 84.0 84.0 119.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 19:25:58 INFO - PROCESS | 29003 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 19:25:58 INFO - PROCESS | 29003 | Values: 149.0 147.0 148.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:25:58 INFO - PROCESS | 29003 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:3.72 (5.8%) stddev-sans-first:3.94 19:25:58 INFO - PROCESS | 29003 | Values: 64.0 63.0 75.0 62.0 63.0 64.0 64.0 63.0 64.0 64.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 19:25:58 INFO - PROCESS | 29003 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 66.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:4.50 (5.3%) stddev-sans-first:4.58 19:25:58 INFO - PROCESS | 29003 | Values: 82.0 92.0 85.0 94.0 89.0 83.0 82.0 85.0 82.0 82.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:137.50 stddev:11.71 (8.5%) stddev-sans-first:12.41 19:25:58 INFO - PROCESS | 29003 | Values: 138.0 141.0 133.0 137.0 133.0 134.0 135.0 134.0 172.0 138.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:2.94 (1.7%) stddev-sans-first:2.88 19:25:58 INFO - PROCESS | 29003 | Values: 178.0 170.0 174.0 176.0 179.0 178.0 172.0 173.0 173.0 175.0 19:25:58 INFO - PROCESS | 29003 | 19:25:58 INFO - PROCESS | 29003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 19:25:58 INFO - PROCESS | 29003 | Values: 69.0 70.0 72.0 69.0 69.0 70.0 68.0 71.0 69.0 69.0 19:25:58 INFO - PROCESS | 29003 | -------- Summary: end -------- 19:25:58 INFO - PROCESS | 29003 | 19:25:59 INFO - TEST-INFO | 29003: exit 0 19:25:59 INFO - TEST-OK | kraken | took 64736ms 19:25:59 INFO - SUITE-END | took 1186s 19:26:00 INFO - Completed test suite (00:19:46) 19:26:00 INFO - javascript benchmark 19:26:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.2398404462706, 2651.8541480218582, 2675.0770984010514, 2689.233568432996, 2700.3249187703063, 4656.604188643969, 4706.317583950329, 4772.8090876364995, 4783.162946484369, 4863.440704319004, 4763.047390521892, 4791.616670666347, 4804.759762011903, 4816.807327706896, 4901.166801643721, 4373.693841431085, 4437.866863994085, 4451.28779395296, 4458.108378324332, 4471.463424389078, 4369.453818272716, 4398.604125628693, 4441.9555804442025, 4463.218936686083, 4481.193385190664, 4417.491988421324, 4453.109378124372, 4518.615917646987, 4519.864404067883, 4534.9319760203625, 4224.091820258659, 4271.2738834397915, 4278.764667943262, 4408.338749187616, 4423.955760442386, 4276.23027854986, 4336.869893903188, 4348.630366418858, 4352.717073390251, 4354.695171338008, 4627.838025669085, 4637.118947399983, 4670.322803193518, 4746.955669752649, 4840.661153719241, 5018.774155163026, 5041.672291301091, 5045.722485263309, 5069.645124841262, 5106.361704786902, 4960.33035540201, 5016.724080175552, 5084.567811736007, 5094.184930411154, 5164.302819119408, 4711.575958163782, 4745.430548334222, 4753.47711751707, 4765.332853400527, 4766.547178018082, 5187.377514698261, 5229.058769421541, 5238.633295669343, 5242.685438873604, 5307.840764777063, 4847.079054979543, 4901.436334821541, 5015.498450154955, 5017.974910125426, 5024.346834911438, 5077.8730531737, 5096.745162741922, 5108.386993560722, 5211.348581427322, 5216.139337009351, 5086.364204474441, 5098.745062746848, 5102.183650615883, 5146.073706732749, 5162.3030890830005, 5061.215511595708, 5065.974670126626, 5070.340855688811, 5072.949270507322, 5119.488051194925, 4140.792960351971, 4171.270027745132, 4297.935530967038, 4307.8492252771, 4346.1090476452255, 3740.9064773380883, 3746.28820524105, 3747.9812600937366, 3754.699624030071, 3853.344931361675, 4382.9342559861625, 4383.430154080013, 4388.4733831940375, 4391.714538554984, 4441.378207051015, 5105.33630628016, 5133.614978876599, 5156.639035267495, 5161.612879034087, 5211.0, 4231.61915427613, 4291.6137547620865, 4292.205941900758, 4350.869473915787, 4388.956110438855, 4552.863414097583, 4565.041341318294, 4566.611837993808, 4573.6569757268335, 4592.609628181642, 4871.732054737024, 4873.293372460902, 4927.531884470969, 4932.186189278729, 4933.235348520913, 5196.350456192976, 5198.636095473432, 5202.817901373433, 5207.3490813648295, 5272.103742363884, 4779.402574678165, 4855.393075865517, 4866.099771542276, 4868.9756551217015, 4874.293227482066, 5037.899242015213, 5053.949460505348, 5064.366954130734, 5095.286659867696, 5138.07514647367, 5134.717590532557, 5151.768170432414, 5157.484251574812, 5163.845084647466, 5169.844904652867, 4775.21209000511, 4995.325631039908, 5021.974890125526, 5024.0, 5027.824026159067, 4896.36347274852, 4901.2893130496595, 4922.630802689884, 4954.8761280968265, 5040.218766091261, 4893.804247830047, 4917.336159618406, 4921.409430868319, 4927.334809800775, 4992.226204938241, 4953.628477864247, 5019.799208031638, 5027.497250274943, 5032.144535428913, 5042.39491261051, 4857.805687772449, 4877.634177436636, 4887.095887260868, 4910.165271903857, 5009.073321435546], "value": 4688.355104479146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.9492559063369, 565.6125553995513, 567.6792612174121, 570.9457601527855, 574.8534123798431, 27218.45563088737, 36109.81945090274, 37392.25215495692, 37426.0, 42095.36856947141, 40325.0, 40562.59437405625, 40602.59397406025, 40605.79697101518, 40636.59363406365, 7554.773356799291, 7741.380689544823, 7745.457817952745, 7750.224977502261, 7753.922460775405, 7363.558186508827, 7529.698812047539, 9638.084381983736, 9869.555869985868, 9882.851757223647, 9999.900000999969, 10070.043345882166, 10091.29360944734, 10095.04097110777, 10095.697129086138, 9947.502624868765, 9974.650887218913, 10019.749506262366, 10034.698959031168, 10044.347117437343, 9782.217422606174, 9871.40771553709, 9872.062154095349, 9872.506374681308, 9873.654422095264, 37510.0, 37881.43177852334, 37904.0, 37910.43134352987, 37937.620623793686, 2998.0, 3011.969880301213, 3180.236743181643, 3281.409346317662, 3294.9670503295138, 26020.609690854653, 26024.8698756505, 26232.73767262322, 26584.601230981552, 30465.086047418612, 3340.682635149657, 3349.43059679855, 3379.4761811919193, 3392.881249156292, 3396.711279541217, 250550.0, 251948.0, 252091.0, 252417.0, 252481.0, 30008.799648014272, 31078.68921310803, 51304.74347628238, 51649.225261621104, 51674.0, 33197.3360532788, 33355.666443335744, 33366.8331658345, 33386.0, 33392.0, 12760.29818359999, 12894.161879477804, 12906.67733306675, 12910.67723306906, 12914.67713307175, 8953.686620968365, 10631.84052239217, 10730.141588672888, 10744.516496757664, 10753.247272690836, 7195.676194571257, 7498.700051997968, 7683.502861570012, 7726.961365193138, 7858.410619203468, 2993.745531629836, 3016.849157542114, 3045.802022868551, 3070.109668196198, 3081.8150910944964, 762.8359902620963, 799.9680012799423, 882.6292956958093, 897.9685711000084, 943.099340130174, 25259.62110568343, 27213.727862721516, 27411.451770964868, 27756.444871102463, 27803.16590502288, 905.7961958559404, 918.5040078357612, 980.4558470049191, 991.8264303746815, 1016.3241444439365, 13446.93276533611, 14127.929360353133, 14357.856421435861, 14528.709425811636, 14536.491222807363, 373738.0, 588326.0, 599920.0, 600277.0, 602276.0, 48198.0, 48793.756031219615, 48808.9227062074, 48860.51139488631, 48871.0, 1151.424287856072, 1196.9341686207167, 1217.4156404925686, 1224.6387315741877, 1229.3710833145938, 27177.59233611458, 28406.573901391082, 28629.856850715612, 28759.137225883256, 29472.0, 41406.0, 41734.791326043174, 41807.58192418037, 41851.37222941719, 41914.58085419229, 327105.0, 331470.0, 331596.0, 332559.0, 332863.0, 23994.640080398458, 25285.0, 25586.872065639553, 25650.871745641154, 25658.0, 34675.306493870485, 37671.0, 37944.810275948446, 38741.0, 39259.80370098131, 31842.44963353986, 32561.34877302488, 33222.5016624746, 33238.833805830815, 33620.327593448485, 32680.0, 32754.578131951883, 32958.67041329556, 32980.83509582533, 34179.658203417646, 32646.83676581602, 33016.66983330136, 33089.172770680925, 33265.0, 33337.33325333528, 28488.430231394843, 29420.852895735385, 29630.0, 29752.404951900407, 29874.551881721356, 23653.52692946166, 23845.0, 23893.163739269043, 24173.51652966966, 24209.39476513101], "value": 16497.35184376896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.536863655656, 369.98335074921624, 372.0995191636238, 374.37853163748184, 398.95212574491063, 12376.814347784779, 13242.271675057867, 13710.383032763537, 16178.191090445489, 16934.83065169351, 15565.844341556582, 16210.432634857782, 16322.102284374354, 16581.50255492334, 17027.57431064224, 4389.978050109761, 4689.202835517953, 4693.225617773063, 4694.0, 4733.431988161426, 3460.2733425980573, 4624.676272660915, 4697.741624210667, 4702.694324868889, 4717.764111794414, 3581.6776490115885, 3623.7825730456125, 4265.997490589709, 5976.910346344808, 6079.0, 6038.456538911475, 6040.063790112539, 6040.426159514839, 6051.576389652726, 6060.30306514752, 4637.721736695776, 4877.414710234759, 4914.827981020683, 5004.924926126111, 5010.0981823271795, 12110.576129835501, 12286.201396909262, 12327.506899724, 12347.073969452327, 12367.072469564819, 1807.4667972948012, 1843.7050071988551, 2032.8881911494861, 2118.7457505099487, 2246.584381889356, 8573.957130214372, 8705.659625348757, 9190.586423610954, 9252.074792520694, 9363.719088427359, 1646.6295083606212, 1707.897526148435, 1714.7053974249486, 1766.6731654643932, 1807.3132209760206, 48991.0, 62645.37354626486, 66008.6699566504, 69294.3070569298, 70235.0, 8331.583420828934, 8492.660293588311, 8811.162939520735, 8812.559372031374, 9794.698245912205, 11780.882191177978, 11891.28652280866, 11896.22674526153, 11904.226225295328, 11921.880781192078, 6825.283345248777, 6959.408450281681, 6970.407515361251, 7049.541779784297, 7098.503104782616, 6275.3724627537795, 6724.630145342053, 6851.417629501549, 7051.1891132519395, 7145.535540189871, 3577.266660334625, 3697.8335974881193, 3736.7197460190596, 3806.9619303807162, 3835.271298453285, 1782.0911335219132, 1784.348712719848, 1794.7078103765268, 1809.4933418642802, 1840.2271046160645, 819.8401311744271, 821.0639870547581, 824.9298809601131, 848.9575521223915, 855.8844555984863, 16149.273282702072, 16222.918885405497, 16623.83376166247, 16902.32390704358, 17024.744628830576, 838.1995194589275, 840.2731637133958, 872.6945569050908, 885.9291256699448, 936.6628013914985, 9152.450852948845, 9276.257899368034, 10250.0, 10269.640562580274, 10580.788384232426, 363098.0, 365397.0, 366846.0, 367525.48711769347, 371176.0, 78155.60922195352, 79608.20391796008, 83398.16601834026, 83766.58116709377, 83860.0, 864.6157482175952, 874.5976850648773, 900.3652425040331, 901.1034021148868, 905.4612505559181, 15628.765568516708, 15670.843291567395, 16080.195990200677, 16487.505374838773, 16520.917395413428, 38808.417873732484, 39514.40728389019, 39595.60404395919, 39949.40075898806, 40500.79749601351, 49593.0, 52720.472795271555, 53215.46784532105, 53350.19974700305, 53386.19920701115, 4764.618830493621, 6591.110200123114, 6996.930030699627, 7012.158540975116, 7496.137944136276, 9726.902730972599, 12035.458404371999, 12041.45813438415, 12095.21381110225, 12264.570740024057, 10391.53238104272, 10450.320729152581, 10613.0, 10651.360918344924, 10975.670729878117, 10295.897041029793, 10350.948245258725, 10424.635137770141, 10436.94781526118, 10586.788264234827, 10416.479176041319, 10495.475226238505, 10560.313579617301, 10769.0, 11056.557737690724, 6808.863822723617, 6985.860282794214, 7003.964980175067, 7117.893231601426, 7309.122905251404, 8790.0, 10481.79036419252, 10580.20648451354, 10846.457677115955, 11133.332000079698], "value": 7826.124006119915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1136.3977092141167, 1351.763441397755, 1388.0283801339062, 1455.5851582299047, 1693.4411644157428, 6968.372846443819, 7490.513116647421, 7840.803979900498, 8094.838103237932, 8098.635561399737, 8048.315893149074, 8113.472624279432, 8117.553534555597, 8117.837643247146, 8118.878216826753, 2142.550064486456, 2163.7836216378314, 2166.490874644457, 2169.3600387885613, 2169.8264138868853, 2064.0917996081675, 2131.3179782469615, 2139.6362618354915, 2145.2169957965384, 2145.9892700536475, 2136.529963408048, 2136.7756385579523, 2147.291393840037, 2152.709384233132, 2204.0522575292616, 2091.518950641346, 2098.08733201058, 2100.9894950525227, 2104.0111147760604, 2104.326615483046, 2097.475631092227, 2143.9892800536054, 2147.387994421598, 2147.6456384696507, 2148.9570208595896, 7886.605669716549, 7970.123286438487, 7985.281324680748, 8066.0, 8078.151794061598, 4723.0, 4885.389326334208, 4898.412190537123, 4964.131277026542, 4966.528179822911, 2897.826130432181, 3091.3508163285737, 3105.0840002199407, 3128.2492201871614, 3145.5281707743793, 939.7133874168376, 945.7635591102224, 958.0563145301873, 963.2246041936238, 964.5273815830262, 10993.340399576051, 11094.891970525574, 11103.111751059896, 11111.833322500088, 11136.33182009082, 4098.139390727981, 4289.978550107229, 4321.67587430944, 4499.842505512292, 4527.049319642846, 8423.0, 8561.0582835888, 8563.400561960727, 8579.142085791496, 8582.82834343322, 4810.2063159578975, 4816.518348165156, 4830.879228019257, 4831.106245344622, 4837.419509658864, 3650.7261955353456, 3807.162424266657, 4115.8765237042935, 4456.799444025027, 4486.573775491323, 3469.7224222062678, 3487.3548393547276, 3584.372734771405, 3593.2274560969518, 3595.442706380515, 1027.440045175381, 1044.3211912257093, 1050.3330385205297, 1056.9577216911237, 1059.247933966892, 673.3939454490998, 744.3672878053611, 769.9461037727306, 793.3415265329878, 800.8158123631597, 4798.47216806151, 4937.185364414831, 5010.624203184776, 5091.66904151229, 5195.116830138885, 396.45883369200834, 409.7561950639365, 412.579169247366, 416.6604217562677, 418.21793246629, 3218.8873389431255, 3373.4265174920324, 3485.128717820545, 3574.356615809127, 3603.94594081089, 9741.902580974242, 10195.031472010147, 10206.642767503101, 10213.234007449471, 10237.18102551794, 10058.849117263248, 10078.647247346307, 10094.899051009395, 10098.949505252427, 10132.848007279898, 7436.66535005926, 7629.771106866803, 7640.083190017233, 7643.235676432312, 7643.885341719879, 4993.3259010034635, 5069.112905241642, 5207.088759467002, 5208.817691380935, 5418.051840927743, 9164.221041211571, 9172.587233574639, 9202.815943680955, 9312.0, 9334.159925606456, 8329.208725171098, 8686.39195256326, 9030.683926062557, 9052.81894362096, 9379.390339627902, 6061.272647282354, 7202.207757146814, 7321.6705248265025, 7432.405407567489, 7435.107787065586, 7489.925100748923, 7537.170911199873, 7559.470837041355, 7632.389408847168, 7699.461037727306, 6918.584884906721, 6941.757038503628, 6961.825954351182, 6983.755568555076, 7011.719531218694, 6869.107016088076, 6876.346747059021, 6888.207856096613, 6952.374286314053, 6980.406665433495, 6204.81385558434, 6330.746770129143, 6331.556791024584, 6333.081703152925, 6334.733053389248, 4351.216780979454, 4372.715773474842, 4373.540778218368, 4390.582894625006, 4495.325701144854, 4142.792860357031, 4205.095904380573, 4236.745795252295, 4306.354046892991, 4349.217140914539], "value": 4049.3936016107277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.2817955112218, 288.73003741501697, 295.8889370414095, 298.8670041831386, 299.8575676553639, 4655.906881862361, 4797.920467894722, 4817.20516114841, 4851.466338702744, 4888.535589119037, 4589.196890544158, 4698.177818881699, 4703.90592188156, 4709.199436095863, 4725.9839134586055, 3734.8319325630277, 3736.532933383327, 3742.513473248474, 3746.9625303746884, 3747.1943532140585, 3505.211327451316, 3740.6446387593137, 3748.2878253131817, 3753.9061523461996, 3758.830852611639, 3301.9174520637057, 3565.5721313442423, 3659.359612067891, 3693.150575367667, 3706.814659267039, 3702.5186725725753, 3704.907377315575, 3705.3330400527893, 3706.962930370689, 3707.6663100320966, 3266.7749593902286, 3275.918102047444, 3280.4423248047888, 3281.2289112058647, 3291.7860339077884, 4454.599086082236, 4611.538846115395, 4629.0, 4631.4673812511655, 4648.000679853814, 4233.206083984555, 4239.7668128252935, 4243.321068629005, 4251.213525497793, 4254.404383386328, 4959.231319145502, 4959.355283813117, 4959.504049595048, 4972.552470277692, 4973.825916092919, 3476.5837742768786, 3608.747387682863, 3626.220362622049, 3626.564812222524, 3631.6186800385844, 5156.0, 5187.610929180289, 5196.740162991873, 5199.4401679496, 5207.505286997767, 3634.6547078027547, 3638.9090272742865, 3641.089727568108, 3644.398674218777, 3645.6172101929446, 3680.4479328100465, 3684.5946945835935, 3694.9076273093387, 3696.390095634244, 3697.7041836653, 3981.92036159281, 4193.706440549132, 4202.747835129902, 4206.305959516707, 4228.85199018039, 4973.154563724175, 4990.775415106329, 4995.225740010304, 4996.225585034325, 4997.500249975046, 1233.2662066070673, 1248.2635245205372, 1256.114439320277, 1283.2941881964882, 1305.269049332358, 860.3934226370394, 861.3453775130946, 877.741066385405, 879.7536689726886, 883.7746374674417, 4401.977990110029, 4404.361367601679, 4408.470983481939, 4414.470263568328, 4414.909563305635, 5104.566111880457, 5105.8723531912, 5106.795728170906, 5107.846764597068, 5109.718965456861, 4364.672649551297, 4371.388005679208, 4379.277419225856, 4386.4736231652405, 4393.51671316155, 2308.8499247548857, 2388.5342358239977, 2403.4231784371973, 2411.409204744849, 2414.177296141402, 4228.154369126187, 4241.639460645818, 4246.8725938221905, 4250.256205164084, 4267.274563324242, 4529.479109902403, 4547.886302842389, 4560.95439045612, 4587.197240482902, 4589.816407343669, 4086.6322031017353, 4199.853005144805, 4241.26438447206, 4254.255505286563, 4259.212045771542, 4413.382126502228, 4480.879780054986, 4486.6540037987825, 4490.326451032372, 4535.886602834956, 4398.714083584557, 4407.471103467605, 4414.4702635683925, 4425.668074894332, 4428.918408348071, 4245.596668316505, 4277.272863613131, 4285.785710714515, 4539.409876716006, 4904.141775189399, 3605.891823245307, 3609.0, 3611.169431030825, 3618.782873027627, 3622.5471816022996, 4946.095753134997, 5191.195364718475, 5198.532132107977, 5210.6613070150315, 5221.582273418194, 4860.295257187618, 4918.581920536794, 4968.751562421792, 4995.17579599362, 5029.0, 5036.924446133385, 5037.647364684437, 5040.395152581714, 5046.9747651261505, 5051.469595692546, 4829.73436460984, 4974.607110009203, 4982.0, 4983.476734942924, 4995.675281106716, 5067.746612669425, 5095.235714642685, 5095.847124586268, 5096.0, 5105.33630628016, 4931.791711030821, 4947.233178857283, 4947.727874966911, 4955.8017679292425, 4959.70241785494], "value": 3672.7750684595158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.8755736410081, 674.6660403100465, 717.7344382578447, 722.9710811567537, 770.9575973321466, 11221.270617409862, 11933.16467847251, 11955.10336724747, 11993.340366279852, 12007.159498835073, 12885.162464439805, 12971.092023558354, 12971.870281297184, 13037.0, 13073.869261307384, 619.7923695561992, 632.4750457120601, 744.5867543513361, 755.958422286774, 768.535036303037, 774.8682723936917, 775.1202385292705, 775.1899265267808, 776.5069181070033, 776.54572075336, 823.9217274358956, 825.8348330333957, 826.3141592478229, 826.3224156191925, 829.854775414303, 649.331188875459, 666.3170250493234, 800.2957397490229, 817.0358976407837, 824.381713714714, 602.256213576233, 603.4599033864666, 603.4749767702083, 603.6378173096107, 603.8339456649456, 13100.279484628341, 13148.6712832179, 13164.605061848064, 13167.53913613019, 13167.86832131676, 12455.377231138498, 12717.55488557896, 13056.608301750963, 13091.0, 13211.0, 12044.759104817942, 12184.086193535431, 12216.0, 12341.69145771354, 12454.937725311316, 3297.422296807966, 3381.408253555618, 3401.2857299967036, 3415.5047518109736, 4143.875683729493, 59876.40123598752, 59982.400175998555, 60824.0, 61180.388196117914, 61281.69359153176, 10170.694879153638, 10224.335418197794, 10522.158227341793, 10785.56857725698, 10817.350958942488, 17702.203400846993, 17804.287828486715, 17893.821061789477, 17964.101794910464, 18290.63418731618, 6832.658367081626, 6903.344182302673, 6927.445804335641, 6959.478039147084, 6991.091158149408, 3778.508793856781, 3801.2777572261184, 3816.580176180618, 3888.066863952631, 3893.454916311662, 3032.529957856536, 3138.1840721412595, 3163.7785355024926, 3169.112648458435, 3169.144331030655, 532.909405401075, 534.0520575977671, 535.8687121655141, 535.9624826262125, 551.01093537101, 460.7350773305363, 488.77561707921427, 571.70271458842, 575.9683217422998, 592.2744637818638, 8057.879131813028, 8171.42800003994, 8321.674128557728, 8350.874736878952, 8810.691625793195, 464.8605418374474, 467.77780554236466, 515.6596646213482, 525.5112745146973, 551.5587529976003, 3825.885223443301, 3983.960160398417, 4151.27352713274, 4182.0, 4209.452771139732, 58192.4180758187, 58602.413975860545, 58697.70651146717, 59758.103628445606, 99452.5027374873, 88648.0, 89712.5514372437, 91967.5401623001, 93054.53472732728, 93908.53045734728, 76457.6177119122, 81371.5931420339, 81894.59052704698, 82001.0, 83628.58185709032, 7394.522834850385, 7474.364679002346, 8411.789705257173, 8490.872636910575, 8679.522626255617, 42623.786881065396, 45056.549434506545, 46302.6848657559, 46958.76520617375, 48632.73243548535, 66391.0, 66931.33068669251, 67088.32911671016, 67454.53272943513, 68307.65846170737, 12362.690932726753, 12454.688632784253, 12633.557825476431, 12756.68108297263, 13045.478180872658, 13293.534726284533, 13361.0, 13420.597382078553, 13585.0, 14148.0, 11588.47851846652, 11722.824157637471, 11964.760704785682, 12040.638780836589, 12433.12968092225, 12436.626901192978, 12965.675858103623, 13387.665308366979, 13394.866051339362, 13397.998183795524, 11807.291562506278, 12423.068269879614, 12770.361481926053, 13047.804282935953, 13158.868411315765, 9839.0, 10468.267221294436, 10584.36493810343, 10934.945325273322, 11129.666110016713, 10586.576536938435, 11098.112151028059, 11181.868424590391, 11236.269642473213, 11345.489452974802], "value": 6634.860379239298, "unit": "score"}], "name": "dromaeo_css", "value": 6252.317618196003, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 115.0, 114.0, 115.0, 116.0, 113.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 126.0, 167.0, 124.0, 127.0, 125.0, 130.0, 161.0, 123.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 163.0, 161.0, 164.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 113.0, 77.0, 78.0, 77.0, 77.0, 103.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 114.0, 83.0, 85.0, 85.0, 117.0, 84.0, 84.0, 119.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 75.0, 62.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 92.0, 85.0, 94.0, 89.0, 83.0, 82.0, 85.0, 82.0, 82.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 133.0, 137.0, 133.0, 134.0, 135.0, 134.0, 172.0, 138.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 174.0, 176.0, 179.0, 178.0, 172.0, 173.0, 173.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 69.0, 69.0, 70.0, 68.0, 71.0, 69.0, 69.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1548.4999999999998, "alertThreshold": 2.0}]} 19:26:00 INFO - Return code: 0 19:26:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:00 INFO - # TBPL SUCCESS # 19:26:00 INFO - Running post-action listener: _resource_record_post_action 19:26:00 INFO - [mozharness: 2016-09-24 02:26:00.369445Z] Finished run-tests step (success) 19:26:00 INFO - Running post-run listener: _resource_record_post_run 19:26:00 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 392753152; Read time: 0; Write time: 245856 19:26:00 INFO - TinderboxPrint: CPU usage
13.1% 19:26:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:26:00 INFO - TinderboxPrint: I/O write bytes / time
392,753,152 / 245,856 19:26:00 INFO - TinderboxPrint: CPU idle
8,344.1 (86.9%) 19:26:00 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 19:26:00 INFO - TinderboxPrint: Swap in / out
0 / 0 19:26:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99086336; Read time: 0; Write time: 56364 19:26:00 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293666816; Read time: 0; Write time: 189492 19:26:01 INFO - Running post-run listener: _upload_blobber_files 19:26:01 INFO - Blob upload gear active. 19:26:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:01 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 19:26:01 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'] 19:26:01 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 19:26:01 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:05 INFO - (blobuploader) - INFO - Done attempting. 19:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:06 INFO - (blobuploader) - INFO - Done attempting. 19:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:06 INFO - (blobuploader) - INFO - Done attempting. 19:26:06 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:06 INFO - Return code: 0 19:26:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f4fc442ddc0ddcc98c25d535d109535a9e076f982528217ba31b580ffa6c8207ee2b828ab7602e9352f54ad8116a56650439c9ff68c4a29d5ae2898ae4424ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c64aa66f0222d10d68be231759794df7472b728cef5795a332950d2d6de759ef41114fdf849faba01cb4de86bccff3951d2f76f0ddd68121c025b9ba3dfbd34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09b847fe3daab96aea91ff580c598d1d6de9dbebc154b7307769c4a7b1cc786427a3785deea027277e292cda9955acf61132f42aa96c82a3fdc9b23778afd8ff"} 19:26:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:06 INFO - Contents: 19:26:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f4fc442ddc0ddcc98c25d535d109535a9e076f982528217ba31b580ffa6c8207ee2b828ab7602e9352f54ad8116a56650439c9ff68c4a29d5ae2898ae4424ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c64aa66f0222d10d68be231759794df7472b728cef5795a332950d2d6de759ef41114fdf849faba01cb4de86bccff3951d2f76f0ddd68121c025b9ba3dfbd34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09b847fe3daab96aea91ff580c598d1d6de9dbebc154b7307769c4a7b1cc786427a3785deea027277e292cda9955acf61132f42aa96c82a3fdc9b23778afd8ff"} 19:26:06 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:06 INFO - Copying logs to upload dir... 19:26:06 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.887464 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-23 19:26:05.872870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 19:26:05.878623) ========= 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=523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f4fc442ddc0ddcc98c25d535d109535a9e076f982528217ba31b580ffa6c8207ee2b828ab7602e9352f54ad8116a56650439c9ff68c4a29d5ae2898ae4424ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c64aa66f0222d10d68be231759794df7472b728cef5795a332950d2d6de759ef41114fdf849faba01cb4de86bccff3951d2f76f0ddd68121c025b9ba3dfbd34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09b847fe3daab96aea91ff580c598d1d6de9dbebc154b7307769c4a7b1cc786427a3785deea027277e292cda9955acf61132f42aa96c82a3fdc9b23778afd8ff"} build_url:https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/RzLCwembQRKClpGpZQAfbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f4fc442ddc0ddcc98c25d535d109535a9e076f982528217ba31b580ffa6c8207ee2b828ab7602e9352f54ad8116a56650439c9ff68c4a29d5ae2898ae4424ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c64aa66f0222d10d68be231759794df7472b728cef5795a332950d2d6de759ef41114fdf849faba01cb4de86bccff3951d2f76f0ddd68121c025b9ba3dfbd34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09b847fe3daab96aea91ff580c598d1d6de9dbebc154b7307769c4a7b1cc786427a3785deea027277e292cda9955acf61132f42aa96c82a3fdc9b23778afd8ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 19:26:05.908224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:26:05.908949) ========= 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=523ca41ca1e0623de333ad52000001bf-1474681576.437994-1340117570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:26:05.988864) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 19:26:05.989196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 19:26:05.989499) ========= ========= Total master_lag: 0.19 =========