builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1483055418.62 results: success (0) buildid: 20161229135219 builduid: d103706511054fd797cc69c12b5a7936 revision: 8999cab905a4fd17d22d1d3ba687e6f1aab374f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.617581) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.617994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.618265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.632440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.632711) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 15:50:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2016-12-29 15:50:18 (32.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.782557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.782865) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:18.832069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-29 15:50:18.832396) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8999cab905a4fd17d22d1d3ba687e6f1aab374f1 --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 8999cab905a4fd17d22d1d3ba687e6f1aab374f1 --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=3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 15:50:19,018 truncating revision to first 12 chars 2016-12-29 15:50:19,018 Setting DEBUG logging. 2016-12-29 15:50:19,018 attempt 1/10 2016-12-29 15:50:19,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8999cab905a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 15:50:19,803 unpacking tar archive at: graphics-8999cab905a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.065894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-29 15:50:19.911658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:19.912010) ========= script_repo_revision: 8999cab905a4fd17d22d1d3ba687e6f1aab374f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:19.912399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:19.912691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 15:50:19.923039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-29 15:50:19.923349) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:20 INFO - MultiFileLogger online at 20161229 15:50:20 in /builds/slave/test 15:50:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 15:50:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:20 INFO - {'append_to_log': False, 15:50:20 INFO - 'base_work_dir': '/builds/slave/test', 15:50:20 INFO - 'blob_upload_branch': 'Graphics', 15:50:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:20 INFO - 'branch': 'Graphics', 15:50:20 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:20 INFO - 'config_files': ('talos/linux_config.py',), 15:50:20 INFO - 'default_actions': ('clobber', 15:50:20 INFO - 'read-buildbot-config', 15:50:20 INFO - 'download-and-extract', 15:50:20 INFO - 'populate-webroot', 15:50:20 INFO - 'create-virtualenv', 15:50:20 INFO - 'install', 15:50:20 INFO - 'run-tests'), 15:50:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:20 INFO - 'download_minidump_stackwalk': True, 15:50:20 INFO - 'download_symbols': 'ondemand', 15:50:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:20 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:20 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:20 INFO - 'installer_path': 'installer.exe', 15:50:20 INFO - 'log_level': 'info', 15:50:20 INFO - 'log_name': 'talos', 15:50:20 INFO - 'log_to_console': True, 15:50:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:20 INFO - 'opt_config_files': (), 15:50:20 INFO - 'pip_index': False, 15:50:20 INFO - 'sps_profile': False, 15:50:20 INFO - 'sps_profile_interval': 0, 15:50:20 INFO - 'suite': 'dromaeojs-e10s', 15:50:20 INFO - 'system_bits': '32', 15:50:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:20 INFO - 'title': 'talos-linux64-ix-059', 15:50:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:20 INFO - 'use_talos_json': True, 15:50:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:20 INFO - 'work_dir': 'build'} 15:50:20 INFO - [mozharness: 2016-12-29 23:50:20.209300Z] Running clobber step. 15:50:20 INFO - Running pre-action listener: _resource_record_pre_action 15:50:20 INFO - Running main action method: clobber 15:50:20 INFO - rmtree: /builds/slave/test/build 15:50:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:20 INFO - Running post-action listener: _resource_record_post_action 15:50:20 INFO - [mozharness: 2016-12-29 23:50:20.669354Z] Finished clobber step (success) 15:50:20 INFO - [mozharness: 2016-12-29 23:50:20.669497Z] Running read-buildbot-config step. 15:50:20 INFO - Running pre-action listener: _resource_record_pre_action 15:50:20 INFO - Running main action method: read_buildbot_config 15:50:20 INFO - Using buildbot properties: 15:50:20 INFO - { 15:50:20 INFO - "project": "", 15:50:20 INFO - "product": "firefox", 15:50:20 INFO - "script_repo_revision": "default", 15:50:20 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 15:50:20 INFO - "repository": "", 15:50:20 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 15:50:20 INFO - "buildid": "20161229135219", 15:50:20 INFO - "pgo_build": "False", 15:50:20 INFO - "basedir": "/builds/slave/test", 15:50:20 INFO - "buildnumber": 42, 15:50:20 INFO - "slavename": "talos-linux64-ix-059", 15:50:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:50:20 INFO - "platform": "ubuntu64_hw", 15:50:20 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 15:50:20 INFO - "branch": "graphics", 15:50:20 INFO - "repo_path": "projects/graphics", 15:50:20 INFO - "revision": "8999cab905a4fd17d22d1d3ba687e6f1aab374f1", 15:50:20 INFO - "stage_platform": "linux64", 15:50:20 INFO - "builduid": "d103706511054fd797cc69c12b5a7936", 15:50:20 INFO - "slavebuilddir": "test" 15:50:20 INFO - } 15:50:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:50:20 INFO - Running post-action listener: _resource_record_post_action 15:50:20 INFO - [mozharness: 2016-12-29 23:50:20.672364Z] Finished read-buildbot-config step (success) 15:50:20 INFO - [mozharness: 2016-12-29 23:50:20.672454Z] Running download-and-extract step. 15:50:20 INFO - Running pre-action listener: _resource_record_pre_action 15:50:20 INFO - Running main action method: download_and_extract 15:50:20 INFO - mkdir: /builds/slave/test/build/tests 15:50:20 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')]} 15:50:20 INFO - trying https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:50:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/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 15:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/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 15:50:21 INFO - Downloaded 1361 bytes. 15:50:21 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:50:21 INFO - Using the following test package requirements: 15:50:21 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:21 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:21 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:50:21 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'jsshell-linux-x86_64.zip'], 15:50:21 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:21 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:21 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:50:21 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:50:21 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:21 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:50:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:50:22 INFO - Expected file size: 20245925 15:50:22 INFO - Obtained file size: 20245925 15:50:25 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 15:50:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:50:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:50:26 INFO - Expected file size: 20245925 15:50:26 INFO - Obtained file size: 20245925 15:50:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:50:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:50:31 INFO - Expected file size: 14409776 15:50:31 INFO - Obtained file size: 14409776 15:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:32 INFO - trying https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:50:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/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 15:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/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 15:50:33 INFO - Downloaded 55920693 bytes. 15:50:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:50:33 INFO - mkdir: /builds/slave/test/properties 15:50:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:33 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:33 INFO - Contents: 15:50:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:50:33 INFO - Running post-action listener: _resource_record_post_action 15:50:33 INFO - Running post-action listener: set_extra_try_arguments 15:50:33 INFO - [mozharness: 2016-12-29 23:50:33.900576Z] Finished download-and-extract step (success) 15:50:33 INFO - [mozharness: 2016-12-29 23:50:33.900805Z] Running populate-webroot step. 15:50:33 INFO - Running pre-action listener: _resource_record_pre_action 15:50:33 INFO - Running main action method: populate_webroot 15:50:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:50:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:50:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:50:33 INFO - '--tppagecycles', 15:50:33 INFO - '7'], 15:50:33 INFO - 'tests': ['tsvgm']}}, 15:50:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:50:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:50:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['damp', 'tps']}, 15:50:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'tests': ['damp', 'tps']}, 15:50:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['dromaeo_dom']}, 15:50:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['basic_compositor_video']}, 15:50:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:50:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['a11yr', 15:50:33 INFO - 'ts_paint', 15:50:33 INFO - 'tpaint', 15:50:33 INFO - 'sessionrestore', 15:50:33 INFO - 'sessionrestore_no_auto_restore', 15:50:33 INFO - 'tabpaint']}, 15:50:33 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:33 INFO - 'ts_paint', 15:50:33 INFO - 'tpaint', 15:50:33 INFO - 'sessionrestore', 15:50:33 INFO - 'sessionrestore_no_auto_restore', 15:50:33 INFO - 'tabpaint']}, 15:50:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:50:33 INFO - 'ts_paint', 15:50:33 INFO - 'tpaint', 15:50:33 INFO - 'sessionrestore', 15:50:33 INFO - 'sessionrestore_no_auto_restore', 15:50:33 INFO - 'tabpaint']}, 15:50:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:50:33 INFO - 'ts_paint', 15:50:33 INFO - 'tpaint', 15:50:33 INFO - 'sessionrestore', 15:50:33 INFO - 'sessionrestore_no_auto_restore', 15:50:33 INFO - 'tabpaint']}, 15:50:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['a11yr', 15:50:33 INFO - 'ts_paint', 15:50:33 INFO - 'tpaint', 15:50:33 INFO - 'sessionrestore', 15:50:33 INFO - 'sessionrestore_no_auto_restore', 15:50:33 INFO - 'tabpaint']}, 15:50:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['a11yr', 15:50:33 INFO - 'ts_paint', 15:50:33 INFO - 'tpaint', 15:50:33 INFO - 'sessionrestore', 15:50:33 INFO - 'sessionrestore_no_auto_restore', 15:50:33 INFO - 'tabpaint']}, 15:50:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['tsvgx', 15:50:33 INFO - 'tsvgr_opacity', 15:50:33 INFO - 'tart', 15:50:33 INFO - 'tscrollx', 15:50:33 INFO - 'cart', 15:50:33 INFO - 'tsvg_static']}, 15:50:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:33 INFO - 'tsvgr_opacity', 15:50:33 INFO - 'tart', 15:50:33 INFO - 'tscrollx', 15:50:33 INFO - 'cart', 15:50:33 INFO - 'tsvg_static']}, 15:50:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'talos_options': ['--disable-e10s'], 15:50:33 INFO - 'tests': ['tp5o']}, 15:50:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:50:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'talos_options': ['--disable-e10s', 15:50:33 INFO - '--xperf_path', 15:50:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:33 INFO - 'tests': ['tp5n']}, 15:50:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:50:33 INFO - 'talos_options': ['--xperf_path', 15:50:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:33 INFO - 'tests': ['tp5n']}}, 15:50:33 INFO - 'talos.zip': {'path': '', 15:50:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:50:33 INFO - Running post-action listener: _resource_record_post_action 15:50:33 INFO - [mozharness: 2016-12-29 23:50:33.919223Z] Finished populate-webroot step (success) 15:50:33 INFO - [mozharness: 2016-12-29 23:50:33.919312Z] Running create-virtualenv step. 15:50:33 INFO - Running pre-action listener: _resource_record_pre_action 15:50:33 INFO - Running main action method: create_virtualenv 15:50:33 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:33 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 15:50:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:50:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:34 INFO - Using real prefix '/usr' 15:50:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:34 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:36 INFO - Installing pip.................done. 15:50:36 INFO - Return code: 0 15:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:36 INFO - Reading from file tmpfile_stdout 15:50:36 INFO - Output received: 15:50:36 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) 15:50:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50:36 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')]} 15:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:36 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')]} 15:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:36 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 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:36 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 15:50:36 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 15:50:36 INFO - Using env: {'DISPLAY': ':0', 15:50:36 INFO - 'HOME': '/home/cltbld', 15:50:36 INFO - 'LANG': 'en_US.UTF-8', 15:50:36 INFO - 'LANGUAGE': 'en_US:en', 15:50:36 INFO - 'LOGNAME': 'cltbld', 15:50:36 INFO - 'MAIL': '/var/mail/cltbld', 15:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:36 INFO - 'MOZ_NO_REMOTE': '1', 15:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:36 INFO - 'NO_EM_RESTART': '1', 15:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:36 INFO - 'PWD': '/builds/slave/test', 15:50:36 INFO - 'SHELL': '/bin/bash', 15:50:36 INFO - 'SHLVL': '1', 15:50:36 INFO - 'TERM': 'linux', 15:50:36 INFO - 'TMOUT': '86400', 15:50:36 INFO - 'USER': 'cltbld', 15:50:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:36 INFO - '_': '/tools/buildbot/bin/python'} 15:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:36 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 15:50:36 INFO - Cleaning up... 15:50:36 INFO - Return code: 0 15:50:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50:36 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')]} 15:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:36 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')]} 15:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:36 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 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:36 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 15:50:36 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 15:50:36 INFO - Using env: {'DISPLAY': ':0', 15:50:36 INFO - 'HOME': '/home/cltbld', 15:50:36 INFO - 'LANG': 'en_US.UTF-8', 15:50:36 INFO - 'LANGUAGE': 'en_US:en', 15:50:36 INFO - 'LOGNAME': 'cltbld', 15:50:36 INFO - 'MAIL': '/var/mail/cltbld', 15:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:36 INFO - 'MOZ_NO_REMOTE': '1', 15:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:36 INFO - 'NO_EM_RESTART': '1', 15:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:36 INFO - 'PWD': '/builds/slave/test', 15:50:36 INFO - 'SHELL': '/bin/bash', 15:50:36 INFO - 'SHLVL': '1', 15:50:36 INFO - 'TERM': 'linux', 15:50:36 INFO - 'TMOUT': '86400', 15:50:36 INFO - 'USER': 'cltbld', 15:50:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:36 INFO - '_': '/tools/buildbot/bin/python'} 15:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:37 INFO - Downloading/unpacking psutil>=3.1.1 15:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:39 INFO - Installing collected packages: psutil 15:50:39 INFO - Running setup.py install for psutil 15:50:39 INFO - building 'psutil._psutil_linux' extension 15:50:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:50:39 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 15:50:39 INFO - building 'psutil._psutil_posix' extension 15:50:39 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 15:50:39 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 15:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:39 INFO - Successfully installed psutil 15:50:39 INFO - Cleaning up... 15:50:39 INFO - Return code: 0 15:50:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50:39 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')]} 15:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:39 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')]} 15:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:39 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 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:39 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 15:50:39 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 15:50:39 INFO - Using env: {'DISPLAY': ':0', 15:50:39 INFO - 'HOME': '/home/cltbld', 15:50:39 INFO - 'LANG': 'en_US.UTF-8', 15:50:39 INFO - 'LANGUAGE': 'en_US:en', 15:50:39 INFO - 'LOGNAME': 'cltbld', 15:50:39 INFO - 'MAIL': '/var/mail/cltbld', 15:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:39 INFO - 'MOZ_NO_REMOTE': '1', 15:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:39 INFO - 'NO_EM_RESTART': '1', 15:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:39 INFO - 'PWD': '/builds/slave/test', 15:50:39 INFO - 'SHELL': '/bin/bash', 15:50:39 INFO - 'SHLVL': '1', 15:50:39 INFO - 'TERM': 'linux', 15:50:39 INFO - 'TMOUT': '86400', 15:50:39 INFO - 'USER': 'cltbld', 15:50:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:39 INFO - '_': '/tools/buildbot/bin/python'} 15:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:42 INFO - Installing collected packages: mozsystemmonitor 15:50:42 INFO - Running setup.py install for mozsystemmonitor 15:50:42 INFO - Successfully installed mozsystemmonitor 15:50:42 INFO - Cleaning up... 15:50:42 INFO - Return code: 0 15:50:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:50:42 INFO - Using env: {'DISPLAY': ':0', 15:50:42 INFO - 'HOME': '/home/cltbld', 15:50:42 INFO - 'LANG': 'en_US.UTF-8', 15:50:42 INFO - 'LANGUAGE': 'en_US:en', 15:50:42 INFO - 'LOGNAME': 'cltbld', 15:50:42 INFO - 'MAIL': '/var/mail/cltbld', 15:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:42 INFO - 'MOZ_NO_REMOTE': '1', 15:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:42 INFO - 'NO_EM_RESTART': '1', 15:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:42 INFO - 'PWD': '/builds/slave/test', 15:50:42 INFO - 'SHELL': '/bin/bash', 15:50:42 INFO - 'SHLVL': '1', 15:50:42 INFO - 'TERM': 'linux', 15:50:42 INFO - 'TMOUT': '86400', 15:50:42 INFO - 'USER': 'cltbld', 15:50:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:42 INFO - '_': '/tools/buildbot/bin/python'} 15:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:42 INFO - Downloading/unpacking jsonschema==2.5.1 15:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:44 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:44 INFO - warning: no files found matching '*.txt' 15:50:44 INFO - no previously-included directories found matching 'build' 15:50:44 INFO - no previously-included directories found matching 'dist' 15:50:44 INFO - no previously-included directories found matching '.git*' 15:50:44 INFO - Installing collected packages: jsonschema, functools32 15:50:44 INFO - Running setup.py install for functools32 15:50:44 INFO - warning: no files found matching '*.txt' 15:50:44 INFO - no previously-included directories found matching 'build' 15:50:44 INFO - no previously-included directories found matching 'dist' 15:50:44 INFO - no previously-included directories found matching '.git*' 15:50:44 INFO - Successfully installed jsonschema functools32 15:50:44 INFO - Cleaning up... 15:50:44 INFO - Return code: 0 15:50:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50:44 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')]} 15:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:44 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')]} 15:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:44 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 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:44 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 15:50:44 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 15:50:44 INFO - Using env: {'DISPLAY': ':0', 15:50:44 INFO - 'HOME': '/home/cltbld', 15:50:44 INFO - 'LANG': 'en_US.UTF-8', 15:50:44 INFO - 'LANGUAGE': 'en_US:en', 15:50:44 INFO - 'LOGNAME': 'cltbld', 15:50:44 INFO - 'MAIL': '/var/mail/cltbld', 15:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:44 INFO - 'MOZ_NO_REMOTE': '1', 15:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:44 INFO - 'NO_EM_RESTART': '1', 15:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:44 INFO - 'PWD': '/builds/slave/test', 15:50:44 INFO - 'SHELL': '/bin/bash', 15:50:44 INFO - 'SHLVL': '1', 15:50:44 INFO - 'TERM': 'linux', 15:50:44 INFO - 'TMOUT': '86400', 15:50:44 INFO - 'USER': 'cltbld', 15:50:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:44 INFO - '_': '/tools/buildbot/bin/python'} 15:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:45 INFO - Cleaning up... 15:50:45 INFO - Return code: 0 15:50:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:50:45 INFO - Using env: {'DISPLAY': ':0', 15:50:45 INFO - 'HOME': '/home/cltbld', 15:50:45 INFO - 'LANG': 'en_US.UTF-8', 15:50:45 INFO - 'LANGUAGE': 'en_US:en', 15:50:45 INFO - 'LOGNAME': 'cltbld', 15:50:45 INFO - 'MAIL': '/var/mail/cltbld', 15:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:45 INFO - 'MOZ_NO_REMOTE': '1', 15:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:45 INFO - 'NO_EM_RESTART': '1', 15:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:45 INFO - 'PWD': '/builds/slave/test', 15:50:45 INFO - 'SHELL': '/bin/bash', 15:50:45 INFO - 'SHLVL': '1', 15:50:45 INFO - 'TERM': 'linux', 15:50:45 INFO - 'TMOUT': '86400', 15:50:45 INFO - 'USER': 'cltbld', 15:50:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:45 INFO - '_': '/tools/buildbot/bin/python'} 15:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:45 INFO - Downloading/unpacking blobuploader==1.2.4 15:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:48 INFO - Downloading docopt-0.6.1.tar.gz 15:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:48 INFO - Running setup.py install for blobuploader 15:50:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:48 INFO - Running setup.py install for requests 15:50:48 INFO - Running setup.py install for docopt 15:50:48 INFO - Successfully installed blobuploader requests docopt 15:50:48 INFO - Cleaning up... 15:50:48 INFO - Return code: 0 15:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:48 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 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:48 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 15:50:48 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 15:50:48 INFO - Using env: {'DISPLAY': ':0', 15:50:48 INFO - 'HOME': '/home/cltbld', 15:50:48 INFO - 'LANG': 'en_US.UTF-8', 15:50:48 INFO - 'LANGUAGE': 'en_US:en', 15:50:48 INFO - 'LOGNAME': 'cltbld', 15:50:48 INFO - 'MAIL': '/var/mail/cltbld', 15:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:48 INFO - 'MOZ_NO_REMOTE': '1', 15:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:48 INFO - 'NO_EM_RESTART': '1', 15:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:48 INFO - 'PWD': '/builds/slave/test', 15:50:48 INFO - 'SHELL': '/bin/bash', 15:50:48 INFO - 'SHLVL': '1', 15:50:48 INFO - 'TERM': 'linux', 15:50:48 INFO - 'TMOUT': '86400', 15:50:48 INFO - 'USER': 'cltbld', 15:50:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:48 INFO - '_': '/tools/buildbot/bin/python'} 15:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:49 INFO - Running setup.py (path:/tmp/pip-5g5WrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:49 INFO - Running setup.py (path:/tmp/pip-xPwPav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:49 INFO - Running setup.py (path:/tmp/pip-YUtdfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:49 INFO - Running setup.py (path:/tmp/pip-7VWRJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:49 INFO - Running setup.py (path:/tmp/pip-s5xVsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:49 INFO - Running setup.py (path:/tmp/pip-ApL791-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:49 INFO - Running setup.py (path:/tmp/pip-CaZLX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:49 INFO - Running setup.py (path:/tmp/pip-nQ8TRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:49 INFO - Running setup.py (path:/tmp/pip-TwbXIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:49 INFO - Running setup.py (path:/tmp/pip-s2eJTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:49 INFO - Running setup.py (path:/tmp/pip-PaQX95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:49 INFO - Running setup.py (path:/tmp/pip-0QvvjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:49 INFO - Running setup.py (path:/tmp/pip-TVlBJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:49 INFO - Running setup.py (path:/tmp/pip-ghRAAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:50 INFO - Running setup.py (path:/tmp/pip-Tb59Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:50 INFO - Running setup.py (path:/tmp/pip-CqTnox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:50 INFO - Running setup.py (path:/tmp/pip-E2GEVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:50:50 INFO - Running setup.py install for manifestparser 15:50:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Running setup.py install for mozcrash 15:50:50 INFO - Running setup.py install for mozdebug 15:50:50 INFO - Running setup.py install for mozdevice 15:50:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Running setup.py install for mozfile 15:50:50 INFO - Running setup.py install for mozhttpd 15:50:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Running setup.py install for mozinfo 15:50:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Running setup.py install for mozInstall 15:50:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Running setup.py install for mozleak 15:50:51 INFO - Running setup.py install for mozlog 15:50:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Running setup.py install for moznetwork 15:50:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Running setup.py install for mozprocess 15:50:51 INFO - Running setup.py install for mozprofile 15:50:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Running setup.py install for mozrunner 15:50:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:50:51 INFO - Running setup.py install for mozscreenshot 15:50:51 INFO - Running setup.py install for moztest 15:50:51 INFO - Running setup.py install for mozversion 15:50:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:50:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:50:52 INFO - Cleaning up... 15:50:52 INFO - Return code: 0 15:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:50:52 INFO - Using env: {'DISPLAY': ':0', 15:50:52 INFO - 'HOME': '/home/cltbld', 15:50:52 INFO - 'LANG': 'en_US.UTF-8', 15:50:52 INFO - 'LANGUAGE': 'en_US:en', 15:50:52 INFO - 'LOGNAME': 'cltbld', 15:50:52 INFO - 'MAIL': '/var/mail/cltbld', 15:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:52 INFO - 'MOZ_NO_REMOTE': '1', 15:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:52 INFO - 'NO_EM_RESTART': '1', 15:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:52 INFO - 'PWD': '/builds/slave/test', 15:50:52 INFO - 'SHELL': '/bin/bash', 15:50:52 INFO - 'SHLVL': '1', 15:50:52 INFO - 'TERM': 'linux', 15:50:52 INFO - 'TMOUT': '86400', 15:50:52 INFO - 'USER': 'cltbld', 15:50:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:52 INFO - '_': '/tools/buildbot/bin/python'} 15:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:52 INFO - Running setup.py (path:/tmp/pip-jQjfnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:52 INFO - Running setup.py (path:/tmp/pip-gz4KCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:52 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)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:52 INFO - Running setup.py (path:/tmp/pip-G8VClq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:52 INFO - Running setup.py (path:/tmp/pip-xuRaZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:52 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)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:52 INFO - Running setup.py (path:/tmp/pip-QAY4dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:52 INFO - Running setup.py (path:/tmp/pip-ksAW5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:52 INFO - Running setup.py (path:/tmp/pip-ysR6qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:52 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)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:52 INFO - Running setup.py (path:/tmp/pip-R1u3uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:52 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)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:52 INFO - Running setup.py (path:/tmp/pip-J2Gm_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:52 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)) 15:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:52 INFO - Running setup.py (path:/tmp/pip-xb4M5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:53 INFO - Running setup.py (path:/tmp/pip-r0NER7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:53 INFO - Running setup.py (path:/tmp/pip-uTrzsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:53 INFO - Running setup.py (path:/tmp/pip-VNlxHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:53 INFO - Running setup.py (path:/tmp/pip-iwnxMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:53 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)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:53 INFO - Running setup.py (path:/tmp/pip-xPAsDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:53 INFO - Running setup.py (path:/tmp/pip-hEm30o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:53 INFO - Running setup.py (path:/tmp/pip-_VOtR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:50:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:55 INFO - Downloading blessings-1.6.tar.gz 15:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:50:55 INFO - Installing collected packages: blessings 15:50:55 INFO - Running setup.py install for blessings 15:50:55 INFO - Successfully installed blessings 15:50:55 INFO - Cleaning up... 15:50:56 INFO - Return code: 0 15:50:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:56 INFO - Reading from file tmpfile_stdout 15:50:56 INFO - Current package versions: 15:50:56 INFO - argparse == 1.2.1 15:50:56 INFO - blessings == 1.6 15:50:56 INFO - blobuploader == 1.2.4 15:50:56 INFO - docopt == 0.6.1 15:50:56 INFO - functools32 == 3.2.3-2 15:50:56 INFO - jsonschema == 2.5.1 15:50:56 INFO - manifestparser == 1.1 15:50:56 INFO - mozInstall == 1.12 15:50:56 INFO - mozcrash == 1.0 15:50:56 INFO - mozdebug == 0.1 15:50:56 INFO - mozdevice == 0.49 15:50:56 INFO - mozfile == 1.2 15:50:56 INFO - mozhttpd == 0.7 15:50:56 INFO - mozinfo == 0.9 15:50:56 INFO - mozleak == 0.1 15:50:56 INFO - mozlog == 3.4 15:50:56 INFO - moznetwork == 0.27 15:50:56 INFO - mozprocess == 0.23 15:50:56 INFO - mozprofile == 0.28 15:50:56 INFO - mozrunner == 6.13 15:50:56 INFO - mozscreenshot == 0.1 15:50:56 INFO - mozsystemmonitor == 0.3 15:50:56 INFO - moztest == 0.7 15:50:56 INFO - mozversion == 1.4 15:50:56 INFO - psutil == 3.1.1 15:50:56 INFO - requests == 1.2.3 15:50:56 INFO - wsgiref == 0.1.2 15:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:50:56 INFO - Using env: {'DISPLAY': ':0', 15:50:56 INFO - 'HOME': '/home/cltbld', 15:50:56 INFO - 'LANG': 'en_US.UTF-8', 15:50:56 INFO - 'LANGUAGE': 'en_US:en', 15:50:56 INFO - 'LOGNAME': 'cltbld', 15:50:56 INFO - 'MAIL': '/var/mail/cltbld', 15:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:56 INFO - 'MOZ_NO_REMOTE': '1', 15:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:56 INFO - 'NO_EM_RESTART': '1', 15:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:56 INFO - 'PWD': '/builds/slave/test', 15:50:56 INFO - 'SHELL': '/bin/bash', 15:50:56 INFO - 'SHLVL': '1', 15:50:56 INFO - 'TERM': 'linux', 15:50:56 INFO - 'TMOUT': '86400', 15:50:56 INFO - 'USER': 'cltbld', 15:50:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:56 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:50:56 INFO - Cleaning up... 15:50:56 INFO - Return code: 0 15:50:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', '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 15:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:50:56 INFO - Using env: {'DISPLAY': ':0', 15:50:56 INFO - 'HOME': '/home/cltbld', 15:50:56 INFO - 'LANG': 'en_US.UTF-8', 15:50:56 INFO - 'LANGUAGE': 'en_US:en', 15:50:56 INFO - 'LOGNAME': 'cltbld', 15:50:56 INFO - 'MAIL': '/var/mail/cltbld', 15:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:56 INFO - 'MOZ_NO_REMOTE': '1', 15:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:56 INFO - 'NO_EM_RESTART': '1', 15:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:56 INFO - 'PWD': '/builds/slave/test', 15:50:56 INFO - 'SHELL': '/bin/bash', 15:50:56 INFO - 'SHLVL': '1', 15:50:56 INFO - 'TERM': 'linux', 15:50:56 INFO - 'TMOUT': '86400', 15:50:56 INFO - 'USER': 'cltbld', 15:50:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:56 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:50:56 INFO - Cleaning up... 15:50:56 INFO - Return code: 0 15:50:56 INFO - Running post-action listener: _resource_record_post_action 15:50:56 INFO - Running post-action listener: _start_resource_monitoring 15:50:56 INFO - Starting resource monitoring. 15:50:56 INFO - [mozharness: 2016-12-29 23:50:56.731256Z] Finished create-virtualenv step (success) 15:50:56 INFO - [mozharness: 2016-12-29 23:50:56.731715Z] Running install step. 15:50:56 INFO - Running pre-action listener: _resource_record_pre_action 15:50:56 INFO - Running main action method: install 15:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:56 INFO - Reading from file tmpfile_stdout 15:50:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:50:57 INFO - Reading from file tmpfile_stdout 15:50:57 INFO - Output received: 15:50:57 INFO - Usage: mozinstall [options] installer 15:50:57 INFO - Options: 15:50:57 INFO - -h, --help show this help message and exit 15:50:57 INFO - -d DEST, --destination=DEST 15:50:57 INFO - Directory to install application into. [default: 15:50:57 INFO - "/builds/slave/test"] 15:50:57 INFO - --app=APP Application being installed. [default: firefox] 15:50:57 INFO - mkdir: /builds/slave/test/build/application 15:50:57 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'] 15:50:57 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 15:51:13 INFO - Reading from file tmpfile_stdout 15:51:13 INFO - Output received: 15:51:13 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:13 INFO - Running post-action listener: _resource_record_post_action 15:51:13 INFO - [mozharness: 2016-12-29 23:51:13.142059Z] Finished install step (success) 15:51:13 INFO - [mozharness: 2016-12-29 23:51:13.142308Z] Running run-tests step. 15:51:13 INFO - Running pre-action listener: _resource_record_pre_action 15:51:13 INFO - Running main action method: run_tests 15:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:13 INFO - Python 2.7.3 15:51:13 INFO - Return code: 0 15:51:13 INFO - grabbing minidump binary from tooltool 15:51: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')]} 15:51:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d3f0>, '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 0x226dcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226e1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:51:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:51:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:51:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:13 INFO - Return code: 0 15:51:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:51:13 INFO - Using env: {'DISPLAY': ':0', 15:51:13 INFO - 'HOME': '/home/cltbld', 15:51:13 INFO - 'LANG': 'en_US.UTF-8', 15:51:13 INFO - 'LANGUAGE': 'en_US:en', 15:51:13 INFO - 'LOGNAME': 'cltbld', 15:51:13 INFO - 'MAIL': '/var/mail/cltbld', 15:51:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:13 INFO - 'MOZ_NO_REMOTE': '1', 15:51:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:13 INFO - 'NO_EM_RESTART': '1', 15:51:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:13 INFO - 'PWD': '/builds/slave/test', 15:51:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:13 INFO - 'SHELL': '/bin/bash', 15:51:13 INFO - 'SHLVL': '1', 15:51:13 INFO - 'TERM': 'linux', 15:51:13 INFO - 'TMOUT': '86400', 15:51:13 INFO - 'USER': 'cltbld', 15:51:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806', 15:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:13 INFO - '_': '/tools/buildbot/bin/python'} 15:51:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:51:13 INFO - mozversion application_buildid: 20161229135219 15:51:13 INFO - mozversion application_changeset: 8999cab905a4fd17d22d1d3ba687e6f1aab374f1 15:51:13 INFO - mozversion application_display_name: Nightly 15:51:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:13 INFO - mozversion application_name: Firefox 15:51:13 INFO - mozversion application_remotingname: firefox 15:51:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 15:51:13 INFO - mozversion application_vendor: Mozilla 15:51:13 INFO - mozversion application_version: 53.0a1 15:51:13 INFO - mozversion platform_buildid: 20161229135219 15:51:13 INFO - mozversion platform_changeset: 8999cab905a4fd17d22d1d3ba687e6f1aab374f1 15:51:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 15:51:13 INFO - mozversion platform_version: 53.0a1 15:51:13 INFO - using testdate: 1483055473 15:51:13 INFO - actual date: 1483055473 15:51:13 INFO - starting webserver on 'localhost:59251' 15:51:13 INFO - SUITE-START | Running 2 tests 15:51:13 INFO - TEST-START | dromaeo_css 15:51:13 INFO - operating with platform_type : linux_ 15:51:13 INFO - Initialising browser for dromaeo_css test... 15:51:13 INFO - TEST-INFO | started process 6359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBGRwFJ/profile http://localhost:59251/getInfo.html) 15:51:13 INFO - PROCESS | 6359 | 1483055473953 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 15:51:17 INFO - PROCESS | 6359 | __metrics Screen width/height:1600/1200 15:51:17 INFO - PROCESS | 6359 | colorDepth:24 15:51:17 INFO - PROCESS | 6359 | Browser inner width/height: 1024/697 15:51:17 INFO - PROCESS | 6359 | __metrics 15:51:18 ERROR - PROCESS | 6359 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 15:51:19 INFO - TEST-INFO | 6359: exit 0 15:51:19 INFO - Browser initialized. 15:51:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:19 INFO - TEST-INFO | started process 6482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBGRwFJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:31 INFO - PROCESS | 6482 | RSS: Main: 158568448 15:51:31 INFO - PROCESS | 6482 | 15:54:34 INFO - PROCESS | 6482 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59251/tests/dromaeo/cssquery-ext.html) 15:54:35 INFO - PROCESS | 6482 | RSS: Main: 165142528 15:54:35 INFO - PROCESS | 6482 | 15:56:19 INFO - PROCESS | 6482 | ************************* 15:56:19 INFO - PROCESS | 6482 | A coding exception was thrown and uncaught in a Task. 15:56:19 INFO - PROCESS | 6482 | 15:56:19 INFO - PROCESS | 6482 | Full message: ReferenceError: fetch is not defined 15:56:19 INFO - PROCESS | 6482 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 15:56:19 INFO - PROCESS | 6482 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 15:56:19 INFO - PROCESS | 6482 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 15:56:19 INFO - PROCESS | 6482 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:56:19 INFO - PROCESS | 6482 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:56:19 INFO - PROCESS | 6482 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:56:19 INFO - PROCESS | 6482 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 15:56:19 INFO - PROCESS | 6482 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:56:19 INFO - PROCESS | 6482 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:56:19 INFO - PROCESS | 6482 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:56:19 INFO - PROCESS | 6482 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 15:56:19 INFO - PROCESS | 6482 | 15:56:19 INFO - PROCESS | 6482 | ************************* 15:57:38 INFO - PROCESS | 6482 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-ext.html (next: http://localhost:59251/tests/dromaeo/cssquery-jquery.html) 15:57:38 INFO - PROCESS | 6482 | RSS: Main: 162799616 15:57:38 INFO - PROCESS | 6482 | 16:00:41 INFO - PROCESS | 6482 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59251/tests/dromaeo/cssquery-mootools.html) 16:00:41 INFO - PROCESS | 6482 | RSS: Main: 167911424 16:00:41 INFO - PROCESS | 6482 | 16:03:43 INFO - PROCESS | 6482 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59251/tests/dromaeo/cssquery-prototype.html) 16:03:44 INFO - PROCESS | 6482 | RSS: Main: 163319808 16:03:44 INFO - PROCESS | 6482 | 16:06:47 INFO - PROCESS | 6482 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59251/tests/dromaeo/cssquery-yui.html) 16:06:48 INFO - PROCESS | 6482 | RSS: Main: 165941248 16:06:48 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | Cycle 1(1): loaded http://localhost:59251/tests/dromaeo/cssquery-yui.html (next: http://localhost:59251/tests/dromaeo/cssquery-dojo.html) 16:09:51 INFO - PROCESS | 6482 | RSS: Main: 168042496 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | __start_tp_report 16:09:51 INFO - PROCESS | 6482 | _x_x_mozilla_page_load 16:09:51 INFO - PROCESS | 6482 | _x_x_mozilla_page_load_details 16:09:51 INFO - PROCESS | 6482 | |i|pagename|runs| 16:09:51 INFO - PROCESS | 6482 | |0;dojo.html;2607.7522635349637;2610.2691246450995;2627.9737202627994;2649.655544779178;2658.0696756135353;4701.294805779135;4780.713157210565;4788.569028787409;4790.089882922242;4855.417349918015;4698.882527936803;4729.12511185431;4729.2433210686295;4747.857564273068;4792.976035119819;4322.178786030652;4343.391925130469;4369.366441865927;4445.888852778674;4452.621527170194;4084.101497670508;4493.9775301123445;4523.5024147343765;4544.454665440152;4552.658550608701;4284;4440.711353762027;4445.444319460067;4474.217012022883;4553.886152846188;4286.442762440894;4355.412019377375;4386.71486353386;4408.515063343029;4504.572065653758;4360.106178233455;4363.061941682522;4399.098184872094;4413.029133590637;4426.579474949906;4744.952550474485;4762.809487620491;4790.928136077961;4834.419869615634;4853.247746599282;4962.354893863775;5006.5494105530315;5068.315777370045;5117.6161787865685;5118.513741194581;5123.590112791005;5174.611904107207;5185.170372740381;5191.610629202825;5212.713300768456;4836.661433699607;4859.975700121512;4861.854144375674;4864.6594738368685;4907.460179380265;5066.36670416198;5116.795328186905;5147.279380886679;5151.97424012885;5257.316548848702;5010.974945125251;5012.649114562018;5015.448300686921;5031.396232452129;5069.290299358093;5031.823886163967;5062.367204099488;5084.13569693153;5091.949080509222;5118.539331460186;4885.242787367893;4922.138625740481;4972.030454061423;5016.372953380827;5024.397072351268;5009.198528235464;5014.949850501521;5016.247562865599;5045.217991211368;5080.187170052774;4194.769287689145;4204.201201771653;4206.137741762931;4236.9364459533135;4240.469941257343;3669.082729317671;3669.4679271505483;3688.5204923359793;3688.6495782900583;3691.6492933171307;4443.488998765119;4456.108778244364;4473.150101480708;4476.9104617908115;4493.191225579427;5060.51925067118;5084.46613105626;5121.923171152435;5128;5141.228815677603;4391.802368893407;4399.098184872094;4437.423134992495;4457.375967364572;4478.977605111953;4519.254323036662;4552.271636538138;4555.817767289272;4573.085382923428;4591.265397536378;4792.305115758265;4802.183628783185;4806.303086052572;4837.05677392905;4849.127157111683;4972.378452693269;5018.222175562793;5151.6908985461;5156.948430515647;5186.818461353985;4736.147493451074;4747.83382581608;4753.786079626356;4769.689970151929;4837.540433658797;4992;5007.273945277987;5011.423686275979;5014.749262536931;5048.823291184791;4962.925556116589;5082.898342033065;5086.160783470686;5103.591712663052;5170.121079416433;4851.975740121276;4941.703497790144;4967.726775027409;4969.776360063734;5051.1160546904875;4982.975085124551;4985.900281994413;4987.750612469289;4989.426215985208;5033.5721463676;4756.143894099096;4798.856034318976;4801.879953001203;4895.583875370491;4937.8271760488215;4940.431850337257;4946.109700253989;4948.183549714401;4965.354503914468;4966.528179822911;4875.488073752205;4886.022795440855;4904.166291730343;4944.283078953604;4951 16:09:51 INFO - PROCESS | 6482 | |1;ext.html;503.66254609411715;504.9141645920194;526.3236740788087;526.686621460231;537.4249552978315;36679.26641467172;38941.22117557651;39109.60890391095;39255;41802.327906883766;39335.40996885049;39556.20887582246;39809.601903980954;39861;39875.40186897199;7735.419843511731;7870.881936770925;7894.960525197394;7910.525368477881;9633.421994680342;9439.575219115122;9757.658481953133;9872.308938374317;9880.40717556949;9897.75255618608;9873.753156171117;9910.55402506889;9913.950430247838;9914.900850991506;9928.602855885756;9811.607535698564;9895.257855660819;9901.25740569453;9904.504774761304;9912.504374781303;9705.466199359033;9757.316987810857;9771.462569558671;9773.12041916231;9788.755281117958;33386.33227335464;33555.32889342224;33838.661613383796;33908.83045584781;33917.491237631206;3421.863125474978;3445.6554344565593;3473.94789078164;3481.0775144586705;3488.9127771805656;25105.49789004228;25628.23115306525;25687.357816054748;25767.613485797727;25772.097976570916;2948.82307061577;3091.458994675945;3128.124125244935;3191.2181515528846;3199.6480387157394;225318;225897;226239;226265.86867065725;226474;45857.77071114623;45902.770486147354;46105.76947115243;46145.76927115343;46264;47903.76048119807;47918.28122578164;47918.28122578164;47936.28095578569;48007;13258.337083145803;13402.865971340358;13407.664808379674;13408.396622152026;13459.057865949486;9182.586783594754;9399.953000235091;10426.947865260625;10570.207234457446;10664.573417063231;15350.309236084404;15540.611484712972;15567.922160389126;15681.607959801097;15692.372305107896;6452.709628066748;6456.870047741627;6537.5750576212395;6550.672466376662;6570.441512471493;804.2279411764655;808.8503626829056;819.774561995456;826.9958650206711;840.5041025794688;26467.735322646527;27368.726312736617;27724.30689232745;28039.859800700866;28151.859240703667;959.318883592657;960.7646126699003;992.503748125937;995.2585323933715;1060.1095080132725;13741.656458588415;14501.854981450262;14655.48705795292;14788.926055369655;14863.777043344358;255642;332055;334793;335710;336102;43100;43263.13473730508;43552.56447435485;43634.56365436369;43746.56253437425;1188.9524419023314;1222.5986448784306;1248.126311581878;1248.9812652810215;1250.2560976219136;24314.75685243125;24823.627645585693;27542.5868611975;28418;28979;40868;41794.1641167181;41796;41893.1621367577;41965.1606967865;321272;323503;325028;325121;325496;30510;32908.50637240491;33343.49984750182;33353;33669.32661346808;41875.58124418717;42083.579164207964;42433.78783106065;42469.78765106278;43037.78481107575;36577.63422365742;36745.265094697425;37943.2411351777;38129.42805857859;38780.80609597047;36425;36431.62820461456;36695.81652091829;37063.6293637071;37154.876939833535;34990.47514287339;35195.472067919516;35913.640863592074;35931.640683593876;35952.64047359493;30968.690313097482;32025.519617206228;32925.670743293216;33174.336513270086;33248.33503329872;24974.62538061894;25022.37444063913;25110.246692599252;25476.363090922136;25576 16:09:51 INFO - PROCESS | 6482 | |2;jquery.html;371.6970668904844;378.37001392681196;379.32290860813447;388.570629454453;393.04686136119903;15370;16018.519444416657;16605.916970415146;16740.916295418538;16749.330026798914;13035.478580856754;14319.284035798195;16730.330786768514;16914.74627880583;16963.067031313272;4519.186546421643;4755.619550435957;4758.167320718878;4758.952410475903;4764.85705428836;3642.344378011957;3810.9237815243678;4691.413573303337;5195.532402083812;5440.537554307889;5448.536874365664;5454.7272636368225;5455.399906010336;5456.290682211326;5465.836024919259;5210.713410762407;5297.496737809902;5332.786688532454;5347.171188465794;5445.891082178354;5178.119719647631;5178.300929374562;5179.844604661828;5193.246979188034;5199.610029247784;13950.860491395058;14340.996130270885;20009.599808003757;20295.89852050745;20300.593988120156;2131.467133216696;2177.368563116694;2179.2154824263253;2211.0824008036648;2251.819854411643;8514.485514485514;8784.780380490474;9075.13786190311;9109.18017378439;9327.067293270686;1666.125284225779;1707.8548323392527;1709.880308378414;1741.1381366223673;1747.432084572519;48529.75735121302;58440;58848.70575647095;60309.09536356914;62884.68557657228;9726.319157658896;9828.230918434607;9929.65246216379;10139.898601013896;10186.388816671024;13682.31588420575;13684.31578421075;13687.31563421825;13689;13694.178349299074;6948.791536253921;7203.494520047075;7245.239249878792;7259.89110163348;7294.416446684252;6605.70274337656;6656.667166641649;6816.522843401013;6862.897056544156;6932.306769323128;4025.2150830587752;4029.5366032906004;4186.748795072305;4284.978575107167;4388.385626012361;1488.95533134004;1570.9764353534706;1791.8387345139;1868.8504919606398;1877.7652793400825;760.3423039071164;787.9709747400467;787.984240315202;790.5454363740872;792.7582087463379;15435.614109647124;15628.35794787211;16032.038077715375;16197.271122799502;16200.837991619934;789.8617741895146;794.6980147544012;801.2508304734974;803.6584451608043;815.7437546178936;8909.287257019423;8969.820603587892;9097.863532047024;9151.72544823643;9202.355835091614;322177;323123;325707;327655;328003;69450.3054969454;69630.65184674044;70461.64769176122;70608.64695676489;71991.2800871995;892.8437523433503;905.108468158863;922.7693076730817;928.5635751196927;947.308464820671;14722.190279534729;14761.261936903327;15049.398024078915;15074.698506030038;15579.844201557838;31970.36059278755;33990.66009339974;34081.31837363189;35246.823765881;35855.46216806698;39413.408798867466;44660.55339446564;46079.53920460752;49170.26244606405;49348;6399.360063993563;6739.764108256383;6835.760748373783;6938.583684978716;6965.512414131165;7055.717771289091;9407.905920940702;10256.102621015136;11465.828012579985;11717.941410292893;5351.3043304370185;5842.591018628656;8672.566371681265;9540;9564.330496865152;9890;10048.748781280527;10335.121514671337;10485.16118710486;10875.564977400816;5475.72621368922;5615;7873.645685944031;9543.618255269712;9881.258905582254;7233.855322893618;7278.308560686726;7301.890471643036;7359.190489046307;7493.812654683458;7200.819979500345;8837.204651581389;9590.808183836145;9727.65953191635;9842.261830362608 16:09:51 INFO - PROCESS | 6482 | |3;mootools.html;1300.2198680791525;1318.498970391251;1321.1478596305383;1327.0378975242947;1327.9402426890788;6389.776357827477;6628.933710662892;6846.726130954762;7225.277472252772;7235.421166306696;6869.690863911123;6995.440364770819;7006.194287656921;7295.562266264014;7304.926950730491;2137.3801597536735;2168.165256376291;2170.902309396073;2172.9891350543226;2174.662927246279;2070.1201989154547;2106.5049713317358;2139.101577337522;2145.367116700569;2162.37291185556;2125.0968338456173;2150.849440539163;2151.290074275493;2154.806067453929;2154.8168405685537;2045.1103769860083;2058.5162486815584;2060.5157787919825;2060.8763474191596;2062.504998800292;2084.72898523191;2086.54096098858;2105.0948092320295;2108.736407949006;2109.789021097893;7136.607486588236;7152;7235.095613048369;7243.674034668453;7266.4550158737775;4387.341898715218;4495.865124046284;4497.64018878489;4498.482674492409;4511.70673906195;2673.3717576369536;2849.971500285012;2874.6119273898175;2913.8106023108644;2920;1104.9889501105047;1106.363840791548;1106.6458733205377;1119.8219463144187;1157.39236900627;9317.534123293808;9324.160825525667;9349.48577828226;9365.625374984993;9368.110029547182;3624.0939765058733;3770.377887648562;3825.0437390652337;3872.4772155759174;3884;7546.2831031051965;7554.206808285161;7618.238176182337;7621.618919054025;7650.349720273728;4288.335308027261;4296.935545966813;4315.438992930962;4321.395004699345;4331.047169622678;3940.4680368150507;3977.582353852804;4106.137711080706;4106.1582375612925;4118.176364727066;3057;3113;3170.4134735074085;3177.126290270148;3206.278587317835;918.1874041473344;920.4845286639503;934.4393363981557;940.5532372123323;1014.0771897573173;663.6792782363062;669.9832504187336;680.9285025072296;681.5910453727723;687.1204857782047;4586.289125185602;4835.685680430761;4868.488808675038;4911.9754401227765;5048.72232027242;852.7100785732756;863.7408777366765;872.7512658892185;890.0031964200008;909.1499448016126;3185.474396724561;3201.839908004637;3211.5022171563446;3286.5234540991423;3322.833858307123;8264.256216940505;8589.656413743505;8601.784955376166;8603.870941935877;8613.353998450142;8551.486910785372;8551.657933682707;8554.443961142506;8555.572221388906;8564.3148548116;6592.340765923369;6721.630310332881;6724.159480064992;6726.529142960044;6742.089817874622;4408;4512.255477846119;4527.162474942146;4535.954640453553;4596.506135505907;7486.887696684663;7590.962045189739;7614.086309642878;7682.0397450318715;7690.038745156856;7752.4573279869865;7756.991591093122;7900.920990790019;7921.722739704082;8100.432969692065;5839.065749480063;5859.824205273849;5884.411558844081;5887.882242355215;5935.228420305332;6562.343765623399;6730.798076057726;6755.1556055493065;6788.456923446014;6804.523683342317;6001.2498437695285;6062.151298818081;6264.31092579825;6346.841328966812;6446.226452825691;5825.563082768725;5882.029465138205;5900.085486749561;5902.911456328073;5928.614640048383;5043.823466178666;5155.613329000415;5164.7417629119145;5175.327207463006;5195.532402083831;3969.9206015878945;4046.656034237005;4095.549489556206;4095.651869591118;4209.810558524812;4094.2630326541507;4183.53981062089;4195.643370313557;4219.641330486943;4277.550857160078 16:09:51 INFO - PROCESS | 6482 | |4;prototype.html;337.4802803682329;339.4568690095847;340.7376320233422;342.6727475261126;348.20609011453877;4899.755012249387;4947.233178857274;4956.553910148086;4966.726830024347;4980.178270585349;4808.97595512022;4871.926921096187;4910;4920.557149856512;4931.950680493194;3696.4085746280603;3796.411556208778;3853.190829925719;3929.0963078491964;3948.7038472114564;3926.391409331558;3937.5865534118934;3949.3878448840474;3951.7431366961055;3954.4661470701517;3911.256861196378;3935.232629637222;3936.665383442411;3937.232239713257;3966.7024973126986;3585.623509531488;3704.870014645532;3941;3949.9802500987453;3968.226195891802;3290.7531935104726;3294.341131773631;3300.290437555913;3306.8095485625154;3319.4191016572004;4708.623310135215;4751.738654374008;4770.211170810946;4800.759962001886;4816.759162041884;4332.566743325674;4334.653227741773;4337.934930976038;4349.217140914634;4351.717138385995;4980.277859710358;5037.665018770029;5047.268146118792;5080.796768129308;5124.052050370693;3553.3959226931483;3553.4314509678584;3555.6310820334356;3570.6786389224835;3577.284543091392;5304.310439642861;5327.866803329909;5374.264885904259;5382.2464854920345;5384.680753215487;3640.7815531068222;3696.131409118855;3710.981445092811;3727.8751111865977;3738.1776009277914;3757.887263382103;3777.1690228149764;3778.527684039495;3779.3575092234387;3793.525809273841;4293.227219100592;4301.290287102593;4302.719558633929;4305.375720520507;4325.015739140046;4877.585500204901;5119.232115182678;5124.821291103067;5165.638405311592;5167.431582525919;1252.9248245105323;1268.9111762176558;1271.1610337177603;1272.4210484229654;1276.304414094321;830.8504469195482;859.0636206534782;865.8441480533564;866.4541338956417;889.7241855024963;4484.865454036384;4548.818047278138;4569.383133276965;4582.679212455096;4591.44902611682;5337.226102215157;5337.786488540492;5338.813141540028;5339.973300133553;5357.812476563302;4584.862454126382;4587.3807036050375;4592.977035114803;4593.47175074864;4598.402207712976;2618.764311212;2715.6876959149554;2738.7398197171237;2747.3543717226435;2763.6545431821023;4887.804487820518;4901.264810278415;4901.3383193268455;4916.606671466274;4933.679310844784;5099.949000509948;5305.44292849253;5306.124489459273;5316.441773613792;5355.303810504687;4993.775280112403;4995.600351971761;5005.824796132118;5009.674371165863;5011.298418221452;5322.41453440129;5331.760070796746;5339.3859706132735;5341.866453338542;5351.545118664957;4967.677100988424;5179.834537229244;5236.769359200509;5237.659552129099;5243.161094224905;5009.824656137018;5016.247562865599;5017.724025178504;5020.648554601143;5040.470750571138;3671.853125874935;3715.554133503889;3724.776513409204;3730.403135498307;3733.981330093332;5102.36220472441;5245.580353571781;5286.577073834161;5355.196720491957;5386.730663466889;5123.92314115296;5127.897442051213;5141.611764823551;5146.099432599355;5148.176291793295;5097.566706829961;5146.305248791366;5163.535281824654;5168.508991645787;5181.870453238699;4965.3296804932315;4991.450940396481;5026.421961474331;5056.342675452168;5074.213496907985;4951.257311403318;5155.587552995677;5168.328117344721;5200.725822173592;5203.453637368173;5034.471380505141;5040.6723562969755;5054.545090941833;5083.237514372726;5086.160783470686 16:09:51 INFO - PROCESS | 6482 | |5;yui.html;680.6460640466961;697.2852825853499;736.9424875303939;757.8294883651178;776.099724319789;11889.881101188985;12773.744525109492;12907.741845163102;14421.63945901353;15350.616234594141;14635.926820365883;14942.775858362105;14947.551573452787;15356.385744570232;15385.307661155246;800.9599520024004;828.5070383122032;829.9751007469755;829.9875501867476;832.6169961817541;676.2966514824576;696.5959743348845;790.3005839831733;821.1501096365263;821.765796747927;862.9525376104311;865.8008658008662;866.3978534918234;866.4714524140269;866.6143566113083;855.247382303572;855.670566831768;856.2550580994513;856.2850020233113;857.0272740439584;630.4767043354005;631.7851930343659;631.8136149835809;632.0298342044939;632.1213513216633;13510.459581616724;13741.312934353342;13780.655483612889;13811.792823107662;13885.166889986633;11354.602588909349;11765.823512647317;11789.94105029478;11975.341356225405;12039.337836418994;10383.325083869524;10408.167346612328;10431.269811113225;10496.737581560446;10568.735781605445;3259.771815972883;3267.9346413071844;3317.668233176687;3323.966760332414;3424.708899743525;62305.06542401868;63415.36584634141;63621.68189159025;64392.678036609985;64601.35398646;9446.622135114656;9569.425834449956;9572.76068098303;9684.757881052888;9784.266180036526;18257.81742182588;18322.175502102436;18343.266269349344;18348.266069357076;18351.90824045898;6597.703103360361;6659.533832631766;6722.6302553359055;6879.208890977602;6944.201416837027;3499.5975462821593;3658.359787037258;3683.3001729671278;3738.476613274144;3759.7180211484247;2942.279141610319;3031.7574594032426;3038.7872848900365;3049.1005153479778;3075.2158199659393;515.6622412319937;521.1791428500128;521.8643152780304;523.1551045062273;535.2827211536481;587.1574290892582;632.1087266953573;635.3805040085879;645.9870802583922;656.7865443730807;7869.645865936047;8107.22981316774;8115.472494287852;8377.204165604258;8480.915190848136;603.8611119442553;603.9969800151059;609.2871340531589;614.9292831324366;622.3154530016946;3638.326909521747;3936.15372694872;3955.3473676843573;3955.8219880105466;4014.217227640582;65371.34628653653;65511.67244163844;66369.66815165893;66933.66533167304;66984;53919.19121213185;55670.72164639151;57034;57321;60280.09579856306;51449.48550514522;51517.484825152016;51935.48064519382;51974.74012629988;52758.20862686986;7620.085589729268;7635.809104772425;7642.65608047628;7670.309672129535;7865.4494185406475;35569.82215089011;35710.10724731799;36769.63230367769;37167.728047804965;38784.6121538781;42647.57352426436;45772.78501507015;47761.28358074701;47803.28295075646;48300.758496207294;9531.76170595713;9785.026679680272;9965.850512242467;10005.949375315487;10161.745956351151;11221.887781122085;11266;11626.825597615873;11883.287002779862;11949.2830430171;10089.19286457067;10231.590736370461;10637.414942178255;10641.095506882002;10662;10687.786244275227;10715.35707857531;11202.66392008241;11211.327320360804;11225.49485273181;10129.290949633454;10158.44128572906;10434.634787782696;10692.732681683021;10698.518566664363;8472.406931514735;8600.870986935075;8616.655333786579;8796.648134074565;8916.821663566821;8326.875096873673;8627.137286271323;8807.075257097913;8986.101389860962;9007.459552426875 16:09:51 INFO - PROCESS | 6482 | __end_tp_report 16:09:51 INFO - PROCESS | 6482 | __start_cc_report 16:09:51 INFO - PROCESS | 6482 | _x_x_mozilla_cycle_collect,335 16:09:51 INFO - PROCESS | 6482 | __end_cc_report 16:09:51 INFO - PROCESS | 6482 | __startTimestamp1483056591598__endTimestamp 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | ------- Summary: start ------- 16:09:51 INFO - PROCESS | 6482 | Number of tests: 6 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | [#0] dojo.html Cycles:165 Average:4704.47 Median:4851.98 stddev:497.46 (10.3%) stddev-sans-first:471.01 16:09:51 INFO - PROCESS | 6482 | Values: 2607.8 2610.3 2628.0 2649.7 2658.1 4701.3 4780.7 4788.6 4790.1 4855.4 4698.9 4729.1 4729.2 4747.9 4793.0 4322.2 4343.4 4369.4 4445.9 4452.6 4084.1 4494.0 4523.5 4544.5 4552.7 4284.0 4440.7 4445.4 4474.2 4553.9 4286.4 4355.4 4386.7 4408.5 4504.6 4360.1 4363.1 4399.1 4413.0 4426.6 4745.0 4762.8 4790.9 4834.4 4853.2 4962.4 5006.5 5068.3 5117.6 5118.5 5123.6 5174.6 5185.2 5191.6 5212.7 4836.7 4860.0 4861.9 4864.7 4907.5 5066.4 5116.8 5147.3 5152.0 5257.3 5011.0 5012.6 5015.4 5031.4 5069.3 5031.8 5062.4 5084.1 5091.9 5118.5 4885.2 4922.1 4972.0 5016.4 5024.4 5009.2 5014.9 5016.2 5045.2 5080.2 4194.8 4204.2 4206.1 4236.9 4240.5 3669.1 3669.5 3688.5 3688.6 3691.6 4443.5 4456.1 4473.2 4476.9 4493.2 5060.5 5084.5 5121.9 5128.0 5141.2 4391.8 4399.1 4437.4 4457.4 4479.0 4519.3 4552.3 4555.8 4573.1 4591.3 4792.3 4802.2 4806.3 4837.1 4849.1 4972.4 5018.2 5151.7 5156.9 5186.8 4736.1 4747.8 4753.8 4769.7 4837.5 4992.0 5007.3 5011.4 5014.7 5048.8 4962.9 5082.9 5086.2 5103.6 5170.1 4852.0 4941.7 4967.7 4969.8 5051.1 4983.0 4985.9 4987.8 4989.4 5033.6 4756.1 4798.9 4801.9 4895.6 4937.8 4940.4 4946.1 4948.2 4965.4 4966.5 4875.5 4886.0 4904.2 4944.3 4951.0 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | [#1] ext.html Cycles:180 Average:44476.20 Median:36504.63 stddev:76929.44 (210.7%) stddev-sans-first:77074.40 16:09:51 INFO - PROCESS | 6482 | Values: 503.7 504.9 526.3 526.7 537.4 36679.3 38941.2 39109.6 39255.0 41802.3 39335.4 39556.2 39809.6 39861.0 39875.4 7735.4 7870.9 7895.0 7910.5 9633.4 9439.6 9757.7 9872.3 9880.4 9897.8 9873.8 9910.6 9914.0 9914.9 9928.6 9811.6 9895.3 9901.3 9904.5 9912.5 9705.5 9757.3 9771.5 9773.1 9788.8 33386.3 33555.3 33838.7 33908.8 33917.5 3421.9 3445.7 3473.9 3481.1 3488.9 25105.5 25628.2 25687.4 25767.6 25772.1 2948.8 3091.5 3128.1 3191.2 3199.6 225318.0 225897.0 226239.0 226265.9 226474.0 45857.8 45902.8 46105.8 46145.8 46264.0 47903.8 47918.3 47918.3 47936.3 48007.0 13258.3 13402.9 13407.7 13408.4 13459.1 9182.6 9400.0 10426.9 10570.2 10664.6 15350.3 15540.6 15567.9 15681.6 15692.4 6452.7 6456.9 6537.6 6550.7 6570.4 804.2 808.9 819.8 827.0 840.5 26467.7 27368.7 27724.3 28039.9 28151.9 959.3 960.8 992.5 995.3 1060.1 13741.7 14501.9 14655.5 14788.9 14863.8 255642.0 332055.0 334793.0 335710.0 336102.0 43100.0 43263.1 43552.6 43634.6 43746.6 1189.0 1222.6 1248.1 1249.0 1250.3 24314.8 24823.6 27542.6 28418.0 28979.0 40868.0 41794.2 41796.0 41893.2 41965.2 321272.0 323503.0 325028.0 325121.0 325496.0 30510.0 32908.5 33343.5 33353.0 33669.3 41875.6 42083.6 42433.8 42469.8 43037.8 36577.6 36745.3 37943.2 38129.4 38780.8 36425.0 36431.6 36695.8 37063.6 37154.9 34990.5 35195.5 35913.6 35931.6 35952.6 30968.7 32025.5 32925.7 33174.3 33248.3 24974.6 25022.4 25110.2 25476.4 25576.0 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | [#2] jquery.html Cycles:180 Average:21295.40 Median:5186.55 stddev:53811.50 (1037.5%) stddev-sans-first:53939.52 16:09:51 INFO - PROCESS | 6482 | Values: 371.7 378.4 379.3 388.6 393.0 15370.0 16018.5 16605.9 16740.9 16749.3 13035.5 14319.3 16730.3 16914.7 16963.1 4519.2 4755.6 4758.2 4759.0 4764.9 3642.3 3810.9 4691.4 5195.5 5440.5 5448.5 5454.7 5455.4 5456.3 5465.8 5210.7 5297.5 5332.8 5347.2 5445.9 5178.1 5178.3 5179.8 5193.2 5199.6 13950.9 14341.0 20009.6 20295.9 20300.6 2131.5 2177.4 2179.2 2211.1 2251.8 8514.5 8784.8 9075.1 9109.2 9327.1 1666.1 1707.9 1709.9 1741.1 1747.4 48529.8 58440.0 58848.7 60309.1 62884.7 9726.3 9828.2 9929.7 10139.9 10186.4 13682.3 13684.3 13687.3 13689.0 13694.2 6948.8 7203.5 7245.2 7259.9 7294.4 6605.7 6656.7 6816.5 6862.9 6932.3 4025.2 4029.5 4186.7 4285.0 4388.4 1489.0 1571.0 1791.8 1868.9 1877.8 760.3 788.0 788.0 790.5 792.8 15435.6 15628.4 16032.0 16197.3 16200.8 789.9 794.7 801.3 803.7 815.7 8909.3 8969.8 9097.9 9151.7 9202.4 322177.0 323123.0 325707.0 327655.0 328003.0 69450.3 69630.7 70461.6 70608.6 71991.3 892.8 905.1 922.8 928.6 947.3 14722.2 14761.3 15049.4 15074.7 15579.8 31970.4 33990.7 34081.3 35246.8 35855.5 39413.4 44660.6 46079.5 49170.3 49348.0 6399.4 6739.8 6835.8 6938.6 6965.5 7055.7 9407.9 10256.1 11465.8 11717.9 5351.3 5842.6 8672.6 9540.0 9564.3 9890.0 10048.7 10335.1 10485.2 10875.6 5475.7 5615.0 7873.6 9543.6 9881.3 7233.9 7278.3 7301.9 7359.2 7493.8 7200.8 8837.2 9590.8 9727.7 9842.3 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | [#3] mootools.html Cycles:180 Average:4619.73 Median:5046.27 stddev:2484.54 (49.2%) stddev-sans-first:2478.99 16:09:51 INFO - PROCESS | 6482 | Values: 1300.2 1318.5 1321.1 1327.0 1327.9 6389.8 6628.9 6846.7 7225.3 7235.4 6869.7 6995.4 7006.2 7295.6 7304.9 2137.4 2168.2 2170.9 2173.0 2174.7 2070.1 2106.5 2139.1 2145.4 2162.4 2125.1 2150.8 2151.3 2154.8 2154.8 2045.1 2058.5 2060.5 2060.9 2062.5 2084.7 2086.5 2105.1 2108.7 2109.8 7136.6 7152.0 7235.1 7243.7 7266.5 4387.3 4495.9 4497.6 4498.5 4511.7 2673.4 2850.0 2874.6 2913.8 2920.0 1105.0 1106.4 1106.6 1119.8 1157.4 9317.5 9324.2 9349.5 9365.6 9368.1 3624.1 3770.4 3825.0 3872.5 3884.0 7546.3 7554.2 7618.2 7621.6 7650.3 4288.3 4296.9 4315.4 4321.4 4331.0 3940.5 3977.6 4106.1 4106.2 4118.2 3057.0 3113.0 3170.4 3177.1 3206.3 918.2 920.5 934.4 940.6 1014.1 663.7 670.0 680.9 681.6 687.1 4586.3 4835.7 4868.5 4912.0 5048.7 852.7 863.7 872.8 890.0 909.1 3185.5 3201.8 3211.5 3286.5 3322.8 8264.3 8589.7 8601.8 8603.9 8613.4 8551.5 8551.7 8554.4 8555.6 8564.3 6592.3 6721.6 6724.2 6726.5 6742.1 4408.0 4512.3 4527.2 4536.0 4596.5 7486.9 7591.0 7614.1 7682.0 7690.0 7752.5 7757.0 7900.9 7921.7 8100.4 5839.1 5859.8 5884.4 5887.9 5935.2 6562.3 6730.8 6755.2 6788.5 6804.5 6001.2 6062.2 6264.3 6346.8 6446.2 5825.6 5882.0 5900.1 5902.9 5928.6 5043.8 5155.6 5164.7 5175.3 5195.5 3969.9 4046.7 4095.5 4095.7 4209.8 4094.3 4183.5 4195.6 4219.6 4277.6 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | [#4] prototype.html Cycles:180 Average:4265.31 Median:4901.30 stddev:1243.14 (25.4%) stddev-sans-first:1211.16 16:09:51 INFO - PROCESS | 6482 | Values: 337.5 339.5 340.7 342.7 348.2 4899.8 4947.2 4956.6 4966.7 4980.2 4809.0 4871.9 4910.0 4920.6 4932.0 3696.4 3796.4 3853.2 3929.1 3948.7 3926.4 3937.6 3949.4 3951.7 3954.5 3911.3 3935.2 3936.7 3937.2 3966.7 3585.6 3704.9 3941.0 3950.0 3968.2 3290.8 3294.3 3300.3 3306.8 3319.4 4708.6 4751.7 4770.2 4800.8 4816.8 4332.6 4334.7 4337.9 4349.2 4351.7 4980.3 5037.7 5047.3 5080.8 5124.1 3553.4 3553.4 3555.6 3570.7 3577.3 5304.3 5327.9 5374.3 5382.2 5384.7 3640.8 3696.1 3711.0 3727.9 3738.2 3757.9 3777.2 3778.5 3779.4 3793.5 4293.2 4301.3 4302.7 4305.4 4325.0 4877.6 5119.2 5124.8 5165.6 5167.4 1252.9 1268.9 1271.2 1272.4 1276.3 830.9 859.1 865.8 866.5 889.7 4484.9 4548.8 4569.4 4582.7 4591.4 5337.2 5337.8 5338.8 5340.0 5357.8 4584.9 4587.4 4593.0 4593.5 4598.4 2618.8 2715.7 2738.7 2747.4 2763.7 4887.8 4901.3 4901.3 4916.6 4933.7 5099.9 5305.4 5306.1 5316.4 5355.3 4993.8 4995.6 5005.8 5009.7 5011.3 5322.4 5331.8 5339.4 5341.9 5351.5 4967.7 5179.8 5236.8 5237.7 5243.2 5009.8 5016.2 5017.7 5020.6 5040.5 3671.9 3715.6 3724.8 3730.4 3734.0 5102.4 5245.6 5286.6 5355.2 5386.7 5123.9 5127.9 5141.6 5146.1 5148.2 5097.6 5146.3 5163.5 5168.5 5181.9 4965.3 4991.5 5026.4 5056.3 5074.2 4951.3 5155.6 5168.3 5200.7 5203.5 5034.5 5040.7 5054.5 5083.2 5086.2 16:09:51 INFO - PROCESS | 6482 | 16:09:51 INFO - PROCESS | 6482 | [#5] yui.html Cycles:180 Average:14671.08 Median:26646.75 stddev:18586.80 (69.8%) stddev-sans-first:18609.25 16:09:51 INFO - PROCESS | 6482 | Values: 680.6 697.3 736.9 757.8 776.1 11889.9 12773.7 12907.7 14421.6 15350.6 14635.9 14942.8 14947.6 15356.4 15385.3 801.0 828.5 830.0 830.0 832.6 676.3 696.6 790.3 821.2 821.8 863.0 865.8 866.4 866.5 866.6 855.2 855.7 856.3 856.3 857.0 630.5 631.8 631.8 632.0 632.1 13510.5 13741.3 13780.7 13811.8 13885.2 11354.6 11765.8 11789.9 11975.3 12039.3 10383.3 10408.2 10431.3 10496.7 10568.7 3259.8 3267.9 3317.7 3324.0 3424.7 62305.1 63415.4 63621.7 64392.7 64601.4 9446.6 9569.4 9572.8 9684.8 9784.3 18257.8 18322.2 18343.3 18348.3 18351.9 6597.7 6659.5 6722.6 6879.2 6944.2 3499.6 3658.4 3683.3 3738.5 3759.7 2942.3 3031.8 3038.8 3049.1 3075.2 515.7 521.2 521.9 523.2 535.3 587.2 632.1 635.4 646.0 656.8 7869.6 8107.2 8115.5 8377.2 8480.9 603.9 604.0 609.3 614.9 622.3 3638.3 3936.2 3955.3 3955.8 4014.2 65371.3 65511.7 66369.7 66933.7 66984.0 53919.2 55670.7 57034.0 57321.0 60280.1 51449.5 51517.5 51935.5 51974.7 52758.2 7620.1 7635.8 7642.7 7670.3 7865.4 35569.8 35710.1 36769.6 37167.7 38784.6 42647.6 45772.8 47761.3 47803.3 48300.8 9531.8 9785.0 9965.9 10005.9 10161.7 11221.9 11266.0 11626.8 11883.3 11949.3 10089.2 10231.6 10637.4 10641.1 10662.0 10687.8 10715.4 11202.7 11211.3 11225.5 10129.3 10158.4 10434.6 10692.7 10698.5 8472.4 8600.9 8616.7 8796.6 8916.8 8326.9 8627.1 8807.1 8986.1 9007.5 16:09:51 INFO - PROCESS | 6482 | -------- Summary: end -------- 16:09:51 INFO - PROCESS | 6482 | 16:09:52 INFO - TEST-INFO | 6482: exit 0 16:09:52 INFO - TEST-OK | dromaeo_css | took 1118999ms 16:09:52 INFO - TEST-START | kraken 16:09:52 INFO - operating with platform_type : linux_ 16:09:52 INFO - Initialising browser for kraken test... 16:09:52 INFO - TEST-INFO | started process 6828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3O1Us9/profile http://localhost:59251/getInfo.html) 16:09:52 INFO - PROCESS | 6828 | 1483056592908 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 16:09:56 INFO - PROCESS | 6828 | __metrics Screen width/height:1600/1200 16:09:56 INFO - PROCESS | 6828 | colorDepth:24 16:09:56 INFO - PROCESS | 6828 | Browser inner width/height: 1024/697 16:09:56 INFO - PROCESS | 6828 | __metrics 16:09:57 ERROR - PROCESS | 6828 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 16:09:58 INFO - TEST-INFO | 6828: exit 0 16:09:58 INFO - Browser initialized. 16:09:58 INFO - Running cycle 1/1 for kraken test... 16:09:58 INFO - TEST-INFO | started process 6948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3O1Us9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:10 INFO - PROCESS | 6948 | RSS: Main: 158138368 16:10:10 INFO - PROCESS | 6948 | 16:10:13 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:14 INFO - PROCESS | 6948 | RSS: Main: 163688448 16:10:14 INFO - PROCESS | 6948 | 16:10:16 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-dft) 16:10:17 INFO - PROCESS | 6948 | RSS: Main: 162115584 16:10:17 INFO - PROCESS | 6948 | 16:10:20 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-fft) 16:10:20 INFO - PROCESS | 6948 | RSS: Main: 159698944 16:10:20 INFO - PROCESS | 6948 | 16:10:23 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59251/tests/kraken/driver.html?testName=audio-oscillator) 16:10:23 INFO - PROCESS | 6948 | RSS: Main: 159641600 16:10:23 INFO - PROCESS | 6948 | 16:10:25 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:26 INFO - PROCESS | 6948 | RSS: Main: 160227328 16:10:26 INFO - PROCESS | 6948 | 16:10:29 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59251/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:30 INFO - PROCESS | 6948 | RSS: Main: 164200448 16:10:30 INFO - PROCESS | 6948 | 16:10:33 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59251/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:34 INFO - PROCESS | 6948 | RSS: Main: 161914880 16:10:34 INFO - PROCESS | 6948 | 16:10:37 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59251/tests/kraken/driver.html?testName=json-parse-financial) 16:10:37 INFO - PROCESS | 6948 | RSS: Main: 162988032 16:10:37 INFO - PROCESS | 6948 | 16:10:39 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:40 INFO - PROCESS | 6948 | RSS: Main: 162816000 16:10:40 INFO - PROCESS | 6948 | 16:10:42 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:42 INFO - PROCESS | 6948 | RSS: Main: 162590720 16:10:42 INFO - PROCESS | 6948 | 16:10:45 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:45 INFO - PROCESS | 6948 | RSS: Main: 163348480 16:10:45 INFO - PROCESS | 6948 | 16:10:48 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:49 INFO - PROCESS | 6948 | RSS: Main: 163799040 16:10:49 INFO - PROCESS | 6948 | 16:10:52 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:53 INFO - PROCESS | 6948 | RSS: Main: 163532800 16:10:53 INFO - PROCESS | 6948 | 16:10:54 INFO - PROCESS | 6948 | Cycle 1(1): loaded http://localhost:59251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59251/tests/kraken/driver.html?testName=ai-astar) 16:10:55 INFO - PROCESS | 6948 | RSS: Main: 165330944 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | __start_tp_report 16:10:55 INFO - PROCESS | 6948 | _x_x_mozilla_page_load 16:10:55 INFO - PROCESS | 6948 | _x_x_mozilla_page_load_details 16:10:55 INFO - PROCESS | 6948 | |i|pagename|runs| 16:10:55 INFO - PROCESS | 6948 | |0;ai-astar;109;116;118;117;116;117;119;115;116;116 16:10:55 INFO - PROCESS | 6948 | |1;audio-beat-detection;158;128;127;182;132;129;130;134;156;133 16:10:55 INFO - PROCESS | 6948 | |2;audio-dft;164;162;168;169;163;165;163;165;163;166 16:10:55 INFO - PROCESS | 6948 | |3;audio-fft;76;77;77;118;78;79;78;77;98;77 16:10:55 INFO - PROCESS | 6948 | |4;audio-oscillator;86;85;102;87;86;90;103;88;87;110 16:10:55 INFO - PROCESS | 6948 | |5;imaging-gaussian-blur;118;118;118;118;117;124;118;118;118;119 16:10:55 INFO - PROCESS | 6948 | |6;imaging-darkroom;151;152;150;150;151;151;151;150;151;151 16:10:55 INFO - PROCESS | 6948 | |7;imaging-desaturate;96;96;96;95;96;95;97;96;96;96 16:10:55 INFO - PROCESS | 6948 | |8;json-parse-financial;72;71;71;71;72;72;72;71;72;73 16:10:55 INFO - PROCESS | 6948 | |9;json-stringify-tinderbox;68;69;68;68;68;68;67;68;68;68 16:10:55 INFO - PROCESS | 6948 | |10;stanford-crypto-aes;86;87;91;95;86;87;86;85;89;84 16:10:55 INFO - PROCESS | 6948 | |11;stanford-crypto-ccm;142;143;136;138;136;135;145;137;181;138 16:10:55 INFO - PROCESS | 6948 | |12;stanford-crypto-pbkdf2;176;188;181;185;179;180;181;179;178;176 16:10:55 INFO - PROCESS | 6948 | |13;stanford-crypto-sha256-iterative;69;71;69;74;68;69;69;69;67;68 16:10:55 INFO - PROCESS | 6948 | __end_tp_report 16:10:55 INFO - PROCESS | 6948 | __start_cc_report 16:10:55 INFO - PROCESS | 6948 | _x_x_mozilla_cycle_collect,789 16:10:55 INFO - PROCESS | 6948 | __end_cc_report 16:10:55 INFO - PROCESS | 6948 | __startTimestamp1483056655152__endTimestamp 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | ------- Summary: start ------- 16:10:55 INFO - PROCESS | 6948 | Number of tests: 14 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:2.69 (2.3%) stddev-sans-first:1.22 16:10:55 INFO - PROCESS | 6948 | Values: 109.0 116.0 118.0 117.0 116.0 117.0 119.0 115.0 116.0 116.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:133.50 stddev:18.31 (13.7%) stddev-sans-first:18.35 16:10:55 INFO - PROCESS | 6948 | Values: 158.0 128.0 127.0 182.0 132.0 129.0 130.0 134.0 156.0 133.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.30 (1.4%) stddev-sans-first:2.42 16:10:55 INFO - PROCESS | 6948 | Values: 164.0 162.0 168.0 169.0 163.0 165.0 163.0 165.0 163.0 166.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.50 stddev:13.77 (17.8%) stddev-sans-first:14.34 16:10:55 INFO - PROCESS | 6948 | Values: 76.0 77.0 77.0 118.0 78.0 79.0 78.0 77.0 98.0 77.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:86.50 stddev:9.03 (10.4%) stddev-sans-first:9.28 16:10:55 INFO - PROCESS | 6948 | Values: 86.0 85.0 102.0 87.0 86.0 90.0 103.0 88.0 87.0 110.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:1.96 (1.7%) stddev-sans-first:2.06 16:10:55 INFO - PROCESS | 6948 | Values: 118.0 118.0 118.0 118.0 117.0 124.0 118.0 118.0 118.0 119.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:10:55 INFO - PROCESS | 6948 | Values: 151.0 152.0 150.0 150.0 151.0 151.0 151.0 150.0 151.0 151.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:10:55 INFO - PROCESS | 6948 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 96.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:72.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 16:10:55 INFO - PROCESS | 6948 | Values: 72.0 71.0 71.0 71.0 72.0 72.0 72.0 71.0 72.0 73.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 16:10:55 INFO - PROCESS | 6948 | Values: 68.0 69.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 68.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.00 stddev:3.27 (3.8%) stddev-sans-first:3.42 16:10:55 INFO - PROCESS | 6948 | Values: 86.0 87.0 91.0 95.0 86.0 87.0 86.0 85.0 89.0 84.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.00 stddev:13.73 (9.8%) stddev-sans-first:14.56 16:10:55 INFO - PROCESS | 6948 | Values: 142.0 143.0 136.0 138.0 136.0 135.0 145.0 137.0 181.0 138.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:180.50 stddev:3.77 (2.1%) stddev-sans-first:3.67 16:10:55 INFO - PROCESS | 6948 | Values: 176.0 188.0 181.0 185.0 179.0 180.0 181.0 179.0 178.0 176.0 16:10:55 INFO - PROCESS | 6948 | 16:10:55 INFO - PROCESS | 6948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.95 (2.8%) stddev-sans-first:2.06 16:10:55 INFO - PROCESS | 6948 | Values: 69.0 71.0 69.0 74.0 68.0 69.0 69.0 69.0 67.0 68.0 16:10:55 INFO - PROCESS | 6948 | -------- Summary: end -------- 16:10:55 INFO - PROCESS | 6948 | 16:10:56 INFO - TEST-INFO | 6948: exit 0 16:10:56 INFO - TEST-OK | kraken | took 63889ms 16:10:56 INFO - SUITE-END | took 1182s 16:10:56 INFO - Completed test suite (00:19:42) 16:10:56 INFO - javascript benchmark 16:10:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6196.699230127613, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.7522635349637, 2610.2691246450995, 2627.9737202627994, 2649.655544779178, 2658.0696756135353, 4701.294805779135, 4780.713157210565, 4788.569028787409, 4790.089882922242, 4855.417349918015, 4698.882527936803, 4729.12511185431, 4729.2433210686295, 4747.857564273068, 4792.976035119819, 4322.178786030652, 4343.391925130469, 4369.366441865927, 4445.888852778674, 4452.621527170194, 4084.101497670508, 4493.9775301123445, 4523.5024147343765, 4544.454665440152, 4552.658550608701, 4284.0, 4440.711353762027, 4445.444319460067, 4474.217012022883, 4553.886152846188, 4286.442762440894, 4355.412019377375, 4386.71486353386, 4408.515063343029, 4504.572065653758, 4360.106178233455, 4363.061941682522, 4399.098184872094, 4413.029133590637, 4426.579474949906, 4744.952550474485, 4762.809487620491, 4790.928136077961, 4834.419869615634, 4853.247746599282, 4962.354893863775, 5006.5494105530315, 5068.315777370045, 5117.6161787865685, 5118.513741194581, 5123.590112791005, 5174.611904107207, 5185.170372740381, 5191.610629202825, 5212.713300768456, 4836.661433699607, 4859.975700121512, 4861.854144375674, 4864.6594738368685, 4907.460179380265, 5066.36670416198, 5116.795328186905, 5147.279380886679, 5151.97424012885, 5257.316548848702, 5010.974945125251, 5012.649114562018, 5015.448300686921, 5031.396232452129, 5069.290299358093, 5031.823886163967, 5062.367204099488, 5084.13569693153, 5091.949080509222, 5118.539331460186, 4885.242787367893, 4922.138625740481, 4972.030454061423, 5016.372953380827, 5024.397072351268, 5009.198528235464, 5014.949850501521, 5016.247562865599, 5045.217991211368, 5080.187170052774, 4194.769287689145, 4204.201201771653, 4206.137741762931, 4236.9364459533135, 4240.469941257343, 3669.082729317671, 3669.4679271505483, 3688.5204923359793, 3688.6495782900583, 3691.6492933171307, 4443.488998765119, 4456.108778244364, 4473.150101480708, 4476.9104617908115, 4493.191225579427, 5060.51925067118, 5084.46613105626, 5121.923171152435, 5128.0, 5141.228815677603, 4391.802368893407, 4399.098184872094, 4437.423134992495, 4457.375967364572, 4478.977605111953, 4519.254323036662, 4552.271636538138, 4555.817767289272, 4573.085382923428, 4591.265397536378, 4792.305115758265, 4802.183628783185, 4806.303086052572, 4837.05677392905, 4849.127157111683, 4972.378452693269, 5018.222175562793, 5151.6908985461, 5156.948430515647, 5186.818461353985, 4736.147493451074, 4747.83382581608, 4753.786079626356, 4769.689970151929, 4837.540433658797, 4992.0, 5007.273945277987, 5011.423686275979, 5014.749262536931, 5048.823291184791, 4962.925556116589, 5082.898342033065, 5086.160783470686, 5103.591712663052, 5170.121079416433, 4851.975740121276, 4941.703497790144, 4967.726775027409, 4969.776360063734, 5051.1160546904875, 4982.975085124551, 4985.900281994413, 4987.750612469289, 4989.426215985208, 5033.5721463676, 4756.143894099096, 4798.856034318976, 4801.879953001203, 4895.583875370491, 4937.8271760488215, 4940.431850337257, 4946.109700253989, 4948.183549714401, 4965.354503914468, 4966.528179822911, 4875.488073752205, 4886.022795440855, 4904.166291730343, 4944.283078953604, 4951.0], "value": 4672.141046544641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.66254609411715, 504.9141645920194, 526.3236740788087, 526.686621460231, 537.4249552978315, 36679.26641467172, 38941.22117557651, 39109.60890391095, 39255.0, 41802.327906883766, 39335.40996885049, 39556.20887582246, 39809.601903980954, 39861.0, 39875.40186897199, 7735.419843511731, 7870.881936770925, 7894.960525197394, 7910.525368477881, 9633.421994680342, 9439.575219115122, 9757.658481953133, 9872.308938374317, 9880.40717556949, 9897.75255618608, 9873.753156171117, 9910.55402506889, 9913.950430247838, 9914.900850991506, 9928.602855885756, 9811.607535698564, 9895.257855660819, 9901.25740569453, 9904.504774761304, 9912.504374781303, 9705.466199359033, 9757.316987810857, 9771.462569558671, 9773.12041916231, 9788.755281117958, 33386.33227335464, 33555.32889342224, 33838.661613383796, 33908.83045584781, 33917.491237631206, 3421.863125474978, 3445.6554344565593, 3473.94789078164, 3481.0775144586705, 3488.9127771805656, 25105.49789004228, 25628.23115306525, 25687.357816054748, 25767.613485797727, 25772.097976570916, 2948.82307061577, 3091.458994675945, 3128.124125244935, 3191.2181515528846, 3199.6480387157394, 225318.0, 225897.0, 226239.0, 226265.86867065725, 226474.0, 45857.77071114623, 45902.770486147354, 46105.76947115243, 46145.76927115343, 46264.0, 47903.76048119807, 47918.28122578164, 47918.28122578164, 47936.28095578569, 48007.0, 13258.337083145803, 13402.865971340358, 13407.664808379674, 13408.396622152026, 13459.057865949486, 9182.586783594754, 9399.953000235091, 10426.947865260625, 10570.207234457446, 10664.573417063231, 15350.309236084404, 15540.611484712972, 15567.922160389126, 15681.607959801097, 15692.372305107896, 6452.709628066748, 6456.870047741627, 6537.5750576212395, 6550.672466376662, 6570.441512471493, 804.2279411764655, 808.8503626829056, 819.774561995456, 826.9958650206711, 840.5041025794688, 26467.735322646527, 27368.726312736617, 27724.30689232745, 28039.859800700866, 28151.859240703667, 959.318883592657, 960.7646126699003, 992.503748125937, 995.2585323933715, 1060.1095080132725, 13741.656458588415, 14501.854981450262, 14655.48705795292, 14788.926055369655, 14863.777043344358, 255642.0, 332055.0, 334793.0, 335710.0, 336102.0, 43100.0, 43263.13473730508, 43552.56447435485, 43634.56365436369, 43746.56253437425, 1188.9524419023314, 1222.5986448784306, 1248.126311581878, 1248.9812652810215, 1250.2560976219136, 24314.75685243125, 24823.627645585693, 27542.5868611975, 28418.0, 28979.0, 40868.0, 41794.1641167181, 41796.0, 41893.1621367577, 41965.1606967865, 321272.0, 323503.0, 325028.0, 325121.0, 325496.0, 30510.0, 32908.50637240491, 33343.49984750182, 33353.0, 33669.32661346808, 41875.58124418717, 42083.579164207964, 42433.78783106065, 42469.78765106278, 43037.78481107575, 36577.63422365742, 36745.265094697425, 37943.2411351777, 38129.42805857859, 38780.80609597047, 36425.0, 36431.62820461456, 36695.81652091829, 37063.6293637071, 37154.876939833535, 34990.47514287339, 35195.472067919516, 35913.640863592074, 35931.640683593876, 35952.64047359493, 30968.690313097482, 32025.519617206228, 32925.670743293216, 33174.336513270086, 33248.33503329872, 24974.62538061894, 25022.37444063913, 25110.246692599252, 25476.363090922136, 25576.0], "value": 17386.298627062624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.6970668904844, 378.37001392681196, 379.32290860813447, 388.570629454453, 393.04686136119903, 15370.0, 16018.519444416657, 16605.916970415146, 16740.916295418538, 16749.330026798914, 13035.478580856754, 14319.284035798195, 16730.330786768514, 16914.74627880583, 16963.067031313272, 4519.186546421643, 4755.619550435957, 4758.167320718878, 4758.952410475903, 4764.85705428836, 3642.344378011957, 3810.9237815243678, 4691.413573303337, 5195.532402083812, 5440.537554307889, 5448.536874365664, 5454.7272636368225, 5455.399906010336, 5456.290682211326, 5465.836024919259, 5210.713410762407, 5297.496737809902, 5332.786688532454, 5347.171188465794, 5445.891082178354, 5178.119719647631, 5178.300929374562, 5179.844604661828, 5193.246979188034, 5199.610029247784, 13950.860491395058, 14340.996130270885, 20009.599808003757, 20295.89852050745, 20300.593988120156, 2131.467133216696, 2177.368563116694, 2179.2154824263253, 2211.0824008036648, 2251.819854411643, 8514.485514485514, 8784.780380490474, 9075.13786190311, 9109.18017378439, 9327.067293270686, 1666.125284225779, 1707.8548323392527, 1709.880308378414, 1741.1381366223673, 1747.432084572519, 48529.75735121302, 58440.0, 58848.70575647095, 60309.09536356914, 62884.68557657228, 9726.319157658896, 9828.230918434607, 9929.65246216379, 10139.898601013896, 10186.388816671024, 13682.31588420575, 13684.31578421075, 13687.31563421825, 13689.0, 13694.178349299074, 6948.791536253921, 7203.494520047075, 7245.239249878792, 7259.89110163348, 7294.416446684252, 6605.70274337656, 6656.667166641649, 6816.522843401013, 6862.897056544156, 6932.306769323128, 4025.2150830587752, 4029.5366032906004, 4186.748795072305, 4284.978575107167, 4388.385626012361, 1488.95533134004, 1570.9764353534706, 1791.8387345139, 1868.8504919606398, 1877.7652793400825, 760.3423039071164, 787.9709747400467, 787.984240315202, 790.5454363740872, 792.7582087463379, 15435.614109647124, 15628.35794787211, 16032.038077715375, 16197.271122799502, 16200.837991619934, 789.8617741895146, 794.6980147544012, 801.2508304734974, 803.6584451608043, 815.7437546178936, 8909.287257019423, 8969.820603587892, 9097.863532047024, 9151.72544823643, 9202.355835091614, 322177.0, 323123.0, 325707.0, 327655.0, 328003.0, 69450.3054969454, 69630.65184674044, 70461.64769176122, 70608.64695676489, 71991.2800871995, 892.8437523433503, 905.108468158863, 922.7693076730817, 928.5635751196927, 947.308464820671, 14722.190279534729, 14761.261936903327, 15049.398024078915, 15074.698506030038, 15579.844201557838, 31970.36059278755, 33990.66009339974, 34081.31837363189, 35246.823765881, 35855.46216806698, 39413.408798867466, 44660.55339446564, 46079.53920460752, 49170.26244606405, 49348.0, 6399.360063993563, 6739.764108256383, 6835.760748373783, 6938.583684978716, 6965.512414131165, 7055.717771289091, 9407.905920940702, 10256.102621015136, 11465.828012579985, 11717.941410292893, 5351.3043304370185, 5842.591018628656, 8672.566371681265, 9540.0, 9564.330496865152, 9890.0, 10048.748781280527, 10335.121514671337, 10485.16118710486, 10875.564977400816, 5475.72621368922, 5615.0, 7873.645685944031, 9543.618255269712, 9881.258905582254, 7233.855322893618, 7278.308560686726, 7301.890471643036, 7359.190489046307, 7493.812654683458, 7200.819979500345, 8837.204651581389, 9590.808183836145, 9727.65953191635, 9842.261830362608], "value": 7650.4605647735325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.2198680791525, 1318.498970391251, 1321.1478596305383, 1327.0378975242947, 1327.9402426890788, 6389.776357827477, 6628.933710662892, 6846.726130954762, 7225.277472252772, 7235.421166306696, 6869.690863911123, 6995.440364770819, 7006.194287656921, 7295.562266264014, 7304.926950730491, 2137.3801597536735, 2168.165256376291, 2170.902309396073, 2172.9891350543226, 2174.662927246279, 2070.1201989154547, 2106.5049713317358, 2139.101577337522, 2145.367116700569, 2162.37291185556, 2125.0968338456173, 2150.849440539163, 2151.290074275493, 2154.806067453929, 2154.8168405685537, 2045.1103769860083, 2058.5162486815584, 2060.5157787919825, 2060.8763474191596, 2062.504998800292, 2084.72898523191, 2086.54096098858, 2105.0948092320295, 2108.736407949006, 2109.789021097893, 7136.607486588236, 7152.0, 7235.095613048369, 7243.674034668453, 7266.4550158737775, 4387.341898715218, 4495.865124046284, 4497.64018878489, 4498.482674492409, 4511.70673906195, 2673.3717576369536, 2849.971500285012, 2874.6119273898175, 2913.8106023108644, 2920.0, 1104.9889501105047, 1106.363840791548, 1106.6458733205377, 1119.8219463144187, 1157.39236900627, 9317.534123293808, 9324.160825525667, 9349.48577828226, 9365.625374984993, 9368.110029547182, 3624.0939765058733, 3770.377887648562, 3825.0437390652337, 3872.4772155759174, 3884.0, 7546.2831031051965, 7554.206808285161, 7618.238176182337, 7621.618919054025, 7650.349720273728, 4288.335308027261, 4296.935545966813, 4315.438992930962, 4321.395004699345, 4331.047169622678, 3940.4680368150507, 3977.582353852804, 4106.137711080706, 4106.1582375612925, 4118.176364727066, 3057.0, 3113.0, 3170.4134735074085, 3177.126290270148, 3206.278587317835, 918.1874041473344, 920.4845286639503, 934.4393363981557, 940.5532372123323, 1014.0771897573173, 663.6792782363062, 669.9832504187336, 680.9285025072296, 681.5910453727723, 687.1204857782047, 4586.289125185602, 4835.685680430761, 4868.488808675038, 4911.9754401227765, 5048.72232027242, 852.7100785732756, 863.7408777366765, 872.7512658892185, 890.0031964200008, 909.1499448016126, 3185.474396724561, 3201.839908004637, 3211.5022171563446, 3286.5234540991423, 3322.833858307123, 8264.256216940505, 8589.656413743505, 8601.784955376166, 8603.870941935877, 8613.353998450142, 8551.486910785372, 8551.657933682707, 8554.443961142506, 8555.572221388906, 8564.3148548116, 6592.340765923369, 6721.630310332881, 6724.159480064992, 6726.529142960044, 6742.089817874622, 4408.0, 4512.255477846119, 4527.162474942146, 4535.954640453553, 4596.506135505907, 7486.887696684663, 7590.962045189739, 7614.086309642878, 7682.0397450318715, 7690.038745156856, 7752.4573279869865, 7756.991591093122, 7900.920990790019, 7921.722739704082, 8100.432969692065, 5839.065749480063, 5859.824205273849, 5884.411558844081, 5887.882242355215, 5935.228420305332, 6562.343765623399, 6730.798076057726, 6755.1556055493065, 6788.456923446014, 6804.523683342317, 6001.2498437695285, 6062.151298818081, 6264.31092579825, 6346.841328966812, 6446.226452825691, 5825.563082768725, 5882.029465138205, 5900.085486749561, 5902.911456328073, 5928.614640048383, 5043.823466178666, 5155.613329000415, 5164.7417629119145, 5175.327207463006, 5195.532402083831, 3969.9206015878945, 4046.656034237005, 4095.549489556206, 4095.651869591118, 4209.810558524812, 4094.2630326541507, 4183.53981062089, 4195.643370313557, 4219.641330486943, 4277.550857160078], "value": 3781.6507020391796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.4802803682329, 339.4568690095847, 340.7376320233422, 342.6727475261126, 348.20609011453877, 4899.755012249387, 4947.233178857274, 4956.553910148086, 4966.726830024347, 4980.178270585349, 4808.97595512022, 4871.926921096187, 4910.0, 4920.557149856512, 4931.950680493194, 3696.4085746280603, 3796.411556208778, 3853.190829925719, 3929.0963078491964, 3948.7038472114564, 3926.391409331558, 3937.5865534118934, 3949.3878448840474, 3951.7431366961055, 3954.4661470701517, 3911.256861196378, 3935.232629637222, 3936.665383442411, 3937.232239713257, 3966.7024973126986, 3585.623509531488, 3704.870014645532, 3941.0, 3949.9802500987453, 3968.226195891802, 3290.7531935104726, 3294.341131773631, 3300.290437555913, 3306.8095485625154, 3319.4191016572004, 4708.623310135215, 4751.738654374008, 4770.211170810946, 4800.759962001886, 4816.759162041884, 4332.566743325674, 4334.653227741773, 4337.934930976038, 4349.217140914634, 4351.717138385995, 4980.277859710358, 5037.665018770029, 5047.268146118792, 5080.796768129308, 5124.052050370693, 3553.3959226931483, 3553.4314509678584, 3555.6310820334356, 3570.6786389224835, 3577.284543091392, 5304.310439642861, 5327.866803329909, 5374.264885904259, 5382.2464854920345, 5384.680753215487, 3640.7815531068222, 3696.131409118855, 3710.981445092811, 3727.8751111865977, 3738.1776009277914, 3757.887263382103, 3777.1690228149764, 3778.527684039495, 3779.3575092234387, 3793.525809273841, 4293.227219100592, 4301.290287102593, 4302.719558633929, 4305.375720520507, 4325.015739140046, 4877.585500204901, 5119.232115182678, 5124.821291103067, 5165.638405311592, 5167.431582525919, 1252.9248245105323, 1268.9111762176558, 1271.1610337177603, 1272.4210484229654, 1276.304414094321, 830.8504469195482, 859.0636206534782, 865.8441480533564, 866.4541338956417, 889.7241855024963, 4484.865454036384, 4548.818047278138, 4569.383133276965, 4582.679212455096, 4591.44902611682, 5337.226102215157, 5337.786488540492, 5338.813141540028, 5339.973300133553, 5357.812476563302, 4584.862454126382, 4587.3807036050375, 4592.977035114803, 4593.47175074864, 4598.402207712976, 2618.764311212, 2715.6876959149554, 2738.7398197171237, 2747.3543717226435, 2763.6545431821023, 4887.804487820518, 4901.264810278415, 4901.3383193268455, 4916.606671466274, 4933.679310844784, 5099.949000509948, 5305.44292849253, 5306.124489459273, 5316.441773613792, 5355.303810504687, 4993.775280112403, 4995.600351971761, 5005.824796132118, 5009.674371165863, 5011.298418221452, 5322.41453440129, 5331.760070796746, 5339.3859706132735, 5341.866453338542, 5351.545118664957, 4967.677100988424, 5179.834537229244, 5236.769359200509, 5237.659552129099, 5243.161094224905, 5009.824656137018, 5016.247562865599, 5017.724025178504, 5020.648554601143, 5040.470750571138, 3671.853125874935, 3715.554133503889, 3724.776513409204, 3730.403135498307, 3733.981330093332, 5102.36220472441, 5245.580353571781, 5286.577073834161, 5355.196720491957, 5386.730663466889, 5123.92314115296, 5127.897442051213, 5141.611764823551, 5146.099432599355, 5148.176291793295, 5097.566706829961, 5146.305248791366, 5163.535281824654, 5168.508991645787, 5181.870453238699, 4965.3296804932315, 4991.450940396481, 5026.421961474331, 5056.342675452168, 5074.213496907985, 4951.257311403318, 5155.587552995677, 5168.328117344721, 5200.725822173592, 5203.453637368173, 5034.471380505141, 5040.6723562969755, 5054.545090941833, 5083.237514372726, 5086.160783470686], "value": 3877.958523982963, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.6460640466961, 697.2852825853499, 736.9424875303939, 757.8294883651178, 776.099724319789, 11889.881101188985, 12773.744525109492, 12907.741845163102, 14421.63945901353, 15350.616234594141, 14635.926820365883, 14942.775858362105, 14947.551573452787, 15356.385744570232, 15385.307661155246, 800.9599520024004, 828.5070383122032, 829.9751007469755, 829.9875501867476, 832.6169961817541, 676.2966514824576, 696.5959743348845, 790.3005839831733, 821.1501096365263, 821.765796747927, 862.9525376104311, 865.8008658008662, 866.3978534918234, 866.4714524140269, 866.6143566113083, 855.247382303572, 855.670566831768, 856.2550580994513, 856.2850020233113, 857.0272740439584, 630.4767043354005, 631.7851930343659, 631.8136149835809, 632.0298342044939, 632.1213513216633, 13510.459581616724, 13741.312934353342, 13780.655483612889, 13811.792823107662, 13885.166889986633, 11354.602588909349, 11765.823512647317, 11789.94105029478, 11975.341356225405, 12039.337836418994, 10383.325083869524, 10408.167346612328, 10431.269811113225, 10496.737581560446, 10568.735781605445, 3259.771815972883, 3267.9346413071844, 3317.668233176687, 3323.966760332414, 3424.708899743525, 62305.06542401868, 63415.36584634141, 63621.68189159025, 64392.678036609985, 64601.35398646, 9446.622135114656, 9569.425834449956, 9572.76068098303, 9684.757881052888, 9784.266180036526, 18257.81742182588, 18322.175502102436, 18343.266269349344, 18348.266069357076, 18351.90824045898, 6597.703103360361, 6659.533832631766, 6722.6302553359055, 6879.208890977602, 6944.201416837027, 3499.5975462821593, 3658.359787037258, 3683.3001729671278, 3738.476613274144, 3759.7180211484247, 2942.279141610319, 3031.7574594032426, 3038.7872848900365, 3049.1005153479778, 3075.2158199659393, 515.6622412319937, 521.1791428500128, 521.8643152780304, 523.1551045062273, 535.2827211536481, 587.1574290892582, 632.1087266953573, 635.3805040085879, 645.9870802583922, 656.7865443730807, 7869.645865936047, 8107.22981316774, 8115.472494287852, 8377.204165604258, 8480.915190848136, 603.8611119442553, 603.9969800151059, 609.2871340531589, 614.9292831324366, 622.3154530016946, 3638.326909521747, 3936.15372694872, 3955.3473676843573, 3955.8219880105466, 4014.217227640582, 65371.34628653653, 65511.67244163844, 66369.66815165893, 66933.66533167304, 66984.0, 53919.19121213185, 55670.72164639151, 57034.0, 57321.0, 60280.09579856306, 51449.48550514522, 51517.484825152016, 51935.48064519382, 51974.74012629988, 52758.20862686986, 7620.085589729268, 7635.809104772425, 7642.65608047628, 7670.309672129535, 7865.4494185406475, 35569.82215089011, 35710.10724731799, 36769.63230367769, 37167.728047804965, 38784.6121538781, 42647.57352426436, 45772.78501507015, 47761.28358074701, 47803.28295075646, 48300.758496207294, 9531.76170595713, 9785.026679680272, 9965.850512242467, 10005.949375315487, 10161.745956351151, 11221.887781122085, 11266.0, 11626.825597615873, 11883.287002779862, 11949.2830430171, 10089.19286457067, 10231.590736370461, 10637.414942178255, 10641.095506882002, 10662.0, 10687.786244275227, 10715.35707857531, 11202.66392008241, 11211.327320360804, 11225.49485273181, 10129.290949633454, 10158.44128572906, 10434.634787782696, 10692.732681683021, 10698.518566664363, 8472.406931514735, 8600.870986935075, 8616.655333786579, 8796.648134074565, 8916.821663566821, 8326.875096873673, 8627.137286271323, 8807.075257097913, 8986.101389860962, 9007.459552426875], "value": 6211.784023570931, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 118.0, 117.0, 116.0, 117.0, 119.0, 115.0, 116.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 127.0, 182.0, 132.0, 129.0, 130.0, 134.0, 156.0, 133.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 168.0, 169.0, 163.0, 165.0, 163.0, 165.0, 163.0, 166.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 118.0, 78.0, 79.0, 78.0, 77.0, 98.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 102.0, 87.0, 86.0, 90.0, 103.0, 88.0, 87.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 124.0, 118.0, 118.0, 118.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 150.0, 151.0, 151.0, 151.0, 150.0, 151.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 71.0, 72.0, 72.0, 72.0, 71.0, 72.0, 73.0], "value": 71.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 91.0, 95.0, 86.0, 87.0, 86.0, 85.0, 89.0, 84.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 143.0, 136.0, 138.0, 136.0, 135.0, 145.0, 137.0, 181.0, 138.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 188.0, 181.0, 185.0, 179.0, 180.0, 181.0, 179.0, 178.0, 176.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 74.0, 68.0, 69.0, 69.0, 69.0, 67.0, 68.0], "value": 69.3, "unit": "score"}]}]} 16:10:56 INFO - Return code: 0 16:10:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:56 ERROR - # TBPL SUCCESS # 16:10:56 INFO - Running post-action listener: _resource_record_post_action 16:10:56 INFO - [mozharness: 2016-12-30 00:10:56.436343Z] Finished run-tests step (success) 16:10:56 INFO - Running post-run listener: _resource_record_post_run 16:10:56 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 384475136; Read time: 36; Write time: 243988 16:10:56 INFO - TinderboxPrint: CPU usage
13.4% 16:10:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 16:10:56 INFO - TinderboxPrint: I/O write bytes / time
384,475,136 / 243,988 16:10:56 INFO - TinderboxPrint: CPU idle
8,279.5 (86.5%) 16:10:56 INFO - TinderboxPrint: CPU user
1,230.4 (12.9%) 16:10:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101240832; Read time: 0; Write time: 57896 16:10:56 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282300416; Read time: 24; Write time: 186068 16:10:57 INFO - Running post-run listener: _upload_blobber_files 16:10:57 INFO - Blob upload gear active. 16:10:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:57 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 16:10:57 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'] 16:10:57 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 16:10:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:59 INFO - (blobuploader) - INFO - Done attempting. 16:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:02 INFO - (blobuploader) - INFO - Done attempting. 16:11:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:11:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:03 INFO - (blobuploader) - INFO - Done attempting. 16:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:04 INFO - (blobuploader) - INFO - Done attempting. 16:11:04 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:04 INFO - Return code: 0 16:11:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e61100d7144cba873d9de3105e2c4cab7c3fc57c6af22ba89a17e719279d86fea1bc869f646be1c98a9759b02fffc0ebaa8e95103a4c9cccec2f68836a29abc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ff0caab8151752cf07c90edb7229afc917f7c3aa65348057cca22ee59e723eb71b0fe3f71ee75ddbdf8e2dc77b9f60e1c4e92b51d77a2375f1461fc7315c062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1e2e8aed39791551de9e1675932d49b8efe7a2bc5733a674d2e46eadb037a3cd2ded0ca011aefeac8dde9a10836beb367691e9bf6f1e4dc72663677c94536a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a736baa3eda4ec2aea2a5377d75b40d8fe383ca25395fa9b3649aa44a0ad3e0bacc6bf98f89bb3f97ef40d13d91fe7b5e31fd26634e615075cc207b4b7f930b"} 16:11:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:04 INFO - Contents: 16:11:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e61100d7144cba873d9de3105e2c4cab7c3fc57c6af22ba89a17e719279d86fea1bc869f646be1c98a9759b02fffc0ebaa8e95103a4c9cccec2f68836a29abc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ff0caab8151752cf07c90edb7229afc917f7c3aa65348057cca22ee59e723eb71b0fe3f71ee75ddbdf8e2dc77b9f60e1c4e92b51d77a2375f1461fc7315c062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1e2e8aed39791551de9e1675932d49b8efe7a2bc5733a674d2e46eadb037a3cd2ded0ca011aefeac8dde9a10836beb367691e9bf6f1e4dc72663677c94536a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a736baa3eda4ec2aea2a5377d75b40d8fe383ca25395fa9b3649aa44a0ad3e0bacc6bf98f89bb3f97ef40d13d91fe7b5e31fd26634e615075cc207b4b7f930b"} 16:11:04 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:04 INFO - Copying logs to upload dir... 16:11:04 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.582493 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-29 16:11:04.498982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 16:11:04.503070) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e61100d7144cba873d9de3105e2c4cab7c3fc57c6af22ba89a17e719279d86fea1bc869f646be1c98a9759b02fffc0ebaa8e95103a4c9cccec2f68836a29abc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ff0caab8151752cf07c90edb7229afc917f7c3aa65348057cca22ee59e723eb71b0fe3f71ee75ddbdf8e2dc77b9f60e1c4e92b51d77a2375f1461fc7315c062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1e2e8aed39791551de9e1675932d49b8efe7a2bc5733a674d2e46eadb037a3cd2ded0ca011aefeac8dde9a10836beb367691e9bf6f1e4dc72663677c94536a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a736baa3eda4ec2aea2a5377d75b40d8fe383ca25395fa9b3649aa44a0ad3e0bacc6bf98f89bb3f97ef40d13d91fe7b5e31fd26634e615075cc207b4b7f930b"} build_url:https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011859 build_url: 'https://queue.taskcluster.net/v1/task/Yp1ybPxsSlm61JsfnCtQQA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e61100d7144cba873d9de3105e2c4cab7c3fc57c6af22ba89a17e719279d86fea1bc869f646be1c98a9759b02fffc0ebaa8e95103a4c9cccec2f68836a29abc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ff0caab8151752cf07c90edb7229afc917f7c3aa65348057cca22ee59e723eb71b0fe3f71ee75ddbdf8e2dc77b9f60e1c4e92b51d77a2375f1461fc7315c062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1e2e8aed39791551de9e1675932d49b8efe7a2bc5733a674d2e46eadb037a3cd2ded0ca011aefeac8dde9a10836beb367691e9bf6f1e4dc72663677c94536a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2a736baa3eda4ec2aea2a5377d75b40d8fe383ca25395fa9b3649aa44a0ad3e0bacc6bf98f89bb3f97ef40d13d91fe7b5e31fd26634e615075cc207b4b7f930b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 16:11:04.528945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 16:11:04.529283) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483055418.169285-839457806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 16:11:04.612380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 16:11:04.612712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 16:11:04.613021) ========= ========= Total master_lag: 0.15 =========