builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1482289548.67 results: success (0) buildid: 20161220181453 builduid: 910dc4cca4444dee88740c9f6d3a8296 revision: 64fc4a634e30bca2a9fb672c97b36e46162572c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.668188) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.668629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.668984) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.684317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.684682) ========= 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=32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-20 19:05:49-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-12-20 19:05:49 (19.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108881 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.808963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.809466) ========= 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=32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:48.861961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-20 19:05:48.862340) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 64fc4a634e30bca2a9fb672c97b36e46162572c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 64fc4a634e30bca2a9fb672c97b36e46162572c4 --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=32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-20 19:05:49,231 truncating revision to first 12 chars 2016-12-20 19:05:49,231 Setting DEBUG logging. 2016-12-20 19:05:49,231 attempt 1/10 2016-12-20 19:05:49,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/64fc4a634e30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 19:05:52,337 unpacking tar archive at: graphics-64fc4a634e30/testing/mozharness/ program finished with exit code 0 elapsedTime=3.497859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-20 19:05:52.375930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:52.376448) ========= script_repo_revision: 64fc4a634e30bca2a9fb672c97b36e46162572c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:52.376902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:52.377509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 19:05:52.387095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-20 19:05:52.387514) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:52 INFO - MultiFileLogger online at 20161220 19:05:52 in /builds/slave/test 19:05:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:05:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:52 INFO - {'append_to_log': False, 19:05:52 INFO - 'base_work_dir': '/builds/slave/test', 19:05:52 INFO - 'blob_upload_branch': 'Graphics', 19:05:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:52 INFO - 'branch': 'Graphics', 19:05:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:52 INFO - 'config_files': ('talos/linux_config.py',), 19:05:52 INFO - 'default_actions': ('clobber', 19:05:52 INFO - 'read-buildbot-config', 19:05:52 INFO - 'download-and-extract', 19:05:52 INFO - 'populate-webroot', 19:05:52 INFO - 'create-virtualenv', 19:05:52 INFO - 'install', 19:05:52 INFO - 'run-tests'), 19:05:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:52 INFO - 'download_minidump_stackwalk': True, 19:05:52 INFO - 'download_symbols': 'ondemand', 19:05:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:52 INFO - 'installer_path': 'installer.exe', 19:05:52 INFO - 'log_level': 'info', 19:05:52 INFO - 'log_name': 'talos', 19:05:52 INFO - 'log_to_console': True, 19:05:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:52 INFO - 'opt_config_files': (), 19:05:52 INFO - 'pip_index': False, 19:05:52 INFO - 'sps_profile': False, 19:05:52 INFO - 'sps_profile_interval': 0, 19:05:52 INFO - 'suite': 'dromaeojs', 19:05:52 INFO - 'system_bits': '32', 19:05:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:52 INFO - 'title': 'talos-linux64-ix-008', 19:05:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:52 INFO - 'use_talos_json': True, 19:05:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:52 INFO - 'work_dir': 'build'} 19:05:52 INFO - [mozharness: 2016-12-21 03:05:52.858151Z] Running clobber step. 19:05:52 INFO - Running pre-action listener: _resource_record_pre_action 19:05:52 INFO - Running main action method: clobber 19:05:52 INFO - rmtree: /builds/slave/test/build 19:05:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:53 INFO - Running post-action listener: _resource_record_post_action 19:05:53 INFO - [mozharness: 2016-12-21 03:05:53.831052Z] Finished clobber step (success) 19:05:53 INFO - [mozharness: 2016-12-21 03:05:53.831151Z] Running read-buildbot-config step. 19:05:53 INFO - Running pre-action listener: _resource_record_pre_action 19:05:53 INFO - Running main action method: read_buildbot_config 19:05:53 INFO - Using buildbot properties: 19:05:53 INFO - { 19:05:53 INFO - "project": "", 19:05:53 INFO - "product": "firefox", 19:05:53 INFO - "script_repo_revision": "default", 19:05:53 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 19:05:53 INFO - "repository": "", 19:05:53 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 19:05:53 INFO - "buildid": "20161220181453", 19:05:53 INFO - "pgo_build": "False", 19:05:53 INFO - "basedir": "/builds/slave/test", 19:05:53 INFO - "buildnumber": 28, 19:05:53 INFO - "slavename": "talos-linux64-ix-008", 19:05:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:05:53 INFO - "platform": "ubuntu64_hw", 19:05:53 INFO - "scheduler": "tests-graphics-linux64-talos", 19:05:53 INFO - "branch": "graphics", 19:05:53 INFO - "repo_path": "projects/graphics", 19:05:53 INFO - "revision": "64fc4a634e30bca2a9fb672c97b36e46162572c4", 19:05:53 INFO - "stage_platform": "linux64", 19:05:53 INFO - "builduid": "910dc4cca4444dee88740c9f6d3a8296", 19:05:53 INFO - "slavebuilddir": "test" 19:05:53 INFO - } 19:05:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:05:53 INFO - Running post-action listener: _resource_record_post_action 19:05:53 INFO - [mozharness: 2016-12-21 03:05:53.833561Z] Finished read-buildbot-config step (success) 19:05:53 INFO - [mozharness: 2016-12-21 03:05:53.833650Z] Running download-and-extract step. 19:05:53 INFO - Running pre-action listener: _resource_record_pre_action 19:05:53 INFO - Running main action method: download_and_extract 19:05:53 INFO - mkdir: /builds/slave/test/build/tests 19:05:53 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:53 INFO - trying https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:05:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:05:54 INFO - Downloaded 1361 bytes. 19:05:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:05:54 INFO - Using the following test package requirements: 19:05:54 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:05:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:05:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:05:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'jsshell-linux-x86_64.zip'], 19:05:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:05:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:05:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:05:54 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:05:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:05:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:05:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:05:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:05:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:05:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:05:55 INFO - Expected file size: 20258275 19:05:55 INFO - Obtained file size: 20258275 19:05:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:05:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:05:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:05:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:05:59 INFO - Expected file size: 20258275 19:05:59 INFO - Obtained file size: 20258275 19:06:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:06:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:06:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:06:05 INFO - Expected file size: 14409734 19:06:05 INFO - Obtained file size: 14409734 19:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:05 INFO - trying https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:06:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:06:06 INFO - Downloaded 55647405 bytes. 19:06:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:06:06 INFO - mkdir: /builds/slave/test/properties 19:06:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:06 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:06 INFO - Contents: 19:06:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:06:07 INFO - Running post-action listener: _resource_record_post_action 19:06:07 INFO - Running post-action listener: set_extra_try_arguments 19:06:07 INFO - [mozharness: 2016-12-21 03:06:07.655200Z] Finished download-and-extract step (success) 19:06:07 INFO - [mozharness: 2016-12-21 03:06:07.655426Z] Running populate-webroot step. 19:06:07 INFO - Running pre-action listener: _resource_record_pre_action 19:06:07 INFO - Running main action method: populate_webroot 19:06:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:06:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:06:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:06:07 INFO - '--tppagecycles', 19:06:07 INFO - '7'], 19:06:07 INFO - 'tests': ['tsvgm']}}, 19:06:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:06:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:06:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:06:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:06:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['damp', 'tps']}, 19:06:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'tests': ['damp', 'tps']}, 19:06:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['dromaeo_dom']}, 19:06:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['basic_compositor_video']}, 19:06:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:06:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['a11yr', 19:06:07 INFO - 'ts_paint', 19:06:07 INFO - 'tpaint', 19:06:07 INFO - 'sessionrestore', 19:06:07 INFO - 'sessionrestore_no_auto_restore', 19:06:07 INFO - 'tabpaint']}, 19:06:07 INFO - 'other-e10s': {'tests': ['a11yr', 19:06:07 INFO - 'ts_paint', 19:06:07 INFO - 'tpaint', 19:06:07 INFO - 'sessionrestore', 19:06:07 INFO - 'sessionrestore_no_auto_restore', 19:06:07 INFO - 'tabpaint']}, 19:06:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:06:07 INFO - 'ts_paint', 19:06:07 INFO - 'tpaint', 19:06:07 INFO - 'sessionrestore', 19:06:07 INFO - 'sessionrestore_no_auto_restore', 19:06:07 INFO - 'tabpaint']}, 19:06:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:06:07 INFO - 'ts_paint', 19:06:07 INFO - 'tpaint', 19:06:07 INFO - 'sessionrestore', 19:06:07 INFO - 'sessionrestore_no_auto_restore', 19:06:07 INFO - 'tabpaint']}, 19:06:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['a11yr', 19:06:07 INFO - 'ts_paint', 19:06:07 INFO - 'tpaint', 19:06:07 INFO - 'sessionrestore', 19:06:07 INFO - 'sessionrestore_no_auto_restore', 19:06:07 INFO - 'tabpaint']}, 19:06:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['a11yr', 19:06:07 INFO - 'ts_paint', 19:06:07 INFO - 'tpaint', 19:06:07 INFO - 'sessionrestore', 19:06:07 INFO - 'sessionrestore_no_auto_restore', 19:06:07 INFO - 'tabpaint']}, 19:06:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['tsvgx', 19:06:07 INFO - 'tsvgr_opacity', 19:06:07 INFO - 'tart', 19:06:07 INFO - 'tscrollx', 19:06:07 INFO - 'cart', 19:06:07 INFO - 'tsvg_static']}, 19:06:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:06:07 INFO - 'tsvgr_opacity', 19:06:07 INFO - 'tart', 19:06:07 INFO - 'tscrollx', 19:06:07 INFO - 'cart', 19:06:07 INFO - 'tsvg_static']}, 19:06:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'talos_options': ['--disable-e10s'], 19:06:07 INFO - 'tests': ['tp5o']}, 19:06:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:06:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'talos_options': ['--disable-e10s', 19:06:07 INFO - '--xperf_path', 19:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:07 INFO - 'tests': ['tp5n']}, 19:06:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:06:07 INFO - 'talos_options': ['--xperf_path', 19:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:07 INFO - 'tests': ['tp5n']}}, 19:06:07 INFO - 'talos.zip': {'path': '', 19:06:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:06:07 INFO - Running post-action listener: _resource_record_post_action 19:06:07 INFO - [mozharness: 2016-12-21 03:06:07.673150Z] Finished populate-webroot step (success) 19:06:07 INFO - [mozharness: 2016-12-21 03:06:07.673237Z] Running create-virtualenv step. 19:06:07 INFO - Running pre-action listener: _resource_record_pre_action 19:06:07 INFO - Running main action method: create_virtualenv 19:06:07 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:07 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:06:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:07 INFO - Using real prefix '/usr' 19:06:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:08 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:10 INFO - Installing pip.................done. 19:06:10 INFO - Return code: 0 19:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:06:10 INFO - Reading from file tmpfile_stdout 19:06:10 INFO - Output received: 19:06:10 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:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:06:10 INFO - Using env: {'DISPLAY': ':0', 19:06:10 INFO - 'HOME': '/home/cltbld', 19:06:10 INFO - 'LANG': 'en_US.UTF-8', 19:06:10 INFO - 'LANGUAGE': 'en_US:en', 19:06:10 INFO - 'LOGNAME': 'cltbld', 19:06:10 INFO - 'MAIL': '/var/mail/cltbld', 19:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:10 INFO - 'MOZ_NO_REMOTE': '1', 19:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:10 INFO - 'NO_EM_RESTART': '1', 19:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:10 INFO - 'PWD': '/builds/slave/test', 19:06:10 INFO - 'SHELL': '/bin/bash', 19:06:10 INFO - 'SHLVL': '1', 19:06:10 INFO - 'TERM': 'linux', 19:06:10 INFO - 'TMOUT': '86400', 19:06:10 INFO - 'USER': 'cltbld', 19:06:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:10 INFO - '_': '/tools/buildbot/bin/python'} 19:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:10 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:06:10 INFO - Cleaning up... 19:06:10 INFO - Return code: 0 19:06:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:06:10 INFO - Using env: {'DISPLAY': ':0', 19:06:10 INFO - 'HOME': '/home/cltbld', 19:06:10 INFO - 'LANG': 'en_US.UTF-8', 19:06:10 INFO - 'LANGUAGE': 'en_US:en', 19:06:10 INFO - 'LOGNAME': 'cltbld', 19:06:10 INFO - 'MAIL': '/var/mail/cltbld', 19:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:10 INFO - 'MOZ_NO_REMOTE': '1', 19:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:10 INFO - 'NO_EM_RESTART': '1', 19:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:10 INFO - 'PWD': '/builds/slave/test', 19:06:10 INFO - 'SHELL': '/bin/bash', 19:06:10 INFO - 'SHLVL': '1', 19:06:10 INFO - 'TERM': 'linux', 19:06:10 INFO - 'TMOUT': '86400', 19:06:10 INFO - 'USER': 'cltbld', 19:06:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:10 INFO - '_': '/tools/buildbot/bin/python'} 19:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:10 INFO - Downloading/unpacking psutil>=3.1.1 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:13 INFO - Installing collected packages: psutil 19:06:13 INFO - Running setup.py install for psutil 19:06:13 INFO - building 'psutil._psutil_linux' extension 19:06:13 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:06:13 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:06:13 INFO - building 'psutil._psutil_posix' extension 19:06:13 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:06:13 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:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:13 INFO - Successfully installed psutil 19:06:13 INFO - Cleaning up... 19:06:13 INFO - Return code: 0 19:06:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:13 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:13 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:06:13 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: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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:13 INFO - 'MOZ_NO_REMOTE': '1', 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': '/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 - '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:13 INFO - '_': '/tools/buildbot/bin/python'} 19:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:06:15 INFO - Installing collected packages: mozsystemmonitor 19:06:15 INFO - Running setup.py install for mozsystemmonitor 19:06:15 INFO - Successfully installed mozsystemmonitor 19:06:15 INFO - Cleaning up... 19:06:16 INFO - Return code: 0 19:06:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:06:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:16 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:16 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:06:16 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:06:16 INFO - Using env: {'DISPLAY': ':0', 19:06:16 INFO - 'HOME': '/home/cltbld', 19:06:16 INFO - 'LANG': 'en_US.UTF-8', 19:06:16 INFO - 'LANGUAGE': 'en_US:en', 19:06:16 INFO - 'LOGNAME': 'cltbld', 19:06:16 INFO - 'MAIL': '/var/mail/cltbld', 19:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:16 INFO - 'MOZ_NO_REMOTE': '1', 19:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:16 INFO - 'NO_EM_RESTART': '1', 19:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:16 INFO - 'PWD': '/builds/slave/test', 19:06:16 INFO - 'SHELL': '/bin/bash', 19:06:16 INFO - 'SHLVL': '1', 19:06:16 INFO - 'TERM': 'linux', 19:06:16 INFO - 'TMOUT': '86400', 19:06:16 INFO - 'USER': 'cltbld', 19:06:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:16 INFO - '_': '/tools/buildbot/bin/python'} 19:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:06:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:06:18 INFO - warning: no files found matching '*.txt' 19:06:18 INFO - no previously-included directories found matching 'build' 19:06:18 INFO - no previously-included directories found matching 'dist' 19:06:18 INFO - no previously-included directories found matching '.git*' 19:06:18 INFO - Installing collected packages: jsonschema, functools32 19:06:18 INFO - Running setup.py install for functools32 19:06:18 INFO - warning: no files found matching '*.txt' 19:06:18 INFO - no previously-included directories found matching 'build' 19:06:18 INFO - no previously-included directories found matching 'dist' 19:06:18 INFO - no previously-included directories found matching '.git*' 19:06:18 INFO - Successfully installed jsonschema functools32 19:06:18 INFO - Cleaning up... 19:06:18 INFO - Return code: 0 19:06:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:18 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:18 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:06:18 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:06:18 INFO - Using env: {'DISPLAY': ':0', 19:06:18 INFO - 'HOME': '/home/cltbld', 19:06:18 INFO - 'LANG': 'en_US.UTF-8', 19:06:18 INFO - 'LANGUAGE': 'en_US:en', 19:06:18 INFO - 'LOGNAME': 'cltbld', 19:06:18 INFO - 'MAIL': '/var/mail/cltbld', 19:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:18 INFO - 'MOZ_NO_REMOTE': '1', 19:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:18 INFO - 'NO_EM_RESTART': '1', 19:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:18 INFO - 'PWD': '/builds/slave/test', 19:06:18 INFO - 'SHELL': '/bin/bash', 19:06:18 INFO - 'SHLVL': '1', 19:06:18 INFO - 'TERM': 'linux', 19:06:18 INFO - 'TMOUT': '86400', 19:06:18 INFO - 'USER': 'cltbld', 19:06:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:18 INFO - '_': '/tools/buildbot/bin/python'} 19:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:06:18 INFO - Cleaning up... 19:06:18 INFO - Return code: 0 19:06:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:18 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:18 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:06:18 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:06:18 INFO - Using env: {'DISPLAY': ':0', 19:06:18 INFO - 'HOME': '/home/cltbld', 19:06:18 INFO - 'LANG': 'en_US.UTF-8', 19:06:18 INFO - 'LANGUAGE': 'en_US:en', 19:06:18 INFO - 'LOGNAME': 'cltbld', 19:06:18 INFO - 'MAIL': '/var/mail/cltbld', 19:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:18 INFO - 'MOZ_NO_REMOTE': '1', 19:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:18 INFO - 'NO_EM_RESTART': '1', 19:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:18 INFO - 'PWD': '/builds/slave/test', 19:06:18 INFO - 'SHELL': '/bin/bash', 19:06:18 INFO - 'SHLVL': '1', 19:06:18 INFO - 'TERM': 'linux', 19:06:18 INFO - 'TMOUT': '86400', 19:06:18 INFO - 'USER': 'cltbld', 19:06:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:18 INFO - '_': '/tools/buildbot/bin/python'} 19:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:06:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:06:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 INFO - Downloading docopt-0.6.1.tar.gz 19:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:06:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:06:21 INFO - Running setup.py install for blobuploader 19:06:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:06:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:06:22 INFO - Running setup.py install for requests 19:06:22 INFO - Running setup.py install for docopt 19:06:22 INFO - Successfully installed blobuploader requests docopt 19:06:22 INFO - Cleaning up... 19:06:22 INFO - Return code: 0 19:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:22 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:22 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:06:22 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:06:22 INFO - Using env: {'DISPLAY': ':0', 19:06:22 INFO - 'HOME': '/home/cltbld', 19:06:22 INFO - 'LANG': 'en_US.UTF-8', 19:06:22 INFO - 'LANGUAGE': 'en_US:en', 19:06:22 INFO - 'LOGNAME': 'cltbld', 19:06:22 INFO - 'MAIL': '/var/mail/cltbld', 19:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:22 INFO - 'MOZ_NO_REMOTE': '1', 19:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:22 INFO - 'NO_EM_RESTART': '1', 19:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:22 INFO - 'PWD': '/builds/slave/test', 19:06:22 INFO - 'SHELL': '/bin/bash', 19:06:22 INFO - 'SHLVL': '1', 19:06:22 INFO - 'TERM': 'linux', 19:06:22 INFO - 'TMOUT': '86400', 19:06:22 INFO - 'USER': 'cltbld', 19:06:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:22 INFO - '_': '/tools/buildbot/bin/python'} 19:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:22 INFO - Running setup.py (path:/tmp/pip-0llkmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:22 INFO - Running setup.py (path:/tmp/pip-85wBBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:22 INFO - Running setup.py (path:/tmp/pip-PyZOCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:23 INFO - Running setup.py (path:/tmp/pip-Dzht7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:23 INFO - Running setup.py (path:/tmp/pip-qIbIfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:23 INFO - Running setup.py (path:/tmp/pip-a0bGz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:23 INFO - Running setup.py (path:/tmp/pip-kyRUTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:23 INFO - Running setup.py (path:/tmp/pip-J_Q6Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:23 INFO - Running setup.py (path:/tmp/pip-F0LnD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:23 INFO - Running setup.py (path:/tmp/pip-eb59Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:23 INFO - Running setup.py (path:/tmp/pip-n3D2Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:23 INFO - Running setup.py (path:/tmp/pip-o08Hgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:23 INFO - Running setup.py (path:/tmp/pip-SyfdEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:23 INFO - Running setup.py (path:/tmp/pip-YCyytM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:23 INFO - Running setup.py (path:/tmp/pip-9baH8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:23 INFO - Running setup.py (path:/tmp/pip-xZeGzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:23 INFO - Running setup.py (path:/tmp/pip-VVDzC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:06:24 INFO - Running setup.py install for manifestparser 19:06:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Running setup.py install for mozcrash 19:06:24 INFO - Running setup.py install for mozdebug 19:06:24 INFO - Running setup.py install for mozdevice 19:06:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Running setup.py install for mozfile 19:06:24 INFO - Running setup.py install for mozhttpd 19:06:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Running setup.py install for mozinfo 19:06:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Running setup.py install for mozInstall 19:06:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:06:24 INFO - Running setup.py install for mozleak 19:06:24 INFO - Running setup.py install for mozlog 19:06:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Running setup.py install for moznetwork 19:06:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Running setup.py install for mozprocess 19:06:25 INFO - Running setup.py install for mozprofile 19:06:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Running setup.py install for mozrunner 19:06:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Running setup.py install for mozscreenshot 19:06:25 INFO - Running setup.py install for moztest 19:06:25 INFO - Running setup.py install for mozversion 19:06:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:06:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:06:25 INFO - Cleaning up... 19:06:25 INFO - Return code: 0 19:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:25 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:25 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:06:25 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:06:25 INFO - Using env: {'DISPLAY': ':0', 19:06:25 INFO - 'HOME': '/home/cltbld', 19:06:25 INFO - 'LANG': 'en_US.UTF-8', 19:06:25 INFO - 'LANGUAGE': 'en_US:en', 19:06:25 INFO - 'LOGNAME': 'cltbld', 19:06:25 INFO - 'MAIL': '/var/mail/cltbld', 19:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:25 INFO - 'MOZ_NO_REMOTE': '1', 19:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:25 INFO - 'NO_EM_RESTART': '1', 19:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:25 INFO - 'PWD': '/builds/slave/test', 19:06:25 INFO - 'SHELL': '/bin/bash', 19:06:25 INFO - 'SHLVL': '1', 19:06:25 INFO - 'TERM': 'linux', 19:06:25 INFO - 'TMOUT': '86400', 19:06:25 INFO - 'USER': 'cltbld', 19:06:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:25 INFO - '_': '/tools/buildbot/bin/python'} 19:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:26 INFO - Running setup.py (path:/tmp/pip-_80MxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:26 INFO - Running setup.py (path:/tmp/pip-VQeh_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:26 INFO - Running setup.py (path:/tmp/pip-HKsqYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:26 INFO - Running setup.py (path:/tmp/pip-N152IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:26 INFO - Running setup.py (path:/tmp/pip-wPWk4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:26 INFO - Running setup.py (path:/tmp/pip-ZCP8fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:26 INFO - Running setup.py (path:/tmp/pip-4AL3YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:26 INFO - Running setup.py (path:/tmp/pip-9rXhvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:26 INFO - Running setup.py (path:/tmp/pip-QJCPVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:26 INFO - Running setup.py (path:/tmp/pip-mp0nDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:26 INFO - Running setup.py (path:/tmp/pip-ZOJLRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:26 INFO - Running setup.py (path:/tmp/pip-KYEV7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:26 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:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:26 INFO - Running setup.py (path:/tmp/pip-2tCZp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:27 INFO - Running setup.py (path:/tmp/pip-InwToW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:27 INFO - Running setup.py (path:/tmp/pip-AbgE8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:27 INFO - Running setup.py (path:/tmp/pip-lRsvZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:27 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:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:27 INFO - Running setup.py (path:/tmp/pip-Vr263Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:27 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:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:06:27 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:06:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:06:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:06:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:29 INFO - Downloading blessings-1.6.tar.gz 19:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:06:29 INFO - Installing collected packages: blessings 19:06:29 INFO - Running setup.py install for blessings 19:06:29 INFO - Successfully installed blessings 19:06:29 INFO - Cleaning up... 19:06:29 INFO - Return code: 0 19:06:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:29 INFO - Reading from file tmpfile_stdout 19:06:29 INFO - Current package versions: 19:06:29 INFO - argparse == 1.2.1 19:06:29 INFO - blessings == 1.6 19:06:29 INFO - blobuploader == 1.2.4 19:06:29 INFO - docopt == 0.6.1 19:06:29 INFO - functools32 == 3.2.3-2 19:06:29 INFO - jsonschema == 2.5.1 19:06:29 INFO - manifestparser == 1.1 19:06:29 INFO - mozInstall == 1.12 19:06:29 INFO - mozcrash == 1.0 19:06:29 INFO - mozdebug == 0.1 19:06:29 INFO - mozdevice == 0.49 19:06:29 INFO - mozfile == 1.2 19:06:29 INFO - mozhttpd == 0.7 19:06:29 INFO - mozinfo == 0.9 19:06:29 INFO - mozleak == 0.1 19:06:29 INFO - mozlog == 3.4 19:06:29 INFO - moznetwork == 0.27 19:06:29 INFO - mozprocess == 0.23 19:06:29 INFO - mozprofile == 0.28 19:06:29 INFO - mozrunner == 6.13 19:06:29 INFO - mozscreenshot == 0.1 19:06:29 INFO - mozsystemmonitor == 0.3 19:06:29 INFO - moztest == 0.7 19:06:29 INFO - mozversion == 1.4 19:06:29 INFO - psutil == 3.1.1 19:06:29 INFO - requests == 1.2.3 19:06:29 INFO - wsgiref == 0.1.2 19:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:29 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:29 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:06:29 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:06:29 INFO - Using env: {'DISPLAY': ':0', 19:06:29 INFO - 'HOME': '/home/cltbld', 19:06:29 INFO - 'LANG': 'en_US.UTF-8', 19:06:29 INFO - 'LANGUAGE': 'en_US:en', 19:06:29 INFO - 'LOGNAME': 'cltbld', 19:06:29 INFO - 'MAIL': '/var/mail/cltbld', 19:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:29 INFO - 'MOZ_NO_REMOTE': '1', 19:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:29 INFO - 'NO_EM_RESTART': '1', 19:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:29 INFO - 'PWD': '/builds/slave/test', 19:06:29 INFO - 'SHELL': '/bin/bash', 19:06:29 INFO - 'SHLVL': '1', 19:06:29 INFO - 'TERM': 'linux', 19:06:29 INFO - 'TMOUT': '86400', 19:06:29 INFO - 'USER': 'cltbld', 19:06:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:29 INFO - '_': '/tools/buildbot/bin/python'} 19:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 INFO - Cleaning up... 19:06:30 INFO - Return code: 0 19:06:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:06:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:30 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 0x1a961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e07c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, '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': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', '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:06:30 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:06:30 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:06:30 INFO - Using env: {'DISPLAY': ':0', 19:06:30 INFO - 'HOME': '/home/cltbld', 19:06:30 INFO - 'LANG': 'en_US.UTF-8', 19:06:30 INFO - 'LANGUAGE': 'en_US:en', 19:06:30 INFO - 'LOGNAME': 'cltbld', 19:06:30 INFO - 'MAIL': '/var/mail/cltbld', 19:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:30 INFO - 'MOZ_NO_REMOTE': '1', 19:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:30 INFO - 'NO_EM_RESTART': '1', 19:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:30 INFO - 'PWD': '/builds/slave/test', 19:06:30 INFO - 'SHELL': '/bin/bash', 19:06:30 INFO - 'SHLVL': '1', 19:06:30 INFO - 'TERM': 'linux', 19:06:30 INFO - 'TMOUT': '86400', 19:06:30 INFO - 'USER': 'cltbld', 19:06:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:30 INFO - '_': '/tools/buildbot/bin/python'} 19:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:06:30 INFO - Cleaning up... 19:06:30 INFO - Return code: 0 19:06:30 INFO - Running post-action listener: _resource_record_post_action 19:06:30 INFO - Running post-action listener: _start_resource_monitoring 19:06:30 INFO - Starting resource monitoring. 19:06:30 INFO - [mozharness: 2016-12-21 03:06:30.263574Z] Finished create-virtualenv step (success) 19:06:30 INFO - [mozharness: 2016-12-21 03:06:30.264098Z] Running install step. 19:06:30 INFO - Running pre-action listener: _resource_record_pre_action 19:06:30 INFO - Running main action method: install 19:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:30 INFO - Reading from file tmpfile_stdout 19:06:30 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:30 INFO - Reading from file tmpfile_stdout 19:06:30 INFO - Output received: 19:06:30 INFO - Usage: mozinstall [options] installer 19:06:30 INFO - Options: 19:06:30 INFO - -h, --help show this help message and exit 19:06:30 INFO - -d DEST, --destination=DEST 19:06:30 INFO - Directory to install application into. [default: 19:06:30 INFO - "/builds/slave/test"] 19:06:30 INFO - --app=APP Application being installed. [default: firefox] 19:06:30 INFO - mkdir: /builds/slave/test/build/application 19:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:06:46 INFO - Reading from file tmpfile_stdout 19:06:46 INFO - Output received: 19:06:46 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:46 INFO - Running post-action listener: _resource_record_post_action 19:06:46 INFO - [mozharness: 2016-12-21 03:06:46.623098Z] Finished install step (success) 19:06:46 INFO - [mozharness: 2016-12-21 03:06:46.623343Z] Running run-tests step. 19:06:46 INFO - Running pre-action listener: _resource_record_pre_action 19:06:46 INFO - Running main action method: run_tests 19:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:46 INFO - Python 2.7.3 19:06:46 INFO - Return code: 0 19:06:46 INFO - grabbing minidump binary from tooltool 19:06:46 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:46 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 0x1e053f0>, '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 0x1e05cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e061a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:46 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:46 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:46 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:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:46 INFO - Return code: 0 19:06:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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:46 INFO - Using env: {'DISPLAY': ':0', 19:06:46 INFO - 'HOME': '/home/cltbld', 19:06:46 INFO - 'LANG': 'en_US.UTF-8', 19:06:46 INFO - 'LANGUAGE': 'en_US:en', 19:06:46 INFO - 'LOGNAME': 'cltbld', 19:06:46 INFO - 'MAIL': '/var/mail/cltbld', 19:06:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:46 INFO - 'MOZ_NO_REMOTE': '1', 19:06:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:46 INFO - 'NO_EM_RESTART': '1', 19:06:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:46 INFO - 'PWD': '/builds/slave/test', 19:06:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:46 INFO - 'SHELL': '/bin/bash', 19:06:46 INFO - 'SHLVL': '1', 19:06:46 INFO - 'TERM': 'linux', 19:06:46 INFO - 'TMOUT': '86400', 19:06:46 INFO - 'USER': 'cltbld', 19:06:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890', 19:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:46 INFO - '_': '/tools/buildbot/bin/python'} 19:06:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:46 INFO - mozversion application_buildid: 20161220181453 19:06:46 INFO - mozversion application_changeset: 64fc4a634e30bca2a9fb672c97b36e46162572c4 19:06:46 INFO - mozversion application_display_name: Nightly 19:06:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:46 INFO - mozversion application_name: Firefox 19:06:46 INFO - mozversion application_remotingname: firefox 19:06:46 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:06:46 INFO - mozversion application_vendor: Mozilla 19:06:46 INFO - mozversion application_version: 53.0a1 19:06:46 INFO - mozversion platform_buildid: 20161220181453 19:06:46 INFO - mozversion platform_changeset: 64fc4a634e30bca2a9fb672c97b36e46162572c4 19:06:46 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:06:46 INFO - mozversion platform_version: 53.0a1 19:06:46 INFO - using testdate: 1482289606 19:06:46 INFO - actual date: 1482289606 19:06:46 INFO - starting webserver on 'localhost:40452' 19:06:46 INFO - SUITE-START | Running 2 tests 19:06:46 INFO - TEST-START | dromaeo_css 19:06:46 INFO - operating with platform_type : linux_ 19:06:46 INFO - Initialising browser for dromaeo_css test... 19:06:46 INFO - TEST-INFO | started process 17615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOaCD96/profile http://localhost:40452/getInfo.html) 19:06:50 INFO - PROCESS | 17615 | __metrics Screen width/height:1600/1200 19:06:50 INFO - PROCESS | 17615 | colorDepth:24 19:06:50 INFO - PROCESS | 17615 | Browser inner width/height: 1024/697 19:06:50 INFO - PROCESS | 17615 | __metrics 19:06:51 INFO - PROCESS | 17615 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:06:51 INFO - PROCESS | 17615 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:06:52 INFO - PROCESS | 17615 | console.error: PushService: 19:06:52 INFO - PROCESS | 17615 | stateChangeProcessEnqueue: Error transitioning state 19:06:52 INFO - PROCESS | 17615 | UnknownError 19:06:52 INFO - TEST-INFO | 17615: exit 0 19:06:52 INFO - Browser initialized. 19:06:52 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:52 INFO - TEST-INFO | started process 17696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOaCD96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:04 INFO - PROCESS | 17696 | RSS: Main: 155873280 19:07:04 INFO - PROCESS | 17696 | 19:07:55 INFO - PROCESS | 17696 | 1482289675579 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:10:09 INFO - PROCESS | 17696 | Cycle 1(1): loaded http://localhost:40452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40452/tests/dromaeo/cssquery-ext.html) 19:10:11 INFO - PROCESS | 17696 | RSS: Main: 213041152 19:10:11 INFO - PROCESS | 17696 | 19:13:14 INFO - PROCESS | 17696 | Cycle 1(1): loaded http://localhost:40452/tests/dromaeo/cssquery-ext.html (next: http://localhost:40452/tests/dromaeo/cssquery-jquery.html) 19:13:14 INFO - PROCESS | 17696 | RSS: Main: 245190656 19:13:14 INFO - PROCESS | 17696 | 19:16:17 INFO - PROCESS | 17696 | Cycle 1(1): loaded http://localhost:40452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40452/tests/dromaeo/cssquery-mootools.html) 19:16:18 INFO - PROCESS | 17696 | RSS: Main: 186396672 19:16:18 INFO - PROCESS | 17696 | 19:19:20 INFO - PROCESS | 17696 | Cycle 1(1): loaded http://localhost:40452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40452/tests/dromaeo/cssquery-prototype.html) 19:19:20 INFO - PROCESS | 17696 | RSS: Main: 187064320 19:19:20 INFO - PROCESS | 17696 | 19:22:24 INFO - PROCESS | 17696 | Cycle 1(1): loaded http://localhost:40452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40452/tests/dromaeo/cssquery-yui.html) 19:22:24 INFO - PROCESS | 17696 | RSS: Main: 187211776 19:22:24 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | Cycle 1(1): loaded http://localhost:40452/tests/dromaeo/cssquery-yui.html (next: http://localhost:40452/tests/dromaeo/cssquery-dojo.html) 19:25:28 INFO - PROCESS | 17696 | RSS: Main: 280829952 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | __start_tp_report 19:25:28 INFO - PROCESS | 17696 | _x_x_mozilla_page_load 19:25:28 INFO - PROCESS | 17696 | _x_x_mozilla_page_load_details 19:25:28 INFO - PROCESS | 17696 | |i|pagename|runs| 19:25:28 INFO - PROCESS | 17696 | |0;dojo.html;2605.8175927685065;2644.4578861333403;2662.8668566571673;2673.8663066846666;2683.476722039202;4633.119707255628;4660.883477913054;4754.120487709772;4827.951720482794;4850.442199147099;4713.740744259073;4776.020915712279;4801.327814106028;4835.41974963004;4881.536254055859;4341.696081274312;4353.651707863379;4397.890052748675;4415.161119387322;4416.645391881534;4000.4999375078114;4424.646028317727;4439.5560443955665;4478.373027776114;4518.367428560005;4224.683148763855;4427.114577084596;4428.955710442902;4441.644668426518;4528.841490547831;4262.722923010026;4310.956890431087;4336.501302350239;4370.650347972155;4390.143921935224;4359.12817436514;4363.127374525107;4374.234508960951;4395.758233297167;4426.84506042287;4770.403699537558;4775.689580177277;4796.160671882407;4801.399825021872;4802.687825291345;4873.926891096637;4875.512448755132;4888.902221955541;5029.446760856303;5098.872528186825;5096.082705113078;5097.337346145015;5106.055379754757;5127.128388173982;5151.974240128813;4766.356541866873;4767.690100143514;4770.499097594772;4771.355866957986;4807.134715751128;5075.137226671474;5119.180931051014;5203.167493201146;5205.895882082413;5256.684598924076;4962.652614316963;4992.8751781205765;5019.372578427697;5041.0422019816115;5099.59203263738;5127.512886275797;5128.871778205575;5131.050755610224;5131.97434012835;5132.358455193101;5036.219385995177;5089.109405853961;5089.211172268304;5092.2361645753435;5122.410922743932;4913.950860491421;4961.677490963076;4964.131277026506;5002.52476014778;5004.774785134678;4299.78501074945;4302.591253830881;4319.611234988866;4327.7619730914475;4374.4531933508315;3771.2080463102507;3776.188119554309;3782.829772660237;3816.0841398064263;3820.6370394812448;4240.703150779477;4328.5455027222315;4329.242382583036;4331.350297455407;4374.431323927869;4998.325226094504;5079.212722028092;5124.205748109049;5130.358705161855;5204.8959020819375;4375.27807911691;4376;4382.101669157815;4385;4422.027154026109;4576.039031803359;4617;4624;4634.652401069866;4658.650601204923;4615.376924115336;4658.928446457266;4663.720176789404;4708.552687494683;4709.576138147446;5139.408967968731;5141.640085194001;5142.820001300086;5172.663776854492;5201;4746.2168742157155;4759.571638552547;4763.571278584944;4763.785629646605;4808.567228949411;4862.246351815475;4908.631852610997;4912.48418916023;5019.824306149268;5117.923231151462;5030.62270329734;5040.8991820162655;5042.294078828893;5042.949570504395;5043.5460808527405;4898;4902.362692849907;4905.7792399342825;4908.509149085063;4911.238757992517;4857.489963553918;4908;4909.214525675875;4910.852674419773;4910.852674419773;4819.638527110411;4833;4838.491958344323;4867.90264194707;4903.092927808367;4992.176290912104;5006.949930500648;5017.9498205018945;5049.697018178921;5064.924026139684;4703.576678098988;4739.834105806281;4787.976060119677;4796.5203479653155;4804.495527969652 19:25:28 INFO - PROCESS | 17696 | |1;ext.html;517.6066189695831;548.202365558113;551.2502995925543;552.930883639545;585.9677717725529;33760.324793504114;37764.62235377645;37772;37801.81099094507;37908;37965.81017094911;38393.23213535728;38444.61555384445;38501.61498385015;38533.03667408316;7251.6374181290985;7308.524945878501;7442.590657513834;7535.54786712799;9905.306628536006;9692.612295508172;9762.902370976306;9788.461634610094;9802.068803463659;9816.50917454128;9832;9874.16069634082;9918.156956658657;9919;9923;9792.16766574842;9837.950810245939;9841.655542056065;9842.360246584021;9863.30956833022;9773.951130244375;9837.311388202828;9849;9850.06424389689;9850.359726617819;37514.43728344077;37855.053623659354;37855.81072094622;37945.62054379449;37949;2910.301527633374;2983.34366439383;2991.0428662827903;3088.6139232595924;3303.7687361884678;27456;28023.299417514725;28154.718452815618;28865.56701649477;29339.41321173586;3359.076254030161;3417.1627951152127;3462.567179102612;3517.0855577549764;3517.120719820045;249318;249943;250093;250239.99999999817;251386;49572.25641615379;50117.74941125344;50120;50129;50163.24755128676;51675;51803.48849416814;51850;51885.740571296905;51915.48084519182;13550.119242249222;13863.584092477242;13902.026858120036;13914.30428478572;13925.860741392456;9405.247580193569;9834.114929656222;10656.62701805433;10892.945535272273;10974.890251097388;14332.928335358465;14381.352839122264;14390.568282951528;14689.632759180893;14756.188409637572;5798.217240672539;5868.383819698955;5868.79689663618;5904.380040095814;5939.673317967553;762.3139174742665;935.6304259817334;970.7281961050776;971.5870754929268;1011.585250047477;26448.33879152998;26511.33721656974;26951.460970780474;27019;27296.863515682693;967.617790972576;974.2595627323285;994.8821915098886;998.7602975285879;1019.8215312320315;13807.17156970585;14049.648758780908;14119.576412707635;14274.785878211835;14275.64310892236;334709;336476;337655;337700;338500;47340.28989565159;47401.5259847404;47462;47515.57453276407;47631;1051.7896420715736;1081.4430568257353;1115.5816568786543;1154.065207182185;1160.3328086350214;26080.478390432465;27284;28227.294317642223;28647;28675.28311792222;39148.41277380899;39826.203475930895;39859.40210896897;39889.2022159561;39941.80029099836;219038;219878;220737;220947;482262;22562.32313030612;22702.864856757427;22944;22962.177942632235;22985.540289194458;30203;30707.692923070485;32907.341853163285;33345.16637083995;35527.46708799319;30198.69801302047;31113.37773244568;31248.375032499676;31475.213119672193;32021.519677205328;30468;30893;31119.222019449695;31400.68599314069;32382.190445238117;30643.54034689437;30738.53892191574;31265.374692506477;31361.52957705682;31488.842555787076;26719.46561068729;28191.71808281891;28963.85518072396;28973.855130724212;29392.26519337034;22261.332160035225;22432.49457657261;22635.98138083823;22728.318150455514;22751.772482275628 19:25:28 INFO - PROCESS | 17696 | |2;jquery.html;350.8140685436716;373.4249256145538;377;381.09870157078507;400.96591789697874;12353.567625133122;12834.807477887827;16155.596110097253;16177.676446471063;16187.028778273283;14034.578962631138;14230.288485575731;14244.287785610704;14250.073745206555;14285.285735713198;3663.084228942764;4731.148393289215;4896.216605343146;4896.8041278349;4905.068037072962;3801.3727734923705;5689.203511508392;5908.734106965197;5931.970340148293;6047.818565443022;5751.539876809845;5868.149118377833;5982.940170598304;5993.160957465958;5994.8801023979495;5920;5956.463918247378;5962.731677074542;5964.956132676764;5969.403059694017;5033.119204139298;5170.500554839092;5217.58259339252;5259.15853463444;5264.341957255343;19658.311959081508;19714;19716.60566788656;19857.304994325128;19927;2026.7567891853073;2133.370655656585;2419.8548087114827;2504.9874750626313;2510.3975045989014;11783.865123600393;12926.612201633967;13067.215967042008;13248;13429.32853357338;1704.420497031003;1738.6609611125837;1753.526547832091;1764.4265613675607;1781.7060185069447;64797.872234054215;64911.67544162296;65216.673916630585;65623.67188164077;65801.67099164473;9189.127032931861;9203.815923681488;9280.907190928005;9467.573959171716;9736;12957.352132393342;12960.805587916;12977;12986.415611297514;12992.675183120498;6882.4149947254045;6969.82575435608;7044.330788575077;7064.293570642894;7217.170025447036;6624.403803657694;6628.6582288600075;6725.024871393621;6836.794896153024;6905.965470172617;5885.234919460443;5887.469257992952;5992.161097446361;6013.609115407485;6153.907691384633;1625.4392234679017;1748.3531093495233;1761.6388640328703;1783.67893779121;1792.9193186306386;751.6392131776669;807.8384323135397;845.4377838737171;866.9003064647646;869.3393021303855;16465;16595;16636.750448743278;16828.495145145665;17559.385421510186;825.5500752090005;827.9461834980707;839.7606682095574;844.7381311793364;863.4301361101643;7658.081030276402;9781.119699227103;9788.951055244821;9789.657361992297;9821.459819709984;236110;353858;364447;366135;367066;56007.159892601645;66586.66706666532;66894.33105668979;77539.2246077532;80292;898.8382091223511;935.9578818953163;949.9382540134869;951.9476428796482;966.0580933589694;14368.92233082502;14818.555443336718;15490.535283941499;15628.68742625164;15810.920945395199;33688.326233474705;36612.450813238356;37124.81437592795;37659.81170094242;38575.22849543049;48364.516354836;50507;50897.23654145265;51521.48478515317;52087;5020.046191223656;5856.326522449973;6743.595384276763;6832.248452670302;7654.693812247448;10911.181661375269;11015.394153321644;11383.260088094248;11406.942965285121;11542.480588373375;9720.708378748648;10377.740556486147;10380.06579407857;10512.684619461428;10547;9854.655087071918;9986.450745209084;10113.898861011296;10119.79760404773;10212.846807297748;9785.31502794826;10113.14038306752;10170.288079834341;10649.148068154684;10828.729281768019;6482.222133344029;7254.383377412979;7373.115226172894;7391.852162956603;7729.497582657109;8469;10049.14582260516;10158.238132140266;10372.688819335432;10505.739311282696 19:25:28 INFO - PROCESS | 17696 | |3;mootools.html;1340.3834236251325;1358.476986360251;1449.2826051104705;1637.2386840119343;1686.1737748503238;7042.330978557035;7455.254474552556;7458.627068646573;7459.701611935523;7464;6554.639494827783;6840.315968403157;7138.821529461753;7367.8894816577795;7377.631118444083;2114.2600089968505;2151.7310336207975;2153.7307836520436;2156.417767202854;2156.7196264485597;2126.627840127979;2160.643493823517;2180.8364372672036;2182.5267944137645;2183.737951445829;1836.889786612801;1900.4013735673218;2060.4539796953745;2132.2217390652454;2132.744070711517;2127.308624696972;2128.3934078787624;2147.194801949269;2150.290404166621;2150.7956744109283;2145.62451570976;2159.66525188596;2180.1170525937023;2183.170395249811;2183.2031308572414;7454.85090298191;7484.513506622052;7488.9625551871895;7523.887141692879;7538.246175382473;4432.578905004019;4579.129965306581;4580.38164847748;4586.082783443325;4595.287730401793;2904.0416662501325;3001.969980300191;3042.4067306875168;3047;3062.2650563864736;871.4248595926721;910.576581889418;935.209747763139;942.8727121838601;951.5432592355708;9908.603655853758;9947.303688741791;9964.90035099647;9973.551190196531;9987;3935.311320518898;4192.224438478891;4267;4275.5724427557;4320.870373888788;8672.523011234316;8676.869846952175;8678.6528538859;8681.826363472695;8690.826183476294;4525.298578720303;4622.95377046232;4626.953730462719;4630.143423466602;4644.071185762861;4038.8788336349958;4134.689898257643;4166.854160104382;4174.582541745862;4183.456150700389;3462.584489861182;3508.52634894286;3590.838412271454;3598.5321908151773;3606.2426890352795;1155.8959693627614;1164.3770582738364;1171.1275100050516;1186.827909953052;1187.4300335838846;660.8248814064277;710.0344575545532;837.535167981776;849.5370023337296;851.476342049635;4883.4628190898975;4973.204287314013;4994.3507344045765;5069.670471419346;5116.130257856174;819.5616692704266;835.365122506887;858.9699360522477;861.1603686405705;864.5072308784058;3283.359744849779;3318.601767787881;3322.734181265493;3351.8491667875005;3371.275175837158;8523.531205783742;9039.954800225956;9051.456912585267;9073.092690731006;9090.727278181665;8536.530490823065;9000.324975626854;9020.188183063556;9023;9025.007249202583;6953.235144134142;7120.786376408716;7138.785836424916;7140.92859071413;7145.214026457085;4932.605391568738;5064.468230835857;5103.387593488805;5158.587313015025;5275.182346736262;7919.485233459806;8091.231333023354;8242.505449673039;8362.749117526484;8462.153784621489;7970.202979701983;8163;8202.671893124209;8383.53890536002;8408.789780255542;6447.806565803034;6553.80338589824;6609.074729537965;6612.437942774918;6649.800505984828;7061.611611361219;7196.532225405332;7202.71189152449;7202.927970720226;7205.171405288249;6333.936660633519;6469.159009328757;6526.347365263436;6670.366315200048;6699.296573859675;6470.126532917996;6506.804795856132;6512.08830763684;6520.804375868732;6525.053867189136;6063.272407311151;6174.722137503913;6178.752849886134;6180.443760061616;6183.103449999815;4475.865724028285;4537.795799189111;4582.358469814162;4587.72473651582;4610.2623580227;4434.17967675981;4471.932921006122;4590.380298659638;4602.79287432073;4709.481956984798 19:25:28 INFO - PROCESS | 17696 | |4;prototype.html;357.4995006990213;360.6375592529507;364.96350364963496;365.14009507609563;369.7467234944062;4846.151923413402;4856.8343597536605;4868.805247790088;4880.4143502779625;4890.339804126442;4784.736839473828;4804.471508134111;4812.807487700487;4814.66297359185;4815.159056156866;3609.9458508122398;3682.815859207042;3782.186829831586;3799.67702745267;3832.198866532739;3829.955185627433;3843.3466310727244;3844.1735026969195;3856.826442810066;3867.400552914303;3815.923681526368;3825.713071519633;3826.9808650956847;3833.2558685798035;3835.5013848199696;3641.6540428659237;3745.9438108428394;3748.3065632857874;3811.714121440903;3812.9791210658395;3473.8436770345397;3479.373712731707;3481;3481.3559491494157;3483.7213022958103;4700.670953033289;4709.788059537329;4723.527647235283;4725.810967561293;4742.430908290993;4310.288802347609;4372.759498227596;4402.933955990663;4443.688941774077;4444.422225110748;4964.453910069889;4973.856013116967;4974.1543937530705;4977.15388383972;5008.572556821288;3752.887413377603;3775.716821238391;3804.239152169577;3806.1626442182674;3812.542494900602;5015.799368025275;5175.404828444777;5207.531322181022;5213.374395072616;5242.79028838846;3871.0128917125953;3876.186000939778;3885.4366116913457;3898.434726964574;3913.3151698452657;3912.9608703912595;3958.5843486434087;3965.8215380307956;3966.147278335172;3983.64147226751;4363.432753742057;4372.781360931941;4388.978055109704;4402.908618406232;4404.977975110104;4875.317455556225;4914.869579996621;4918.19662792205;4931.5315045070665;4971.37857767779;1324.9466673994004;1345.2264947655137;1346.7239215960703;1351.2297990145523;1353.6886516101156;907.6233363154217;945.2479587949058;970.5195928015678;982.1602529837029;983.1544871410581;4076.571959944163;4265.786710664454;4357.211384713785;4377.212101821703;4386.298192289219;5115;5118.232265160182;5135.6918584885025;5136.5890728741615;5147.50722290539;4288.978555107205;4327.285997810389;4342.08816148606;4350.32569951658;4365.515724653633;2464.496657039205;2631.8552479613422;2646.775024122933;2661.1750357388883;2688.220416079354;4664.55686709762;4690.390249267573;4690.390249267642;4691.296305554126;4693.296005599187;4971.776270067856;5136.743162841843;5161;5174.844754657366;5176.058977883294;4577.244754615518;4594;4595.195840727926;4603.746793926366;4627.838025669085;4968.677035992649;4973.6269779765935;5067.898642027212;5080.415752188545;5096.362954630671;4737.763111844325;4972.726500042532;4974.154393752999;4980.5805345476365;4993.500649934977;4596.333531637827;4679.3448917150945;4703.3885594872445;4721.811127554859;4728.38530990969;3865.265599536079;3885.86399476017;3886.6113388660906;3908.257431088084;3912.9848128213425;5099.827039780946;5107.463716309734;5108.616853736059;5109.540141387293;5119.283300337881;4768.833090841804;4879.707217566957;4901.848065704486;4913.1186362773005;4929.595065406342;4860.659753817199;4871.537203965618;4873.878153046202;4882.829100981448;4918.376935611168;4798.95201047985;4803.303520989367;4814.759262036814;4817.9036419272115;4824.614030877451;4627.467841198305;4759.50025247344;4854.126257273725;4870.829520966749;4881.73150476713;4880.951190488192;4886.047220791911;4897.681650692693;4902.656814022984;4919.532644398776 19:25:28 INFO - PROCESS | 17696 | |5;yui.html;600.5975996082624;616.2358675242699;632.3897438971392;731.0788406607679;734.3354264390729;12341.938290308548;13082.215067095982;13554.254516001616;13662.453501859914;13844.100133491316;12352.197107188027;12734.68163295918;12772.42524086416;12939.158954667964;12955.611331660042;767.4129291092332;785.1951749456796;785.7092875636023;786.2726977545776;786.6342150899831;629.8866204083263;650.229478068488;775.6974779835869;793.9007624046994;796.4623878881761;827.3009307135461;835.1648351648352;836.6486075848128;836.9121242269565;837.3552364679193;825.7564018614523;826.0912995704737;826.1696994520529;826.8801023851568;827.1067247372853;432.1831738015154;438.2265301742427;438.5417238985268;439.2466919233498;589.6255877517764;12917.67705807353;13628.182309061489;13635.931820340835;13637.454501819915;13658.248796316198;12167.41434951589;12187.817182742177;12686;12891.806622900664;13076.738465230737;11924.219354516585;12008.279503229835;12026.639200823989;12076.71026406337;12200.450979705935;3997.980010099931;4002.779847108408;4027.7583344999102;4102.097538541516;4191.203671302474;66880;67084.6645766768;67509.66245168743;68914;70581.2941870585;9952.253580981456;10029.398236105857;10097.495125243708;10115.190784737204;10329;17016.48950531486;17814;19255.037248137538;19420.126094325507;19565;6669.483731450813;6868.072810170663;7003.824904377431;7087.610181439967;7167.354938055496;3630.6006339302658;3739.6821270191795;3800.7149463790324;3842.5773164951834;3873.922521549553;2838.4465029319085;2905.418916216765;2924.3712601790717;2929.326254961371;2945.572891930658;484.59536287199876;504.4627471742656;505.71427143663715;508.42547920849205;518.8158203837659;546.2189069630388;611.4771870051131;621.810347843903;626.1077963901513;632.5034847644577;7827.452078354574;8345.332373410112;8487;8546.658133674708;8649.481031138026;497.56214531213027;565.3498476751686;565.5221337969409;582.3710392775791;616.374380004296;3817.141143242748;4059.512858457004;4099.651529620016;4274.551172126882;4458.621017213508;50611;66538.33461665321;66550.33449665539;67973.66013169903;68234.31765682378;46250.5374946253;50722.49277507252;53349.73325133349;57711.71144144252;60858.69570652118;53950.460495394545;53974.73012634912;54640.18039729407;55412.44587554153;55452.722736386866;8962.238209752244;9236.907630923604;9330.766730831783;9354.111359420844;9431.858522122036;36720.26559468849;36969.44545831868;37362.25275494529;37622.8118859404;37815.62184378231;45208;46666.533334667576;48040;50279.74860125676;50280.74859625679;11065.778684426428;11302.43487825589;11389.259698119597;11400.600978965696;11908.702282443008;12572.308523030955;12809;13023.934880325538;13436.798448023092;13539.11995720275;11639.185257031926;12217.266963982189;12391.318477483825;12526.185797923106;12908.16096953695;11998.40007999614;12038.398080096134;12454.564090256797;12598.874011260137;13089.803652945024;11479.942600286946;11746.29522228669;12318.952889004535;12685.492580296685;12695.238285702888;9375.812483750151;9380.155785979294;9603.711888643353;10129.341592796445;10364.533595988049;9614.519274036411;10071.546780394754;10121.797564048826;10166.644167454104;10169.288149829441 19:25:28 INFO - PROCESS | 17696 | __end_tp_report 19:25:28 INFO - PROCESS | 17696 | __start_cc_report 19:25:28 INFO - PROCESS | 17696 | _x_x_mozilla_cycle_collect,2192 19:25:28 INFO - PROCESS | 17696 | __end_cc_report 19:25:28 INFO - PROCESS | 17696 | __startTimestamp1482290728382__endTimestamp 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | ------- Summary: start ------- 19:25:28 INFO - PROCESS | 17696 | Number of tests: 6 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | [#0] dojo.html Cycles:165 Average:4688.24 Median:4802.69 stddev:487.60 (10.2%) stddev-sans-first:460.91 19:25:28 INFO - PROCESS | 17696 | Values: 2605.8 2644.5 2662.9 2673.9 2683.5 4633.1 4660.9 4754.1 4828.0 4850.4 4713.7 4776.0 4801.3 4835.4 4881.5 4341.7 4353.7 4397.9 4415.2 4416.6 4000.5 4424.6 4439.6 4478.4 4518.4 4224.7 4427.1 4429.0 4441.6 4528.8 4262.7 4311.0 4336.5 4370.7 4390.1 4359.1 4363.1 4374.2 4395.8 4426.8 4770.4 4775.7 4796.2 4801.4 4802.7 4873.9 4875.5 4888.9 5029.4 5098.9 5096.1 5097.3 5106.1 5127.1 5152.0 4766.4 4767.7 4770.5 4771.4 4807.1 5075.1 5119.2 5203.2 5205.9 5256.7 4962.7 4992.9 5019.4 5041.0 5099.6 5127.5 5128.9 5131.1 5132.0 5132.4 5036.2 5089.1 5089.2 5092.2 5122.4 4914.0 4961.7 4964.1 5002.5 5004.8 4299.8 4302.6 4319.6 4327.8 4374.5 3771.2 3776.2 3782.8 3816.1 3820.6 4240.7 4328.5 4329.2 4331.4 4374.4 4998.3 5079.2 5124.2 5130.4 5204.9 4375.3 4376.0 4382.1 4385.0 4422.0 4576.0 4617.0 4624.0 4634.7 4658.7 4615.4 4658.9 4663.7 4708.6 4709.6 5139.4 5141.6 5142.8 5172.7 5201.0 4746.2 4759.6 4763.6 4763.8 4808.6 4862.2 4908.6 4912.5 5019.8 5117.9 5030.6 5040.9 5042.3 5042.9 5043.5 4898.0 4902.4 4905.8 4908.5 4911.2 4857.5 4908.0 4909.2 4910.9 4910.9 4819.6 4833.0 4838.5 4867.9 4903.1 4992.2 5006.9 5017.9 5049.7 5064.9 4703.6 4739.8 4788.0 4796.5 4804.5 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | [#1] ext.html Cycles:180 Average:43359.75 Median:185118.16 stddev:77750.15 (42.0%) stddev-sans-first:77901.72 19:25:28 INFO - PROCESS | 17696 | Values: 517.6 548.2 551.3 552.9 586.0 33760.3 37764.6 37772.0 37801.8 37908.0 37965.8 38393.2 38444.6 38501.6 38533.0 7251.6 7308.5 7442.6 7535.5 9905.3 9692.6 9762.9 9788.5 9802.1 9816.5 9832.0 9874.2 9918.2 9919.0 9923.0 9792.2 9838.0 9841.7 9842.4 9863.3 9774.0 9837.3 9849.0 9850.1 9850.4 37514.4 37855.1 37855.8 37945.6 37949.0 2910.3 2983.3 2991.0 3088.6 3303.8 27456.0 28023.3 28154.7 28865.6 29339.4 3359.1 3417.2 3462.6 3517.1 3517.1 249318.0 249943.0 250093.0 250240.0 251386.0 49572.3 50117.7 50120.0 50129.0 50163.2 51675.0 51803.5 51850.0 51885.7 51915.5 13550.1 13863.6 13902.0 13914.3 13925.9 9405.2 9834.1 10656.6 10892.9 10974.9 14332.9 14381.4 14390.6 14689.6 14756.2 5798.2 5868.4 5868.8 5904.4 5939.7 762.3 935.6 970.7 971.6 1011.6 26448.3 26511.3 26951.5 27019.0 27296.9 967.6 974.3 994.9 998.8 1019.8 13807.2 14049.6 14119.6 14274.8 14275.6 334709.0 336476.0 337655.0 337700.0 338500.0 47340.3 47401.5 47462.0 47515.6 47631.0 1051.8 1081.4 1115.6 1154.1 1160.3 26080.5 27284.0 28227.3 28647.0 28675.3 39148.4 39826.2 39859.4 39889.2 39941.8 219038.0 219878.0 220737.0 220947.0 482262.0 22562.3 22702.9 22944.0 22962.2 22985.5 30203.0 30707.7 32907.3 33345.2 35527.5 30198.7 31113.4 31248.4 31475.2 32021.5 30468.0 30893.0 31119.2 31400.7 32382.2 30643.5 30738.5 31265.4 31361.5 31488.8 26719.5 28191.7 28963.9 28973.9 29392.3 22261.3 22432.5 22636.0 22728.3 22751.8 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | [#2] jquery.html Cycles:180 Average:22396.19 Median:4900.94 stddev:56506.63 (1153.0%) stddev-sans-first:56640.91 19:25:28 INFO - PROCESS | 17696 | Values: 350.8 373.4 377.0 381.1 401.0 12353.6 12834.8 16155.6 16177.7 16187.0 14034.6 14230.3 14244.3 14250.1 14285.3 3663.1 4731.1 4896.2 4896.8 4905.1 3801.4 5689.2 5908.7 5932.0 6047.8 5751.5 5868.1 5982.9 5993.2 5994.9 5920.0 5956.5 5962.7 5965.0 5969.4 5033.1 5170.5 5217.6 5259.2 5264.3 19658.3 19714.0 19716.6 19857.3 19927.0 2026.8 2133.4 2419.9 2505.0 2510.4 11783.9 12926.6 13067.2 13248.0 13429.3 1704.4 1738.7 1753.5 1764.4 1781.7 64797.9 64911.7 65216.7 65623.7 65801.7 9189.1 9203.8 9280.9 9467.6 9736.0 12957.4 12960.8 12977.0 12986.4 12992.7 6882.4 6969.8 7044.3 7064.3 7217.2 6624.4 6628.7 6725.0 6836.8 6906.0 5885.2 5887.5 5992.2 6013.6 6153.9 1625.4 1748.4 1761.6 1783.7 1792.9 751.6 807.8 845.4 866.9 869.3 16465.0 16595.0 16636.8 16828.5 17559.4 825.6 827.9 839.8 844.7 863.4 7658.1 9781.1 9789.0 9789.7 9821.5 236110.0 353858.0 364447.0 366135.0 367066.0 56007.2 66586.7 66894.3 77539.2 80292.0 898.8 936.0 949.9 951.9 966.1 14368.9 14818.6 15490.5 15628.7 15810.9 33688.3 36612.5 37124.8 37659.8 38575.2 48364.5 50507.0 50897.2 51521.5 52087.0 5020.0 5856.3 6743.6 6832.2 7654.7 10911.2 11015.4 11383.3 11406.9 11542.5 9720.7 10377.7 10380.1 10512.7 10547.0 9854.7 9986.5 10113.9 10119.8 10212.8 9785.3 10113.1 10170.3 10649.1 10828.7 6482.2 7254.4 7373.1 7391.9 7729.5 8469.0 10049.1 10158.2 10372.7 10505.7 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | [#3] mootools.html Cycles:180 Average:4928.44 Median:6119.00 stddev:2667.08 (43.6%) stddev-sans-first:2660.93 19:25:28 INFO - PROCESS | 17696 | Values: 1340.4 1358.5 1449.3 1637.2 1686.2 7042.3 7455.3 7458.6 7459.7 7464.0 6554.6 6840.3 7138.8 7367.9 7377.6 2114.3 2151.7 2153.7 2156.4 2156.7 2126.6 2160.6 2180.8 2182.5 2183.7 1836.9 1900.4 2060.5 2132.2 2132.7 2127.3 2128.4 2147.2 2150.3 2150.8 2145.6 2159.7 2180.1 2183.2 2183.2 7454.9 7484.5 7489.0 7523.9 7538.2 4432.6 4579.1 4580.4 4586.1 4595.3 2904.0 3002.0 3042.4 3047.0 3062.3 871.4 910.6 935.2 942.9 951.5 9908.6 9947.3 9964.9 9973.6 9987.0 3935.3 4192.2 4267.0 4275.6 4320.9 8672.5 8676.9 8678.7 8681.8 8690.8 4525.3 4623.0 4627.0 4630.1 4644.1 4038.9 4134.7 4166.9 4174.6 4183.5 3462.6 3508.5 3590.8 3598.5 3606.2 1155.9 1164.4 1171.1 1186.8 1187.4 660.8 710.0 837.5 849.5 851.5 4883.5 4973.2 4994.4 5069.7 5116.1 819.6 835.4 859.0 861.2 864.5 3283.4 3318.6 3322.7 3351.8 3371.3 8523.5 9040.0 9051.5 9073.1 9090.7 8536.5 9000.3 9020.2 9023.0 9025.0 6953.2 7120.8 7138.8 7140.9 7145.2 4932.6 5064.5 5103.4 5158.6 5275.2 7919.5 8091.2 8242.5 8362.7 8462.2 7970.2 8163.0 8202.7 8383.5 8408.8 6447.8 6553.8 6609.1 6612.4 6649.8 7061.6 7196.5 7202.7 7202.9 7205.2 6333.9 6469.2 6526.3 6670.4 6699.3 6470.1 6506.8 6512.1 6520.8 6525.1 6063.3 6174.7 6178.8 6180.4 6183.1 4475.9 4537.8 4582.4 4587.7 4610.3 4434.2 4471.9 4590.4 4602.8 4709.5 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | [#4] prototype.html Cycles:180 Average:4164.20 Median:4690.84 stddev:1150.01 (24.5%) stddev-sans-first:1117.17 19:25:28 INFO - PROCESS | 17696 | Values: 357.5 360.6 365.0 365.1 369.7 4846.2 4856.8 4868.8 4880.4 4890.3 4784.7 4804.5 4812.8 4814.7 4815.2 3609.9 3682.8 3782.2 3799.7 3832.2 3830.0 3843.3 3844.2 3856.8 3867.4 3815.9 3825.7 3827.0 3833.3 3835.5 3641.7 3745.9 3748.3 3811.7 3813.0 3473.8 3479.4 3481.0 3481.4 3483.7 4700.7 4709.8 4723.5 4725.8 4742.4 4310.3 4372.8 4402.9 4443.7 4444.4 4964.5 4973.9 4974.2 4977.2 5008.6 3752.9 3775.7 3804.2 3806.2 3812.5 5015.8 5175.4 5207.5 5213.4 5242.8 3871.0 3876.2 3885.4 3898.4 3913.3 3913.0 3958.6 3965.8 3966.1 3983.6 4363.4 4372.8 4389.0 4402.9 4405.0 4875.3 4914.9 4918.2 4931.5 4971.4 1324.9 1345.2 1346.7 1351.2 1353.7 907.6 945.2 970.5 982.2 983.2 4076.6 4265.8 4357.2 4377.2 4386.3 5115.0 5118.2 5135.7 5136.6 5147.5 4289.0 4327.3 4342.1 4350.3 4365.5 2464.5 2631.9 2646.8 2661.2 2688.2 4664.6 4690.4 4690.4 4691.3 4693.3 4971.8 5136.7 5161.0 5174.8 5176.1 4577.2 4594.0 4595.2 4603.7 4627.8 4968.7 4973.6 5067.9 5080.4 5096.4 4737.8 4972.7 4974.2 4980.6 4993.5 4596.3 4679.3 4703.4 4721.8 4728.4 3865.3 3885.9 3886.6 3908.3 3913.0 5099.8 5107.5 5108.6 5109.5 5119.3 4768.8 4879.7 4901.8 4913.1 4929.6 4860.7 4871.5 4873.9 4882.8 4918.4 4799.0 4803.3 4814.8 4817.9 4824.6 4627.5 4759.5 4854.1 4870.8 4881.7 4881.0 4886.0 4897.7 4902.7 4919.5 19:25:28 INFO - PROCESS | 17696 | 19:25:28 INFO - PROCESS | 17696 | [#5] yui.html Cycles:180 Average:15157.16 Median:438.38 stddev:18784.88 (4285.0%) stddev-sans-first:18805.77 19:25:28 INFO - PROCESS | 17696 | Values: 600.6 616.2 632.4 731.1 734.3 12341.9 13082.2 13554.3 13662.5 13844.1 12352.2 12734.7 12772.4 12939.2 12955.6 767.4 785.2 785.7 786.3 786.6 629.9 650.2 775.7 793.9 796.5 827.3 835.2 836.6 836.9 837.4 825.8 826.1 826.2 826.9 827.1 432.2 438.2 438.5 439.2 589.6 12917.7 13628.2 13635.9 13637.5 13658.2 12167.4 12187.8 12686.0 12891.8 13076.7 11924.2 12008.3 12026.6 12076.7 12200.5 3998.0 4002.8 4027.8 4102.1 4191.2 66880.0 67084.7 67509.7 68914.0 70581.3 9952.3 10029.4 10097.5 10115.2 10329.0 17016.5 17814.0 19255.0 19420.1 19565.0 6669.5 6868.1 7003.8 7087.6 7167.4 3630.6 3739.7 3800.7 3842.6 3873.9 2838.4 2905.4 2924.4 2929.3 2945.6 484.6 504.5 505.7 508.4 518.8 546.2 611.5 621.8 626.1 632.5 7827.5 8345.3 8487.0 8546.7 8649.5 497.6 565.3 565.5 582.4 616.4 3817.1 4059.5 4099.7 4274.6 4458.6 50611.0 66538.3 66550.3 67973.7 68234.3 46250.5 50722.5 53349.7 57711.7 60858.7 53950.5 53974.7 54640.2 55412.4 55452.7 8962.2 9236.9 9330.8 9354.1 9431.9 36720.3 36969.4 37362.3 37622.8 37815.6 45208.0 46666.5 48040.0 50279.7 50280.7 11065.8 11302.4 11389.3 11400.6 11908.7 12572.3 12809.0 13023.9 13436.8 13539.1 11639.2 12217.3 12391.3 12526.2 12908.2 11998.4 12038.4 12454.6 12598.9 13089.8 11479.9 11746.3 12319.0 12685.5 12695.2 9375.8 9380.2 9603.7 10129.3 10364.5 9614.5 10071.5 10121.8 10166.6 10169.3 19:25:28 INFO - PROCESS | 17696 | -------- Summary: end -------- 19:25:28 INFO - PROCESS | 17696 | 19:25:29 INFO - TEST-INFO | 17696: exit 0 19:25:29 INFO - TEST-OK | dromaeo_css | took 1122364ms 19:25:29 INFO - TEST-START | kraken 19:25:29 INFO - operating with platform_type : linux_ 19:25:29 INFO - Initialising browser for kraken test... 19:25:29 INFO - TEST-INFO | started process 18003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgHDrUH/profile http://localhost:40452/getInfo.html) 19:25:33 INFO - PROCESS | 18003 | __metrics Screen width/height:1600/1200 19:25:33 INFO - PROCESS | 18003 | colorDepth:24 19:25:33 INFO - PROCESS | 18003 | Browser inner width/height: 1024/697 19:25:33 INFO - PROCESS | 18003 | __metrics 19:25:33 INFO - PROCESS | 18003 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:25:33 INFO - PROCESS | 18003 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:35 INFO - TEST-INFO | 18003: exit 0 19:25:35 INFO - Browser initialized. 19:25:35 INFO - Running cycle 1/1 for kraken test... 19:25:35 INFO - TEST-INFO | started process 18085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgHDrUH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:47 INFO - PROCESS | 18085 | RSS: Main: 156024832 19:25:47 INFO - PROCESS | 18085 | 19:25:49 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40452/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:50 INFO - PROCESS | 18085 | RSS: Main: 209592320 19:25:50 INFO - PROCESS | 18085 | 19:25:53 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40452/tests/kraken/driver.html?testName=audio-dft) 19:25:54 INFO - PROCESS | 18085 | RSS: Main: 188698624 19:25:54 INFO - PROCESS | 18085 | 19:25:57 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40452/tests/kraken/driver.html?testName=audio-fft) 19:25:57 INFO - PROCESS | 18085 | RSS: Main: 269791232 19:25:57 INFO - PROCESS | 18085 | 19:25:59 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40452/tests/kraken/driver.html?testName=audio-oscillator) 19:26:00 INFO - PROCESS | 18085 | RSS: Main: 181141504 19:26:00 INFO - PROCESS | 18085 | 19:26:02 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:03 INFO - PROCESS | 18085 | RSS: Main: 184631296 19:26:03 INFO - PROCESS | 18085 | 19:26:06 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40452/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:07 INFO - PROCESS | 18085 | RSS: Main: 223645696 19:26:07 INFO - PROCESS | 18085 | 19:26:10 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40452/tests/kraken/driver.html?testName=imaging-desaturate) 19:26:11 INFO - PROCESS | 18085 | RSS: Main: 218157056 19:26:11 INFO - PROCESS | 18085 | 19:26:14 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40452/tests/kraken/driver.html?testName=json-parse-financial) 19:26:14 INFO - PROCESS | 18085 | RSS: Main: 220266496 19:26:14 INFO - PROCESS | 18085 | 19:26:16 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:26:17 INFO - PROCESS | 18085 | RSS: Main: 183578624 19:26:17 INFO - PROCESS | 18085 | 19:26:19 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:26:19 INFO - PROCESS | 18085 | RSS: Main: 190111744 19:26:19 INFO - PROCESS | 18085 | 19:26:21 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:26:22 INFO - PROCESS | 18085 | RSS: Main: 198463488 19:26:22 INFO - PROCESS | 18085 | 19:26:25 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:26:26 INFO - PROCESS | 18085 | RSS: Main: 208826368 19:26:26 INFO - PROCESS | 18085 | 19:26:29 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:26:29 INFO - PROCESS | 18085 | RSS: Main: 205455360 19:26:29 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | Cycle 1(1): loaded http://localhost:40452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40452/tests/kraken/driver.html?testName=ai-astar) 19:26:31 INFO - PROCESS | 18085 | RSS: Main: 255479808 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | __start_tp_report 19:26:31 INFO - PROCESS | 18085 | _x_x_mozilla_page_load 19:26:31 INFO - PROCESS | 18085 | _x_x_mozilla_page_load_details 19:26:31 INFO - PROCESS | 18085 | |i|pagename|runs| 19:26:31 INFO - PROCESS | 18085 | |0;ai-astar;108;114;113;114;114;115;116;114;115;113 19:26:31 INFO - PROCESS | 18085 | |1;audio-beat-detection;150;126;125;163;129;127;124;126;146;127 19:26:31 INFO - PROCESS | 18085 | |2;audio-dft;161;161;161;161;163;162;164;162;162;163 19:26:31 INFO - PROCESS | 18085 | |3;audio-fft;77;77;76;108;76;75;76;75;90;77 19:26:31 INFO - PROCESS | 18085 | |4;audio-oscillator;86;85;106;84;85;85;106;85;85;107 19:26:31 INFO - PROCESS | 18085 | |5;imaging-gaussian-blur;128;127;128;127;127;129;128;128;127;128 19:26:31 INFO - PROCESS | 18085 | |6;imaging-darkroom;147;147;146;147;147;147;148;148;146;147 19:26:31 INFO - PROCESS | 18085 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 19:26:31 INFO - PROCESS | 18085 | |8;json-parse-financial;66;72;65;65;65;65;66;66;66;65 19:26:31 INFO - PROCESS | 18085 | |9;json-stringify-tinderbox;66;67;67;67;66;66;67;65;65;66 19:26:31 INFO - PROCESS | 18085 | |10;stanford-crypto-aes;84;86;88;88;89;85;84;83;84;83 19:26:31 INFO - PROCESS | 18085 | |11;stanford-crypto-ccm;136;144;143;132;135;135;136;133;178;138 19:26:31 INFO - PROCESS | 18085 | |12;stanford-crypto-pbkdf2;183;181;178;182;183;179;181;179;179;179 19:26:31 INFO - PROCESS | 18085 | |13;stanford-crypto-sha256-iterative;74;68;68;68;74;68;67;68;68;68 19:26:31 INFO - PROCESS | 18085 | __end_tp_report 19:26:31 INFO - PROCESS | 18085 | __start_cc_report 19:26:31 INFO - PROCESS | 18085 | _x_x_mozilla_cycle_collect,1990 19:26:31 INFO - PROCESS | 18085 | __end_cc_report 19:26:31 INFO - PROCESS | 18085 | __startTimestamp1482290791838__endTimestamp 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | ------- Summary: start ------- 19:26:31 INFO - PROCESS | 18085 | Number of tests: 14 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.17 (1.9%) stddev-sans-first:0.97 19:26:31 INFO - PROCESS | 18085 | Values: 108.0 114.0 113.0 114.0 114.0 115.0 116.0 114.0 115.0 113.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:128.00 stddev:13.63 (10.6%) stddev-sans-first:13.22 19:26:31 INFO - PROCESS | 18085 | Values: 150.0 126.0 125.0 163.0 129.0 127.0 124.0 126.0 146.0 127.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 19:26:31 INFO - PROCESS | 18085 | Values: 161.0 161.0 161.0 161.0 163.0 162.0 164.0 162.0 162.0 163.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.50 stddev:10.56 (13.8%) stddev-sans-first:11.12 19:26:31 INFO - PROCESS | 18085 | Values: 77.0 77.0 76.0 108.0 76.0 75.0 76.0 75.0 90.0 77.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:85.00 stddev:10.32 (12.1%) stddev-sans-first:10.76 19:26:31 INFO - PROCESS | 18085 | Values: 86.0 85.0 106.0 84.0 85.0 85.0 106.0 85.0 85.0 107.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#5] imaging-gaussian-blur Cycles:10 Average:127.70 Median:128.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:26:31 INFO - PROCESS | 18085 | Values: 128.0 127.0 128.0 127.0 127.0 129.0 128.0 128.0 127.0 128.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:26:31 INFO - PROCESS | 18085 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 148.0 148.0 146.0 147.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:26:31 INFO - PROCESS | 18085 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:2.13 (3.2%) stddev-sans-first:2.26 19:26:31 INFO - PROCESS | 18085 | Values: 66.0 72.0 65.0 65.0 65.0 65.0 66.0 66.0 66.0 65.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 19:26:31 INFO - PROCESS | 18085 | Values: 66.0 67.0 67.0 67.0 66.0 66.0 67.0 65.0 65.0 66.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.22 (2.6%) stddev-sans-first:2.30 19:26:31 INFO - PROCESS | 18085 | Values: 84.0 86.0 88.0 88.0 89.0 85.0 84.0 83.0 84.0 83.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:137.00 stddev:13.57 (9.9%) stddev-sans-first:14.28 19:26:31 INFO - PROCESS | 18085 | Values: 136.0 144.0 143.0 132.0 135.0 135.0 136.0 133.0 178.0 138.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:181.00 stddev:1.84 (1.0%) stddev-sans-first:1.69 19:26:31 INFO - PROCESS | 18085 | Values: 183.0 181.0 178.0 182.0 183.0 179.0 181.0 179.0 179.0 179.0 19:26:31 INFO - PROCESS | 18085 | 19:26:31 INFO - PROCESS | 18085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.00 stddev:2.60 (3.8%) stddev-sans-first:2.07 19:26:31 INFO - PROCESS | 18085 | Values: 74.0 68.0 68.0 68.0 74.0 68.0 67.0 68.0 68.0 68.0 19:26:31 INFO - PROCESS | 18085 | -------- Summary: end -------- 19:26:31 INFO - PROCESS | 18085 | 19:26:33 INFO - TEST-INFO | 18085: exit 0 19:26:33 INFO - TEST-OK | kraken | took 63800ms 19:26:33 INFO - SUITE-END | took 1186s 19:26:33 INFO - Completed test suite (00:19:46) 19:26:33 INFO - javascript benchmark 19:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.8175927685065, 2644.4578861333403, 2662.8668566571673, 2673.8663066846666, 2683.476722039202, 4633.119707255628, 4660.883477913054, 4754.120487709772, 4827.951720482794, 4850.442199147099, 4713.740744259073, 4776.020915712279, 4801.327814106028, 4835.41974963004, 4881.536254055859, 4341.696081274312, 4353.651707863379, 4397.890052748675, 4415.161119387322, 4416.645391881534, 4000.4999375078114, 4424.646028317727, 4439.5560443955665, 4478.373027776114, 4518.367428560005, 4224.683148763855, 4427.114577084596, 4428.955710442902, 4441.644668426518, 4528.841490547831, 4262.722923010026, 4310.956890431087, 4336.501302350239, 4370.650347972155, 4390.143921935224, 4359.12817436514, 4363.127374525107, 4374.234508960951, 4395.758233297167, 4426.84506042287, 4770.403699537558, 4775.689580177277, 4796.160671882407, 4801.399825021872, 4802.687825291345, 4873.926891096637, 4875.512448755132, 4888.902221955541, 5029.446760856303, 5098.872528186825, 5096.082705113078, 5097.337346145015, 5106.055379754757, 5127.128388173982, 5151.974240128813, 4766.356541866873, 4767.690100143514, 4770.499097594772, 4771.355866957986, 4807.134715751128, 5075.137226671474, 5119.180931051014, 5203.167493201146, 5205.895882082413, 5256.684598924076, 4962.652614316963, 4992.8751781205765, 5019.372578427697, 5041.0422019816115, 5099.59203263738, 5127.512886275797, 5128.871778205575, 5131.050755610224, 5131.97434012835, 5132.358455193101, 5036.219385995177, 5089.109405853961, 5089.211172268304, 5092.2361645753435, 5122.410922743932, 4913.950860491421, 4961.677490963076, 4964.131277026506, 5002.52476014778, 5004.774785134678, 4299.78501074945, 4302.591253830881, 4319.611234988866, 4327.7619730914475, 4374.4531933508315, 3771.2080463102507, 3776.188119554309, 3782.829772660237, 3816.0841398064263, 3820.6370394812448, 4240.703150779477, 4328.5455027222315, 4329.242382583036, 4331.350297455407, 4374.431323927869, 4998.325226094504, 5079.212722028092, 5124.205748109049, 5130.358705161855, 5204.8959020819375, 4375.27807911691, 4376.0, 4382.101669157815, 4385.0, 4422.027154026109, 4576.039031803359, 4617.0, 4624.0, 4634.652401069866, 4658.650601204923, 4615.376924115336, 4658.928446457266, 4663.720176789404, 4708.552687494683, 4709.576138147446, 5139.408967968731, 5141.640085194001, 5142.820001300086, 5172.663776854492, 5201.0, 4746.2168742157155, 4759.571638552547, 4763.571278584944, 4763.785629646605, 4808.567228949411, 4862.246351815475, 4908.631852610997, 4912.48418916023, 5019.824306149268, 5117.923231151462, 5030.62270329734, 5040.8991820162655, 5042.294078828893, 5042.949570504395, 5043.5460808527405, 4898.0, 4902.362692849907, 4905.7792399342825, 4908.509149085063, 4911.238757992517, 4857.489963553918, 4908.0, 4909.214525675875, 4910.852674419773, 4910.852674419773, 4819.638527110411, 4833.0, 4838.491958344323, 4867.90264194707, 4903.092927808367, 4992.176290912104, 5006.949930500648, 5017.9498205018945, 5049.697018178921, 5064.924026139684, 4703.576678098988, 4739.834105806281, 4787.976060119677, 4796.5203479653155, 4804.495527969652], "value": 4657.4543847786435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.6066189695831, 548.202365558113, 551.2502995925543, 552.930883639545, 585.9677717725529, 33760.324793504114, 37764.62235377645, 37772.0, 37801.81099094507, 37908.0, 37965.81017094911, 38393.23213535728, 38444.61555384445, 38501.61498385015, 38533.03667408316, 7251.6374181290985, 7308.524945878501, 7442.590657513834, 7535.54786712799, 9905.306628536006, 9692.612295508172, 9762.902370976306, 9788.461634610094, 9802.068803463659, 9816.50917454128, 9832.0, 9874.16069634082, 9918.156956658657, 9919.0, 9923.0, 9792.16766574842, 9837.950810245939, 9841.655542056065, 9842.360246584021, 9863.30956833022, 9773.951130244375, 9837.311388202828, 9849.0, 9850.06424389689, 9850.359726617819, 37514.43728344077, 37855.053623659354, 37855.81072094622, 37945.62054379449, 37949.0, 2910.301527633374, 2983.34366439383, 2991.0428662827903, 3088.6139232595924, 3303.7687361884678, 27456.0, 28023.299417514725, 28154.718452815618, 28865.56701649477, 29339.41321173586, 3359.076254030161, 3417.1627951152127, 3462.567179102612, 3517.0855577549764, 3517.120719820045, 249318.0, 249943.0, 250093.0, 250239.99999999817, 251386.0, 49572.25641615379, 50117.74941125344, 50120.0, 50129.0, 50163.24755128676, 51675.0, 51803.48849416814, 51850.0, 51885.740571296905, 51915.48084519182, 13550.119242249222, 13863.584092477242, 13902.026858120036, 13914.30428478572, 13925.860741392456, 9405.247580193569, 9834.114929656222, 10656.62701805433, 10892.945535272273, 10974.890251097388, 14332.928335358465, 14381.352839122264, 14390.568282951528, 14689.632759180893, 14756.188409637572, 5798.217240672539, 5868.383819698955, 5868.79689663618, 5904.380040095814, 5939.673317967553, 762.3139174742665, 935.6304259817334, 970.7281961050776, 971.5870754929268, 1011.585250047477, 26448.33879152998, 26511.33721656974, 26951.460970780474, 27019.0, 27296.863515682693, 967.617790972576, 974.2595627323285, 994.8821915098886, 998.7602975285879, 1019.8215312320315, 13807.17156970585, 14049.648758780908, 14119.576412707635, 14274.785878211835, 14275.64310892236, 334709.0, 336476.0, 337655.0, 337700.0, 338500.0, 47340.28989565159, 47401.5259847404, 47462.0, 47515.57453276407, 47631.0, 1051.7896420715736, 1081.4430568257353, 1115.5816568786543, 1154.065207182185, 1160.3328086350214, 26080.478390432465, 27284.0, 28227.294317642223, 28647.0, 28675.28311792222, 39148.41277380899, 39826.203475930895, 39859.40210896897, 39889.2022159561, 39941.80029099836, 219038.0, 219878.0, 220737.0, 220947.0, 482262.0, 22562.32313030612, 22702.864856757427, 22944.0, 22962.177942632235, 22985.540289194458, 30203.0, 30707.692923070485, 32907.341853163285, 33345.16637083995, 35527.46708799319, 30198.69801302047, 31113.37773244568, 31248.375032499676, 31475.213119672193, 32021.519677205328, 30468.0, 30893.0, 31119.222019449695, 31400.68599314069, 32382.190445238117, 30643.54034689437, 30738.53892191574, 31265.374692506477, 31361.52957705682, 31488.842555787076, 26719.46561068729, 28191.71808281891, 28963.85518072396, 28973.855130724212, 29392.26519337034, 22261.332160035225, 22432.49457657261, 22635.98138083823, 22728.318150455514, 22751.772482275628], "value": 16839.89947487912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.8140685436716, 373.4249256145538, 377.0, 381.09870157078507, 400.96591789697874, 12353.567625133122, 12834.807477887827, 16155.596110097253, 16177.676446471063, 16187.028778273283, 14034.578962631138, 14230.288485575731, 14244.287785610704, 14250.073745206555, 14285.285735713198, 3663.084228942764, 4731.148393289215, 4896.216605343146, 4896.8041278349, 4905.068037072962, 3801.3727734923705, 5689.203511508392, 5908.734106965197, 5931.970340148293, 6047.818565443022, 5751.539876809845, 5868.149118377833, 5982.940170598304, 5993.160957465958, 5994.8801023979495, 5920.0, 5956.463918247378, 5962.731677074542, 5964.956132676764, 5969.403059694017, 5033.119204139298, 5170.500554839092, 5217.58259339252, 5259.15853463444, 5264.341957255343, 19658.311959081508, 19714.0, 19716.60566788656, 19857.304994325128, 19927.0, 2026.7567891853073, 2133.370655656585, 2419.8548087114827, 2504.9874750626313, 2510.3975045989014, 11783.865123600393, 12926.612201633967, 13067.215967042008, 13248.0, 13429.32853357338, 1704.420497031003, 1738.6609611125837, 1753.526547832091, 1764.4265613675607, 1781.7060185069447, 64797.872234054215, 64911.67544162296, 65216.673916630585, 65623.67188164077, 65801.67099164473, 9189.127032931861, 9203.815923681488, 9280.907190928005, 9467.573959171716, 9736.0, 12957.352132393342, 12960.805587916, 12977.0, 12986.415611297514, 12992.675183120498, 6882.4149947254045, 6969.82575435608, 7044.330788575077, 7064.293570642894, 7217.170025447036, 6624.403803657694, 6628.6582288600075, 6725.024871393621, 6836.794896153024, 6905.965470172617, 5885.234919460443, 5887.469257992952, 5992.161097446361, 6013.609115407485, 6153.907691384633, 1625.4392234679017, 1748.3531093495233, 1761.6388640328703, 1783.67893779121, 1792.9193186306386, 751.6392131776669, 807.8384323135397, 845.4377838737171, 866.9003064647646, 869.3393021303855, 16465.0, 16595.0, 16636.750448743278, 16828.495145145665, 17559.385421510186, 825.5500752090005, 827.9461834980707, 839.7606682095574, 844.7381311793364, 863.4301361101643, 7658.081030276402, 9781.119699227103, 9788.951055244821, 9789.657361992297, 9821.459819709984, 236110.0, 353858.0, 364447.0, 366135.0, 367066.0, 56007.159892601645, 66586.66706666532, 66894.33105668979, 77539.2246077532, 80292.0, 898.8382091223511, 935.9578818953163, 949.9382540134869, 951.9476428796482, 966.0580933589694, 14368.92233082502, 14818.555443336718, 15490.535283941499, 15628.68742625164, 15810.920945395199, 33688.326233474705, 36612.450813238356, 37124.81437592795, 37659.81170094242, 38575.22849543049, 48364.516354836, 50507.0, 50897.23654145265, 51521.48478515317, 52087.0, 5020.046191223656, 5856.326522449973, 6743.595384276763, 6832.248452670302, 7654.693812247448, 10911.181661375269, 11015.394153321644, 11383.260088094248, 11406.942965285121, 11542.480588373375, 9720.708378748648, 10377.740556486147, 10380.06579407857, 10512.684619461428, 10547.0, 9854.655087071918, 9986.450745209084, 10113.898861011296, 10119.79760404773, 10212.846807297748, 9785.31502794826, 10113.14038306752, 10170.288079834341, 10649.148068154684, 10828.729281768019, 6482.222133344029, 7254.383377412979, 7373.115226172894, 7391.852162956603, 7729.497582657109, 8469.0, 10049.14582260516, 10158.238132140266, 10372.688819335432, 10505.739311282696], "value": 8124.8185738149205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.3834236251325, 1358.476986360251, 1449.2826051104705, 1637.2386840119343, 1686.1737748503238, 7042.330978557035, 7455.254474552556, 7458.627068646573, 7459.701611935523, 7464.0, 6554.639494827783, 6840.315968403157, 7138.821529461753, 7367.8894816577795, 7377.631118444083, 2114.2600089968505, 2151.7310336207975, 2153.7307836520436, 2156.417767202854, 2156.7196264485597, 2126.627840127979, 2160.643493823517, 2180.8364372672036, 2182.5267944137645, 2183.737951445829, 1836.889786612801, 1900.4013735673218, 2060.4539796953745, 2132.2217390652454, 2132.744070711517, 2127.308624696972, 2128.3934078787624, 2147.194801949269, 2150.290404166621, 2150.7956744109283, 2145.62451570976, 2159.66525188596, 2180.1170525937023, 2183.170395249811, 2183.2031308572414, 7454.85090298191, 7484.513506622052, 7488.9625551871895, 7523.887141692879, 7538.246175382473, 4432.578905004019, 4579.129965306581, 4580.38164847748, 4586.082783443325, 4595.287730401793, 2904.0416662501325, 3001.969980300191, 3042.4067306875168, 3047.0, 3062.2650563864736, 871.4248595926721, 910.576581889418, 935.209747763139, 942.8727121838601, 951.5432592355708, 9908.603655853758, 9947.303688741791, 9964.90035099647, 9973.551190196531, 9987.0, 3935.311320518898, 4192.224438478891, 4267.0, 4275.5724427557, 4320.870373888788, 8672.523011234316, 8676.869846952175, 8678.6528538859, 8681.826363472695, 8690.826183476294, 4525.298578720303, 4622.95377046232, 4626.953730462719, 4630.143423466602, 4644.071185762861, 4038.8788336349958, 4134.689898257643, 4166.854160104382, 4174.582541745862, 4183.456150700389, 3462.584489861182, 3508.52634894286, 3590.838412271454, 3598.5321908151773, 3606.2426890352795, 1155.8959693627614, 1164.3770582738364, 1171.1275100050516, 1186.827909953052, 1187.4300335838846, 660.8248814064277, 710.0344575545532, 837.535167981776, 849.5370023337296, 851.476342049635, 4883.4628190898975, 4973.204287314013, 4994.3507344045765, 5069.670471419346, 5116.130257856174, 819.5616692704266, 835.365122506887, 858.9699360522477, 861.1603686405705, 864.5072308784058, 3283.359744849779, 3318.601767787881, 3322.734181265493, 3351.8491667875005, 3371.275175837158, 8523.531205783742, 9039.954800225956, 9051.456912585267, 9073.092690731006, 9090.727278181665, 8536.530490823065, 9000.324975626854, 9020.188183063556, 9023.0, 9025.007249202583, 6953.235144134142, 7120.786376408716, 7138.785836424916, 7140.92859071413, 7145.214026457085, 4932.605391568738, 5064.468230835857, 5103.387593488805, 5158.587313015025, 5275.182346736262, 7919.485233459806, 8091.231333023354, 8242.505449673039, 8362.749117526484, 8462.153784621489, 7970.202979701983, 8163.0, 8202.671893124209, 8383.53890536002, 8408.789780255542, 6447.806565803034, 6553.80338589824, 6609.074729537965, 6612.437942774918, 6649.800505984828, 7061.611611361219, 7196.532225405332, 7202.71189152449, 7202.927970720226, 7205.171405288249, 6333.936660633519, 6469.159009328757, 6526.347365263436, 6670.366315200048, 6699.296573859675, 6470.126532917996, 6506.804795856132, 6512.08830763684, 6520.804375868732, 6525.053867189136, 6063.272407311151, 6174.722137503913, 6178.752849886134, 6180.443760061616, 6183.103449999815, 4475.865724028285, 4537.795799189111, 4582.358469814162, 4587.72473651582, 4610.2623580227, 4434.17967675981, 4471.932921006122, 4590.380298659638, 4602.79287432073, 4709.481956984798], "value": 4009.9639393371604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.4995006990213, 360.6375592529507, 364.96350364963496, 365.14009507609563, 369.7467234944062, 4846.151923413402, 4856.8343597536605, 4868.805247790088, 4880.4143502779625, 4890.339804126442, 4784.736839473828, 4804.471508134111, 4812.807487700487, 4814.66297359185, 4815.159056156866, 3609.9458508122398, 3682.815859207042, 3782.186829831586, 3799.67702745267, 3832.198866532739, 3829.955185627433, 3843.3466310727244, 3844.1735026969195, 3856.826442810066, 3867.400552914303, 3815.923681526368, 3825.713071519633, 3826.9808650956847, 3833.2558685798035, 3835.5013848199696, 3641.6540428659237, 3745.9438108428394, 3748.3065632857874, 3811.714121440903, 3812.9791210658395, 3473.8436770345397, 3479.373712731707, 3481.0, 3481.3559491494157, 3483.7213022958103, 4700.670953033289, 4709.788059537329, 4723.527647235283, 4725.810967561293, 4742.430908290993, 4310.288802347609, 4372.759498227596, 4402.933955990663, 4443.688941774077, 4444.422225110748, 4964.453910069889, 4973.856013116967, 4974.1543937530705, 4977.15388383972, 5008.572556821288, 3752.887413377603, 3775.716821238391, 3804.239152169577, 3806.1626442182674, 3812.542494900602, 5015.799368025275, 5175.404828444777, 5207.531322181022, 5213.374395072616, 5242.79028838846, 3871.0128917125953, 3876.186000939778, 3885.4366116913457, 3898.434726964574, 3913.3151698452657, 3912.9608703912595, 3958.5843486434087, 3965.8215380307956, 3966.147278335172, 3983.64147226751, 4363.432753742057, 4372.781360931941, 4388.978055109704, 4402.908618406232, 4404.977975110104, 4875.317455556225, 4914.869579996621, 4918.19662792205, 4931.5315045070665, 4971.37857767779, 1324.9466673994004, 1345.2264947655137, 1346.7239215960703, 1351.2297990145523, 1353.6886516101156, 907.6233363154217, 945.2479587949058, 970.5195928015678, 982.1602529837029, 983.1544871410581, 4076.571959944163, 4265.786710664454, 4357.211384713785, 4377.212101821703, 4386.298192289219, 5115.0, 5118.232265160182, 5135.6918584885025, 5136.5890728741615, 5147.50722290539, 4288.978555107205, 4327.285997810389, 4342.08816148606, 4350.32569951658, 4365.515724653633, 2464.496657039205, 2631.8552479613422, 2646.775024122933, 2661.1750357388883, 2688.220416079354, 4664.55686709762, 4690.390249267573, 4690.390249267642, 4691.296305554126, 4693.296005599187, 4971.776270067856, 5136.743162841843, 5161.0, 5174.844754657366, 5176.058977883294, 4577.244754615518, 4594.0, 4595.195840727926, 4603.746793926366, 4627.838025669085, 4968.677035992649, 4973.6269779765935, 5067.898642027212, 5080.415752188545, 5096.362954630671, 4737.763111844325, 4972.726500042532, 4974.154393752999, 4980.5805345476365, 4993.500649934977, 4596.333531637827, 4679.3448917150945, 4703.3885594872445, 4721.811127554859, 4728.38530990969, 3865.265599536079, 3885.86399476017, 3886.6113388660906, 3908.257431088084, 3912.9848128213425, 5099.827039780946, 5107.463716309734, 5108.616853736059, 5109.540141387293, 5119.283300337881, 4768.833090841804, 4879.707217566957, 4901.848065704486, 4913.1186362773005, 4929.595065406342, 4860.659753817199, 4871.537203965618, 4873.878153046202, 4882.829100981448, 4918.376935611168, 4798.95201047985, 4803.303520989367, 4814.759262036814, 4817.9036419272115, 4824.614030877451, 4627.467841198305, 4759.50025247344, 4854.126257273725, 4870.829520966749, 4881.73150476713, 4880.951190488192, 4886.047220791911, 4897.681650692693, 4902.656814022984, 4919.532644398776], "value": 3821.7639832865184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5975996082624, 616.2358675242699, 632.3897438971392, 731.0788406607679, 734.3354264390729, 12341.938290308548, 13082.215067095982, 13554.254516001616, 13662.453501859914, 13844.100133491316, 12352.197107188027, 12734.68163295918, 12772.42524086416, 12939.158954667964, 12955.611331660042, 767.4129291092332, 785.1951749456796, 785.7092875636023, 786.2726977545776, 786.6342150899831, 629.8866204083263, 650.229478068488, 775.6974779835869, 793.9007624046994, 796.4623878881761, 827.3009307135461, 835.1648351648352, 836.6486075848128, 836.9121242269565, 837.3552364679193, 825.7564018614523, 826.0912995704737, 826.1696994520529, 826.8801023851568, 827.1067247372853, 432.1831738015154, 438.2265301742427, 438.5417238985268, 439.2466919233498, 589.6255877517764, 12917.67705807353, 13628.182309061489, 13635.931820340835, 13637.454501819915, 13658.248796316198, 12167.41434951589, 12187.817182742177, 12686.0, 12891.806622900664, 13076.738465230737, 11924.219354516585, 12008.279503229835, 12026.639200823989, 12076.71026406337, 12200.450979705935, 3997.980010099931, 4002.779847108408, 4027.7583344999102, 4102.097538541516, 4191.203671302474, 66880.0, 67084.6645766768, 67509.66245168743, 68914.0, 70581.2941870585, 9952.253580981456, 10029.398236105857, 10097.495125243708, 10115.190784737204, 10329.0, 17016.48950531486, 17814.0, 19255.037248137538, 19420.126094325507, 19565.0, 6669.483731450813, 6868.072810170663, 7003.824904377431, 7087.610181439967, 7167.354938055496, 3630.6006339302658, 3739.6821270191795, 3800.7149463790324, 3842.5773164951834, 3873.922521549553, 2838.4465029319085, 2905.418916216765, 2924.3712601790717, 2929.326254961371, 2945.572891930658, 484.59536287199876, 504.4627471742656, 505.71427143663715, 508.42547920849205, 518.8158203837659, 546.2189069630388, 611.4771870051131, 621.810347843903, 626.1077963901513, 632.5034847644577, 7827.452078354574, 8345.332373410112, 8487.0, 8546.658133674708, 8649.481031138026, 497.56214531213027, 565.3498476751686, 565.5221337969409, 582.3710392775791, 616.374380004296, 3817.141143242748, 4059.512858457004, 4099.651529620016, 4274.551172126882, 4458.621017213508, 50611.0, 66538.33461665321, 66550.33449665539, 67973.66013169903, 68234.31765682378, 46250.5374946253, 50722.49277507252, 53349.73325133349, 57711.71144144252, 60858.69570652118, 53950.460495394545, 53974.73012634912, 54640.18039729407, 55412.44587554153, 55452.722736386866, 8962.238209752244, 9236.907630923604, 9330.766730831783, 9354.111359420844, 9431.858522122036, 36720.26559468849, 36969.44545831868, 37362.25275494529, 37622.8118859404, 37815.62184378231, 45208.0, 46666.533334667576, 48040.0, 50279.74860125676, 50280.74859625679, 11065.778684426428, 11302.43487825589, 11389.259698119597, 11400.600978965696, 11908.702282443008, 12572.308523030955, 12809.0, 13023.934880325538, 13436.798448023092, 13539.11995720275, 11639.185257031926, 12217.266963982189, 12391.318477483825, 12526.185797923106, 12908.16096953695, 11998.40007999614, 12038.398080096134, 12454.564090256797, 12598.874011260137, 13089.803652945024, 11479.942600286946, 11746.29522228669, 12318.952889004535, 12685.492580296685, 12695.238285702888, 9375.812483750151, 9380.155785979294, 9603.711888643353, 10129.341592796445, 10364.533595988049, 9614.519274036411, 10071.546780394754, 10121.797564048826, 10166.644167454104, 10169.288149829441], "value": 6367.582690392645, "unit": "score"}], "name": "dromaeo_css", "value": 6294.407994785033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 113.0, 114.0, 114.0, 115.0, 116.0, 114.0, 115.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 125.0, 163.0, 129.0, 127.0, 124.0, 126.0, 146.0, 127.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 163.0, 162.0, 164.0, 162.0, 162.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 108.0, 76.0, 75.0, 76.0, 75.0, 90.0, 77.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 106.0, 84.0, 85.0, 85.0, 106.0, 85.0, 85.0, 107.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 128.0, 127.0, 127.0, 129.0, 128.0, 128.0, 127.0, 128.0], "value": 127.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 65.0, 65.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 88.0, 88.0, 89.0, 85.0, 84.0, 83.0, 84.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 144.0, 143.0, 132.0, 135.0, 135.0, 136.0, 133.0, 178.0, 138.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 178.0, 182.0, 183.0, 179.0, 181.0, 179.0, 179.0, 179.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 68.0, 68.0, 74.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1560.0000000000002, "alertThreshold": 2.0}]} 19:26:33 INFO - Return code: 0 19:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:33 INFO - # TBPL SUCCESS # 19:26:33 INFO - Running post-action listener: _resource_record_post_action 19:26:33 INFO - [mozharness: 2016-12-21 03:26:33.658207Z] Finished run-tests step (success) 19:26:33 INFO - Running post-run listener: _resource_record_post_run 19:26:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 382271488; Read time: 12; Write time: 298936 19:26:33 INFO - TinderboxPrint: CPU usage
13.1% 19:26:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:26:33 INFO - TinderboxPrint: I/O write bytes / time
382,271,488 / 298,936 19:26:33 INFO - TinderboxPrint: CPU idle
8,339.1 (86.8%) 19:26:33 INFO - TinderboxPrint: CPU user
1,217.8 (12.7%) 19:26:33 INFO - TinderboxPrint: Swap in / out
0 / 0 19:26:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99684352; Read time: 0; Write time: 100128 19:26:33 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 282587136; Read time: 0; Write time: 198808 19:26:34 INFO - Running post-run listener: _upload_blobber_files 19:26:34 INFO - Blob upload gear active. 19:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:34 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:34 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:26:34 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:37 INFO - (blobuploader) - INFO - Done attempting. 19:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:38 INFO - (blobuploader) - INFO - Done attempting. 19:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:39 INFO - (blobuploader) - INFO - Done attempting. 19:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:40 INFO - (blobuploader) - INFO - Done attempting. 19:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:40 INFO - Return code: 0 19:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cffcf4e99bb84ea3a5483ab5150a5ccd39d8bab868102e93a51cb992baa65cdaad0c13f5be282930742ad6d73715168f3546187e9d43a1c6a396f2bac4c201c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ecbc1b4c945a9a858f6364e149323f65928d11a32abc26dfd9111bab4295cf5ddafa66b7561a553c622aec229f8f95d87a678655568003de476079e0d28eda1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/db92c4ec5fcd487d48fc25bfeee53bd467092376ee1360c8cf9bd3a294ce8745ecfbae7cbc59d1ef9445eabb14a6680f4f2a7a939c066d0ad2dbbd1560f420a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/02948e7e71ea0421e950ec932d507310aebc14252be07e65626799cab88ae5aa8b45e693315510f062d5bd3806d6d8378369cf6db2c5f3b90e7bee53ad3f7783"} 19:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:40 INFO - Contents: 19:26:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cffcf4e99bb84ea3a5483ab5150a5ccd39d8bab868102e93a51cb992baa65cdaad0c13f5be282930742ad6d73715168f3546187e9d43a1c6a396f2bac4c201c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ecbc1b4c945a9a858f6364e149323f65928d11a32abc26dfd9111bab4295cf5ddafa66b7561a553c622aec229f8f95d87a678655568003de476079e0d28eda1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/db92c4ec5fcd487d48fc25bfeee53bd467092376ee1360c8cf9bd3a294ce8745ecfbae7cbc59d1ef9445eabb14a6680f4f2a7a939c066d0ad2dbbd1560f420a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/02948e7e71ea0421e950ec932d507310aebc14252be07e65626799cab88ae5aa8b45e693315510f062d5bd3806d6d8378369cf6db2c5f3b90e7bee53ad3f7783"} 19:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:40 INFO - Copying logs to upload dir... 19:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.820251 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-20 19:26:40.219058) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 19:26:40.222682) ========= 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=32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cffcf4e99bb84ea3a5483ab5150a5ccd39d8bab868102e93a51cb992baa65cdaad0c13f5be282930742ad6d73715168f3546187e9d43a1c6a396f2bac4c201c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ecbc1b4c945a9a858f6364e149323f65928d11a32abc26dfd9111bab4295cf5ddafa66b7561a553c622aec229f8f95d87a678655568003de476079e0d28eda1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/db92c4ec5fcd487d48fc25bfeee53bd467092376ee1360c8cf9bd3a294ce8745ecfbae7cbc59d1ef9445eabb14a6680f4f2a7a939c066d0ad2dbbd1560f420a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/02948e7e71ea0421e950ec932d507310aebc14252be07e65626799cab88ae5aa8b45e693315510f062d5bd3806d6d8378369cf6db2c5f3b90e7bee53ad3f7783"} build_url:https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011551 build_url: 'https://queue.taskcluster.net/v1/task/ZGgCBxhJTvOsOHbJ4tLTAA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cffcf4e99bb84ea3a5483ab5150a5ccd39d8bab868102e93a51cb992baa65cdaad0c13f5be282930742ad6d73715168f3546187e9d43a1c6a396f2bac4c201c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ecbc1b4c945a9a858f6364e149323f65928d11a32abc26dfd9111bab4295cf5ddafa66b7561a553c622aec229f8f95d87a678655568003de476079e0d28eda1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/db92c4ec5fcd487d48fc25bfeee53bd467092376ee1360c8cf9bd3a294ce8745ecfbae7cbc59d1ef9445eabb14a6680f4f2a7a939c066d0ad2dbbd1560f420a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/02948e7e71ea0421e950ec932d507310aebc14252be07e65626799cab88ae5aa8b45e693315510f062d5bd3806d6d8378369cf6db2c5f3b90e7bee53ad3f7783"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 19:26:40.248745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:26:40.249097) ========= 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=32c5991c409366f7fec8a718000001d2-1482285541.964796-1833981890 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-12-20 19:26:40.331472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 19:26:40.331892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 19:26:40.332213) ========= ========= Total master_lag: 0.17 =========