builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1501768916.9 results: success (0) revision: fa1da3c0b200abbd9cfab3cab19962824314044e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:56.895813) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:56.896293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:56.896709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:56.912638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:56.912898) ========= 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=cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 07:01:57-- 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% 46.1M=0s 2017-08-03 07:01:57 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:57.064116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:57.064547) ========= 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=cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:01:57.117008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-03 07:01:57.117301) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fa1da3c0b200abbd9cfab3cab19962824314044e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev fa1da3c0b200abbd9cfab3cab19962824314044e --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=cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 07:01:57,430 truncating revision to first 12 chars 2017-08-03 07:01:57,430 Setting DEBUG logging. 2017-08-03 07:01:57,430 attempt 1/10 2017-08-03 07:01:57,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fa1da3c0b200?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 07:01:58,048 attempt 1/10 2017-08-03 07:01:58,677 current task status: no status available at this point. state: STARTED 2017-08-03 07:01:58,677 sleeping for 9.00s (attempt 1/10) 2017-08-03 07:02:07,687 attempt 2/10 2017-08-03 07:02:08,270 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-03 07:02:08,517 unpacking tar archive at: mozilla-central-fa1da3c0b200/testing/mozharness/ program finished with exit code 0 elapsedTime=11.401163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-03 07:02:08.535532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:08.535842) ========= script_repo_revision: fa1da3c0b200abbd9cfab3cab19962824314044e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:08.536259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:08.536536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:08.544989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-03 07:02:08.545283) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:02:08 INFO - MultiFileLogger online at 20170803 07:02:08 in /builds/slave/test 07:02:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:02:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:02:08 INFO - {'append_to_log': False, 07:02:08 INFO - 'base_work_dir': '/builds/slave/test', 07:02:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:02:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:02:08 INFO - 'branch': 'Firefox-Non-PGO', 07:02:08 INFO - 'buildbot_json_path': 'buildprops.json', 07:02:08 INFO - 'code_coverage': False, 07:02:08 INFO - 'config_files': ('talos/linux_config.py',), 07:02:08 INFO - 'default_actions': ('clobber', 07:02:08 INFO - 'read-buildbot-config', 07:02:08 INFO - 'download-and-extract', 07:02:08 INFO - 'populate-webroot', 07:02:08 INFO - 'create-virtualenv', 07:02:08 INFO - 'install', 07:02:08 INFO - 'setup-mitmproxy', 07:02:08 INFO - 'run-tests'), 07:02:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:02:08 INFO - 'disable_ccov_upload': False, 07:02:08 INFO - 'download_minidump_stackwalk': True, 07:02:08 INFO - 'download_symbols': 'ondemand', 07:02:08 INFO - 'enable_stylo': False, 07:02:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:02:08 INFO - 'tooltool.py': '/tools/tooltool.py', 07:02:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:02:08 INFO - '/tools/misc-python/virtualenv.py')}, 07:02:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:02:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:02:08 INFO - 'gecko_profile': False, 07:02:08 INFO - 'gecko_profile_interval': 0, 07:02:08 INFO - 'installer_path': 'installer.exe', 07:02:08 INFO - 'log_level': 'info', 07:02:08 INFO - 'log_name': 'talos', 07:02:08 INFO - 'log_to_console': True, 07:02:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:02:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:02:08 INFO - 'opt_config_files': (), 07:02:08 INFO - 'pip_index': False, 07:02:08 INFO - 'suite': 'dromaeojs-e10s', 07:02:08 INFO - 'system_bits': '32', 07:02:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:02:08 INFO - 'title': 'talos-linux64-ix-054', 07:02:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:02:08 INFO - 'use_talos_json': True, 07:02:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:02:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:02:08 INFO - 'work_dir': 'build'} 07:02:08 INFO - [mozharness: 2017-08-03 14:02:08.963572Z] Running clobber step. 07:02:08 INFO - Running pre-action listener: _resource_record_pre_action 07:02:08 INFO - Running main action method: clobber 07:02:08 INFO - rmtree: /builds/slave/test/build 07:02:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:02:10 INFO - Running post-action listener: _resource_record_post_action 07:02:10 INFO - [mozharness: 2017-08-03 14:02:10.505227Z] Finished clobber step (success) 07:02:10 INFO - [mozharness: 2017-08-03 14:02:10.505330Z] Running read-buildbot-config step. 07:02:10 INFO - Running pre-action listener: _resource_record_pre_action 07:02:10 INFO - Running main action method: read_buildbot_config 07:02:10 INFO - Using buildbot properties: 07:02:10 INFO - { 07:02:10 INFO - "project": "", 07:02:10 INFO - "product": "firefox", 07:02:10 INFO - "who": "axel@mozilla.com", 07:02:10 INFO - "installer_path": "public/build/target.tar.bz2", 07:02:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:02:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:02:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:02:10 INFO - "stage_platform": "linux64", 07:02:10 INFO - "basedir": "/builds/slave/test", 07:02:10 INFO - "buildnumber": 756, 07:02:10 INFO - "platform": "ubuntu64_hw", 07:02:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:02:10 INFO - "slavebuilddir": "test", 07:02:10 INFO - "taskId": "cSnE7jLIQkGlygqpFrVGbA", 07:02:10 INFO - "branch": "mozilla-central", 07:02:10 INFO - "script_repo_revision": "production", 07:02:10 INFO - "revision": "fa1da3c0b200abbd9cfab3cab19962824314044e", 07:02:10 INFO - "slavename": "talos-linux64-ix-054", 07:02:10 INFO - "repo_path": "mozilla-central" 07:02:10 INFO - } 07:02:10 INFO - Finding installer, test and symbols from parent task. 07:02:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cSnE7jLIQkGlygqpFrVGbA'}, attempt #1 07:02:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cSnE7jLIQkGlygqpFrVGbA'}, attempt #1 07:02:11 INFO - Task dependencies: am3KdoAISBKA1Cb3driNbg 07:02:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg'}, attempt #1 07:02:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:11 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json 07:02:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip 07:02:11 INFO - Running post-action listener: _resource_record_post_action 07:02:11 INFO - [mozharness: 2017-08-03 14:02:11.878289Z] Finished read-buildbot-config step (success) 07:02:11 INFO - [mozharness: 2017-08-03 14:02:11.878512Z] Running download-and-extract step. 07:02:11 INFO - Running pre-action listener: _resource_record_pre_action 07:02:11 INFO - Running main action method: download_and_extract 07:02:11 INFO - mkdir: /builds/slave/test/build/tests 07:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:11 INFO - trying https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json 07:02:11 INFO - Downloading https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:02:12 INFO - Downloaded 989 bytes. 07:02:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:02:12 INFO - Using the following test package requirements: 07:02:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:02:12 INFO - u'common': [u'target.common.tests.zip'], 07:02:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:02:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:02:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:02:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:02:12 INFO - u'mozbase': [u'target.common.tests.zip'], 07:02:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:02:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:02:12 INFO - u'web-platform': [u'target.common.tests.zip', 07:02:12 INFO - u'target.web-platform.tests.tar.gz'], 07:02:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:02:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:02:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip 07:02:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:02:12 INFO - Fetch https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip into memory 07:02:13 INFO - Content-Length response header: 54278210 07:02:13 INFO - Bytes received: 54278210 07:02:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:02:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip 07:02:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:02:24 INFO - Fetch https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip into memory 07:02:25 INFO - Content-Length response header: 54278210 07:02:25 INFO - Bytes received: 54278210 07:02:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.talos.tests.zip 07:02:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:02:37 INFO - Fetch https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.talos.tests.zip into memory 07:02:38 INFO - Content-Length response header: 14496464 07:02:38 INFO - Bytes received: 14496464 07:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:38 INFO - trying https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:38 INFO - Downloading https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:02:39 INFO - Downloaded 62111745 bytes. 07:02:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:39 INFO - mkdir: /builds/slave/test/properties 07:02:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:02:39 INFO - Writing to file /builds/slave/test/properties/build_url 07:02:39 INFO - Contents: 07:02:39 INFO - build_url:https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:39 INFO - Running post-action listener: _resource_record_post_action 07:02:39 INFO - Running post-action listener: set_extra_try_arguments 07:02:39 INFO - [mozharness: 2017-08-03 14:02:39.902148Z] Finished download-and-extract step (success) 07:02:39 INFO - [mozharness: 2017-08-03 14:02:39.902248Z] Running populate-webroot step. 07:02:39 INFO - Running pre-action listener: _resource_record_pre_action 07:02:39 INFO - Running main action method: populate_webroot 07:02:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:02:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:02:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'tests': ['damp', 'tps']}, 07:02:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:02:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:02:39 INFO - 'other-e10s': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_many_windows', 07:02:39 INFO - 'sessionrestore_no_auto_restore', 07:02:39 INFO - 'tabpaint']}, 07:02:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:02:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:02:39 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:02:39 INFO - 'talos_options': ['--mitmproxy', 07:02:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:02:39 INFO - '--firstNonBlankPaint'], 07:02:39 INFO - 'tests': ['quantum_pageload_google', 07:02:39 INFO - 'quantum_pageload_youtube', 07:02:39 INFO - 'quantum_pageload_amazon', 07:02:39 INFO - 'quantum_pageload_facebook']}, 07:02:39 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:02:39 INFO - 'talos_options': ['--stylo', 07:02:39 INFO - '--mitmproxy', 07:02:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:02:39 INFO - '--firstNonBlankPaint'], 07:02:39 INFO - 'tests': ['quantum_pageload_google', 07:02:39 INFO - 'quantum_pageload_youtube', 07:02:39 INFO - 'quantum_pageload_amazon', 07:02:39 INFO - 'quantum_pageload_facebook']}, 07:02:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:02:39 INFO - 'tsvgr_opacity', 07:02:39 INFO - 'tart', 07:02:39 INFO - 'tscrollx', 07:02:39 INFO - 'cart', 07:02:39 INFO - 'tsvg_static']}, 07:02:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:02:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:02:39 INFO - 'talos_options': ['--stylo', 07:02:39 INFO - '--stylo-threads=1', 07:02:39 INFO - '--mitmproxy', 07:02:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:02:39 INFO - '--firstNonBlankPaint'], 07:02:39 INFO - 'tests': ['tp6_google', 07:02:39 INFO - 'tp6_youtube', 07:02:39 INFO - 'tp6_amazon', 07:02:39 INFO - 'tp6_facebook']}, 07:02:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:02:39 INFO - 'talos_options': ['--xperf_path', 07:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:39 INFO - 'tests': ['tp5n']}}} 07:02:39 INFO - Running post-action listener: _resource_record_post_action 07:02:39 INFO - [mozharness: 2017-08-03 14:02:39.911029Z] Finished populate-webroot step (success) 07:02:39 INFO - [mozharness: 2017-08-03 14:02:39.911121Z] Running create-virtualenv step. 07:02:39 INFO - Running pre-action listener: _resource_record_pre_action 07:02:39 INFO - Running main action method: create_virtualenv 07:02:39 INFO - Creating virtualenv /builds/slave/test/build/venv 07:02:39 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 07:02:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:02:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:02:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:40 INFO - Using real prefix '/usr' 07:02:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:02:40 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:42 INFO - Installing pip.................done. 07:02:42 INFO - Return code: 0 07:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:02:42 INFO - Reading from file tmpfile_stdout 07:02:42 INFO - Output received: 07:02:42 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) 07:02:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 07:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:02:42 INFO - Using env: {'DISPLAY': ':0', 07:02:42 INFO - 'HOME': '/home/cltbld', 07:02:42 INFO - 'LANG': 'en_US.UTF-8', 07:02:42 INFO - 'LANGUAGE': 'en_US:en', 07:02:42 INFO - 'LOGNAME': 'cltbld', 07:02:42 INFO - 'MAIL': '/var/mail/cltbld', 07:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:42 INFO - 'MOZ_NO_REMOTE': '1', 07:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:42 INFO - 'NO_EM_RESTART': '1', 07:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:42 INFO - 'PWD': '/builds/slave/test', 07:02:42 INFO - 'SHELL': '/bin/bash', 07:02:42 INFO - 'SHLVL': '1', 07:02:42 INFO - 'TERM': 'linux', 07:02:42 INFO - 'TMOUT': '86400', 07:02:42 INFO - 'USER': 'cltbld', 07:02:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:42 INFO - '_': '/tools/buildbot/bin/python'} 07:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:42 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 07:02:42 INFO - Cleaning up... 07:02:42 INFO - Return code: 0 07:02:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 07:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:02:42 INFO - Using env: {'DISPLAY': ':0', 07:02:42 INFO - 'HOME': '/home/cltbld', 07:02:42 INFO - 'LANG': 'en_US.UTF-8', 07:02:42 INFO - 'LANGUAGE': 'en_US:en', 07:02:42 INFO - 'LOGNAME': 'cltbld', 07:02:42 INFO - 'MAIL': '/var/mail/cltbld', 07:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:42 INFO - 'MOZ_NO_REMOTE': '1', 07:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:42 INFO - 'NO_EM_RESTART': '1', 07:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:42 INFO - 'PWD': '/builds/slave/test', 07:02:42 INFO - 'SHELL': '/bin/bash', 07:02:42 INFO - 'SHLVL': '1', 07:02:42 INFO - 'TERM': 'linux', 07:02:42 INFO - 'TMOUT': '86400', 07:02:42 INFO - 'USER': 'cltbld', 07:02:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:42 INFO - '_': '/tools/buildbot/bin/python'} 07:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:43 INFO - Downloading/unpacking psutil>=3.1.1 07:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:44 INFO - Installing collected packages: psutil 07:02:44 INFO - Running setup.py install for psutil 07:02:44 INFO - building 'psutil._psutil_linux' extension 07:02:44 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 07:02:44 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 07:02:44 INFO - building 'psutil._psutil_posix' extension 07:02:44 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 07:02:44 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 07:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:44 INFO - Successfully installed psutil 07:02:44 INFO - Cleaning up... 07:02:44 INFO - Return code: 0 07:02:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 07:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:02:44 INFO - Using env: {'DISPLAY': ':0', 07:02:44 INFO - 'HOME': '/home/cltbld', 07:02:44 INFO - 'LANG': 'en_US.UTF-8', 07:02:44 INFO - 'LANGUAGE': 'en_US:en', 07:02:44 INFO - 'LOGNAME': 'cltbld', 07:02:44 INFO - 'MAIL': '/var/mail/cltbld', 07:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:44 INFO - 'MOZ_NO_REMOTE': '1', 07:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:44 INFO - 'NO_EM_RESTART': '1', 07:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:44 INFO - 'PWD': '/builds/slave/test', 07:02:44 INFO - 'SHELL': '/bin/bash', 07:02:44 INFO - 'SHLVL': '1', 07:02:44 INFO - 'TERM': 'linux', 07:02:44 INFO - 'TMOUT': '86400', 07:02:44 INFO - 'USER': 'cltbld', 07:02:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:44 INFO - '_': '/tools/buildbot/bin/python'} 07:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:02: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 07:02: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 07:02: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 07:02: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 07:02:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:02:46 INFO - Installing collected packages: mozsystemmonitor 07:02:46 INFO - Running setup.py install for mozsystemmonitor 07:02:46 INFO - Successfully installed mozsystemmonitor 07:02:46 INFO - Cleaning up... 07:02:46 INFO - Return code: 0 07:02:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:46 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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 07:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:02:46 INFO - Using env: {'DISPLAY': ':0', 07:02:46 INFO - 'HOME': '/home/cltbld', 07:02:46 INFO - 'LANG': 'en_US.UTF-8', 07:02:46 INFO - 'LANGUAGE': 'en_US:en', 07:02:46 INFO - 'LOGNAME': 'cltbld', 07:02:46 INFO - 'MAIL': '/var/mail/cltbld', 07:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:46 INFO - 'MOZ_NO_REMOTE': '1', 07:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:46 INFO - 'NO_EM_RESTART': '1', 07:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:46 INFO - 'PWD': '/builds/slave/test', 07:02:46 INFO - 'SHELL': '/bin/bash', 07:02:46 INFO - 'SHLVL': '1', 07:02:46 INFO - 'TERM': 'linux', 07:02:46 INFO - 'TMOUT': '86400', 07:02:46 INFO - 'USER': 'cltbld', 07:02:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:46 INFO - '_': '/tools/buildbot/bin/python'} 07:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:46 INFO - Downloading/unpacking jsonschema==2.5.1 07:02:46 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 07:02:46 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 07:02:46 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 07:02:46 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 07:02:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:02:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:02: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 07:02: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 07:02: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 07:02: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 07:02:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:02:47 INFO - warning: no files found matching '*.txt' 07:02:47 INFO - no previously-included directories found matching 'build' 07:02:47 INFO - no previously-included directories found matching 'dist' 07:02:47 INFO - no previously-included directories found matching '.git*' 07:02:47 INFO - Installing collected packages: jsonschema, functools32 07:02:47 INFO - Running setup.py install for functools32 07:02:47 INFO - warning: no files found matching '*.txt' 07:02:47 INFO - no previously-included directories found matching 'build' 07:02:47 INFO - no previously-included directories found matching 'dist' 07:02:47 INFO - no previously-included directories found matching '.git*' 07:02:47 INFO - Successfully installed jsonschema functools32 07:02:47 INFO - Cleaning up... 07:02:47 INFO - Return code: 0 07:02:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:47 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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 07:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:02:48 INFO - Using env: {'DISPLAY': ':0', 07:02:48 INFO - 'HOME': '/home/cltbld', 07:02:48 INFO - 'LANG': 'en_US.UTF-8', 07:02:48 INFO - 'LANGUAGE': 'en_US:en', 07:02:48 INFO - 'LOGNAME': 'cltbld', 07:02:48 INFO - 'MAIL': '/var/mail/cltbld', 07:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:48 INFO - 'MOZ_NO_REMOTE': '1', 07:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:48 INFO - 'NO_EM_RESTART': '1', 07:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:48 INFO - 'PWD': '/builds/slave/test', 07:02:48 INFO - 'SHELL': '/bin/bash', 07:02:48 INFO - 'SHLVL': '1', 07:02:48 INFO - 'TERM': 'linux', 07:02:48 INFO - 'TMOUT': '86400', 07:02:48 INFO - 'USER': 'cltbld', 07:02:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:48 INFO - '_': '/tools/buildbot/bin/python'} 07:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:02:48 INFO - Cleaning up... 07:02:48 INFO - Return code: 0 07:02:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:48 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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 07:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:02:48 INFO - Using env: {'DISPLAY': ':0', 07:02:48 INFO - 'HOME': '/home/cltbld', 07:02:48 INFO - 'LANG': 'en_US.UTF-8', 07:02:48 INFO - 'LANGUAGE': 'en_US:en', 07:02:48 INFO - 'LOGNAME': 'cltbld', 07:02:48 INFO - 'MAIL': '/var/mail/cltbld', 07:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:48 INFO - 'MOZ_NO_REMOTE': '1', 07:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:48 INFO - 'NO_EM_RESTART': '1', 07:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:48 INFO - 'PWD': '/builds/slave/test', 07:02:48 INFO - 'SHELL': '/bin/bash', 07:02:48 INFO - 'SHLVL': '1', 07:02:48 INFO - 'TERM': 'linux', 07:02:48 INFO - 'TMOUT': '86400', 07:02:48 INFO - 'USER': 'cltbld', 07:02:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:48 INFO - '_': '/tools/buildbot/bin/python'} 07:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:02:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 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 07:02:50 INFO - Downloading docopt-0.6.1.tar.gz 07:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:50 INFO - Running setup.py install for blobuploader 07:02:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:02:50 INFO - Running setup.py install for requests 07:02:50 INFO - Running setup.py install for docopt 07:02:50 INFO - Successfully installed blobuploader requests docopt 07:02:50 INFO - Cleaning up... 07:02:50 INFO - Return code: 0 07:02:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:50 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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:50 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:02:50 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:50 INFO - Using env: {'DISPLAY': ':0', 07:02:50 INFO - 'HOME': '/home/cltbld', 07:02:50 INFO - 'LANG': 'en_US.UTF-8', 07:02:50 INFO - 'LANGUAGE': 'en_US:en', 07:02:50 INFO - 'LOGNAME': 'cltbld', 07:02:50 INFO - 'MAIL': '/var/mail/cltbld', 07:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:50 INFO - 'MOZ_NO_REMOTE': '1', 07:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:50 INFO - 'NO_EM_RESTART': '1', 07:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:50 INFO - 'PWD': '/builds/slave/test', 07:02:50 INFO - 'SHELL': '/bin/bash', 07:02:50 INFO - 'SHLVL': '1', 07:02:50 INFO - 'TERM': 'linux', 07:02:50 INFO - 'TMOUT': '86400', 07:02:50 INFO - 'USER': 'cltbld', 07:02:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:50 INFO - '_': '/tools/buildbot/bin/python'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:50 INFO - Running setup.py (path:/tmp/pip-spoXhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:50 INFO - Running setup.py (path:/tmp/pip-mkff0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:51 INFO - Running setup.py (path:/tmp/pip-ClATc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:51 INFO - Running setup.py (path:/tmp/pip-HX0MxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:51 INFO - Running setup.py (path:/tmp/pip-PvOv2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:51 INFO - Running setup.py (path:/tmp/pip-mvBudr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:51 INFO - Running setup.py (path:/tmp/pip-ZRBi4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:51 INFO - Running setup.py (path:/tmp/pip-DL6yVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:51 INFO - Running setup.py (path:/tmp/pip-qiSs0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:51 INFO - Running setup.py (path:/tmp/pip-xywi3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:51 INFO - Running setup.py (path:/tmp/pip-_c3x2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:51 INFO - Running setup.py (path:/tmp/pip-7XcUlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:51 INFO - Running setup.py (path:/tmp/pip-Pdrvst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:51 INFO - Running setup.py (path:/tmp/pip-wU93sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:51 INFO - Running setup.py (path:/tmp/pip-n2W8cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:51 INFO - Running setup.py (path:/tmp/pip-yNMrrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:52 INFO - Running setup.py (path:/tmp/pip-W8XNij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:02:52 INFO - Running setup.py install for manifestparser 07:02:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Running setup.py install for mozcrash 07:02:52 INFO - Running setup.py install for mozdebug 07:02:52 INFO - Running setup.py install for mozdevice 07:02:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Running setup.py install for mozfile 07:02:52 INFO - Running setup.py install for mozhttpd 07:02:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Running setup.py install for mozinfo 07:02:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Running setup.py install for mozInstall 07:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:02:52 INFO - Running setup.py install for mozleak 07:02:53 INFO - Running setup.py install for mozlog 07:02:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Running setup.py install for moznetwork 07:02:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Running setup.py install for mozprocess 07:02:53 INFO - Running setup.py install for mozprofile 07:02:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Running setup.py install for mozrunner 07:02:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Running setup.py install for mozscreenshot 07:02:53 INFO - Running setup.py install for moztest 07:02:53 INFO - Running setup.py install for mozversion 07:02:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:02:53 INFO - Cleaning up... 07:02:53 INFO - Return code: 0 07:02:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:53 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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:53 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:02:53 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:53 INFO - Using env: {'DISPLAY': ':0', 07:02:53 INFO - 'HOME': '/home/cltbld', 07:02:53 INFO - 'LANG': 'en_US.UTF-8', 07:02:53 INFO - 'LANGUAGE': 'en_US:en', 07:02:53 INFO - 'LOGNAME': 'cltbld', 07:02:53 INFO - 'MAIL': '/var/mail/cltbld', 07:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:53 INFO - 'MOZ_NO_REMOTE': '1', 07:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:53 INFO - 'NO_EM_RESTART': '1', 07:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:53 INFO - 'PWD': '/builds/slave/test', 07:02:53 INFO - 'SHELL': '/bin/bash', 07:02:53 INFO - 'SHLVL': '1', 07:02:53 INFO - 'TERM': 'linux', 07:02:53 INFO - 'TMOUT': '86400', 07:02:53 INFO - 'USER': 'cltbld', 07:02:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:53 INFO - '_': '/tools/buildbot/bin/python'} 07:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:54 INFO - Running setup.py (path:/tmp/pip-Ti7inM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:54 INFO - Running setup.py (path:/tmp/pip-9UU81f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:54 INFO - Running setup.py (path:/tmp/pip-4b155m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:54 INFO - Running setup.py (path:/tmp/pip-q4HG7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:54 INFO - Running setup.py (path:/tmp/pip-Z56kip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:54 INFO - Running setup.py (path:/tmp/pip-nXVMeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:54 INFO - Running setup.py (path:/tmp/pip-G5BMQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:54 INFO - Running setup.py (path:/tmp/pip-BhZzKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:54 INFO - Running setup.py (path:/tmp/pip-pyyReD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:54 INFO - Running setup.py (path:/tmp/pip-umt6wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:54 INFO - Running setup.py (path:/tmp/pip-I8p2Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:54 INFO - Running setup.py (path:/tmp/pip-nUoCKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 07:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:55 INFO - Running setup.py (path:/tmp/pip-UeGvzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:55 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)) 07:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:55 INFO - Running setup.py (path:/tmp/pip-HIraV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:55 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)) 07:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:55 INFO - Running setup.py (path:/tmp/pip-3Ftmly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:55 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)) 07:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:55 INFO - Running setup.py (path:/tmp/pip-QD5i7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:55 INFO - Running setup.py (path:/tmp/pip-l0UtVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:55 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)) 07:02:55 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)) 07:02:55 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)) 07:02:55 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)) 07:02:55 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:55 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:02:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:55 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 07:02:55 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 07:02:55 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 07:02:55 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 07:02:56 INFO - Downloading blessings-1.6.tar.gz 07:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:02:56 INFO - Installing collected packages: blessings 07:02:56 INFO - Running setup.py install for blessings 07:02:56 INFO - Successfully installed blessings 07:02:56 INFO - Cleaning up... 07:02:56 INFO - Return code: 0 07:02:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:56 INFO - Reading from file tmpfile_stdout 07:02:56 INFO - Current package versions: 07:02:56 INFO - argparse == 1.2.1 07:02:56 INFO - blessings == 1.6 07:02:56 INFO - blobuploader == 1.2.4 07:02:56 INFO - docopt == 0.6.1 07:02:56 INFO - functools32 == 3.2.3-2 07:02:56 INFO - jsonschema == 2.5.1 07:02:56 INFO - manifestparser == 1.1 07:02:56 INFO - mozInstall == 1.13 07:02:56 INFO - mozcrash == 1.0 07:02:56 INFO - mozdebug == 0.1 07:02:56 INFO - mozdevice == 0.51 07:02:56 INFO - mozfile == 1.2 07:02:56 INFO - mozhttpd == 0.7 07:02:56 INFO - mozinfo == 0.10 07:02:56 INFO - mozleak == 0.1 07:02:56 INFO - mozlog == 3.5 07:02:56 INFO - moznetwork == 0.27 07:02:56 INFO - mozprocess == 0.25 07:02:56 INFO - mozprofile == 0.28 07:02:56 INFO - mozrunner == 6.13 07:02:56 INFO - mozscreenshot == 0.1 07:02:56 INFO - mozsystemmonitor == 0.3 07:02:56 INFO - moztest == 0.8 07:02:56 INFO - mozversion == 1.4 07:02:56 INFO - psutil == 3.1.1 07:02:56 INFO - requests == 1.2.3 07:02:56 INFO - wsgiref == 0.1.2 07:02:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02: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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:02: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/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:56 INFO - Using env: {'DISPLAY': ':0', 07:02:56 INFO - 'HOME': '/home/cltbld', 07:02:56 INFO - 'LANG': 'en_US.UTF-8', 07:02:56 INFO - 'LANGUAGE': 'en_US:en', 07:02:56 INFO - 'LOGNAME': 'cltbld', 07:02:56 INFO - 'MAIL': '/var/mail/cltbld', 07:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:56 INFO - 'MOZ_NO_REMOTE': '1', 07:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:56 INFO - 'NO_EM_RESTART': '1', 07:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:56 INFO - 'PWD': '/builds/slave/test', 07:02:56 INFO - 'SHELL': '/bin/bash', 07:02:56 INFO - 'SHLVL': '1', 07:02:56 INFO - 'TERM': 'linux', 07:02:56 INFO - 'TMOUT': '86400', 07:02:56 INFO - 'USER': 'cltbld', 07:02:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:56 INFO - '_': '/tools/buildbot/bin/python'} 07:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:02:57 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 07:02:57 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 07:02:57 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 07:02:57 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 07:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:02:58 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)) 07:02:58 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)) 07:02:58 INFO - Installing collected packages: simplejson 07:02:58 INFO - Running setup.py install for simplejson 07:02:58 INFO - building 'simplejson._speedups' extension 07:02:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 07:02:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:02:59 INFO - Successfully installed simplejson 07:02:59 INFO - Cleaning up... 07:02:59 INFO - Return code: 0 07:02:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:59 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/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 0x17011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a71d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, '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': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', '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 07:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:02:59 INFO - Using env: {'DISPLAY': ':0', 07:02:59 INFO - 'HOME': '/home/cltbld', 07:02:59 INFO - 'LANG': 'en_US.UTF-8', 07:02:59 INFO - 'LANGUAGE': 'en_US:en', 07:02:59 INFO - 'LOGNAME': 'cltbld', 07:02:59 INFO - 'MAIL': '/var/mail/cltbld', 07:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:59 INFO - 'MOZ_NO_REMOTE': '1', 07:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:59 INFO - 'NO_EM_RESTART': '1', 07:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:59 INFO - 'PWD': '/builds/slave/test', 07:02:59 INFO - 'SHELL': '/bin/bash', 07:02:59 INFO - 'SHLVL': '1', 07:02:59 INFO - 'TERM': 'linux', 07:02:59 INFO - 'TMOUT': '86400', 07:02:59 INFO - 'USER': 'cltbld', 07:02:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:59 INFO - '_': '/tools/buildbot/bin/python'} 07:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:02:59 INFO - Cleaning up... 07:02:59 INFO - Return code: 0 07:02:59 INFO - Running post-action listener: _resource_record_post_action 07:02:59 INFO - Running post-action listener: _start_resource_monitoring 07:02:59 INFO - Starting resource monitoring. 07:02:59 INFO - [mozharness: 2017-08-03 14:02:59.593564Z] Finished create-virtualenv step (success) 07:02:59 INFO - [mozharness: 2017-08-03 14:02:59.594085Z] Running install step. 07:02:59 INFO - Running pre-action listener: _resource_record_pre_action 07:02:59 INFO - Running main action method: install 07:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:59 INFO - Reading from file tmpfile_stdout 07:02:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:02:59 INFO - Reading from file tmpfile_stdout 07:02:59 INFO - Output received: 07:02:59 INFO - Usage: mozinstall [options] installer 07:02:59 INFO - Options: 07:02:59 INFO - -h, --help show this help message and exit 07:02:59 INFO - -d DEST, --destination=DEST 07:02:59 INFO - Directory to install application into. [default: 07:02:59 INFO - "/builds/slave/test"] 07:02:59 INFO - --app=APP Application being installed. [default: firefox] 07:02:59 INFO - mkdir: /builds/slave/test/build/application 07:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:03:17 INFO - Reading from file tmpfile_stdout 07:03:17 INFO - Output received: 07:03:17 INFO - /builds/slave/test/build/application/firefox/firefox 07:03:17 INFO - Running post-action listener: _resource_record_post_action 07:03:17 INFO - [mozharness: 2017-08-03 14:03:17.947271Z] Finished install step (success) 07:03:17 INFO - [mozharness: 2017-08-03 14:03:17.947559Z] Running setup-mitmproxy step. 07:03:17 INFO - Running pre-action listener: _resource_record_pre_action 07:03:17 INFO - Running main action method: setup_mitmproxy 07:03:17 INFO - Skipping: mitmproxy is not required 07:03:17 INFO - Running post-action listener: _resource_record_post_action 07:03:17 INFO - [mozharness: 2017-08-03 14:03:17.948706Z] Finished setup-mitmproxy step (success) 07:03:17 INFO - [mozharness: 2017-08-03 14:03:17.948930Z] Running run-tests step. 07:03:17 INFO - Running pre-action listener: _resource_record_pre_action 07:03:17 INFO - Running pre-action listener: _set_gcov_prefix 07:03:17 INFO - Running main action method: run_tests 07:03:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:03:17 INFO - Python 2.7.3 07:03:17 INFO - Return code: 0 07:03:17 INFO - grabbing minidump binary from tooltool 07:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 07:03:17 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 0x1a6eeb0>, '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 0x1a6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:03:17 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 07:03:17 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 07:03:17 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 07:03:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:18 INFO - Return code: 0 07:03:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:03:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:03:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:03:18 INFO - ENV: RUST_BACKTRACE is now 1 07:03:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:03:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:03:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 07:03:18 INFO - Using env: {'DISPLAY': ':0', 07:03:18 INFO - 'HOME': '/home/cltbld', 07:03:18 INFO - 'LANG': 'en_US.UTF-8', 07:03:18 INFO - 'LANGUAGE': 'en_US:en', 07:03:18 INFO - 'LOGNAME': 'cltbld', 07:03:18 INFO - 'MAIL': '/var/mail/cltbld', 07:03:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:03:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:18 INFO - 'MOZ_NO_REMOTE': '1', 07:03:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:18 INFO - 'NO_EM_RESTART': '1', 07:03:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:18 INFO - 'PWD': '/builds/slave/test', 07:03:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:03:18 INFO - 'RUST_BACKTRACE': '1', 07:03:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:03:18 INFO - 'SHELL': '/bin/bash', 07:03:18 INFO - 'SHLVL': '1', 07:03:18 INFO - 'TERM': 'linux', 07:03:18 INFO - 'TMOUT': '86400', 07:03:18 INFO - 'USER': 'cltbld', 07:03:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160', 07:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:18 INFO - '_': '/tools/buildbot/bin/python'} 07:03:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:03:18 INFO - mozversion application_buildid: 20170803132126 07:03:18 INFO - mozversion application_changeset: fa1da3c0b200abbd9cfab3cab19962824314044e 07:03:18 INFO - mozversion application_display_name: Nightly 07:03:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:18 INFO - mozversion application_name: Firefox 07:03:18 INFO - mozversion application_remotingname: firefox 07:03:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:03:18 INFO - mozversion application_vendor: Mozilla 07:03:18 INFO - mozversion application_version: 57.0a1 07:03:18 INFO - mozversion platform_buildid: 20170803132126 07:03:18 INFO - mozversion platform_changeset: fa1da3c0b200abbd9cfab3cab19962824314044e 07:03:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:03:18 INFO - mozversion platform_version: 57.0a1 07:03:18 INFO - using testdate: 1501768998 07:03:18 INFO - actual date: 1501768998 07:03:18 INFO - starting webserver on 'localhost:58512' 07:03:18 INFO - SUITE-START | Running 2 tests 07:03:18 INFO - TEST-START | dromaeo_css 07:03:18 INFO - Initialising browser for dromaeo_css test... 07:03:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58512/getInfo.html -profile /tmp/tmplnLAGH/profile 07:03:18 INFO - TEST-INFO | started process 2454 (/builds/slave/test/build/application/firefox/firefox http://localhost:58512/getInfo.html) 07:03:24 INFO - TEST-INFO | 2454: exit 0 07:03:24 INFO - Browser initialized. 07:03:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:03:24 INFO - TEST-INFO | started process 2678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnLAGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:25 INFO - PID 2678 | 07:03:25 INFO - PID 2678 | (/builds/slave/test/build/application/firefox/firefox:2775): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:03:25 INFO - PID 2678 | 07:03:36 INFO - PID 2678 | RSS: Main: 171450368 07:03:36 INFO - PID 2678 | 07:06:36 INFO - PID 2678 | Cycle 1(1): loaded http://localhost:58512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58512/tests/dromaeo/cssquery-ext.html) 07:06:38 INFO - PID 2678 | RSS: Main: 171180032 07:06:38 INFO - PID 2678 | 07:09:39 INFO - PID 2678 | Cycle 1(1): loaded http://localhost:58512/tests/dromaeo/cssquery-ext.html (next: http://localhost:58512/tests/dromaeo/cssquery-jquery.html) 07:09:40 INFO - PID 2678 | RSS: Main: 171749376 07:09:40 INFO - PID 2678 | 07:12:42 INFO - PID 2678 | Cycle 1(1): loaded http://localhost:58512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58512/tests/dromaeo/cssquery-mootools.html) 07:12:42 INFO - PID 2678 | RSS: Main: 173236224 07:12:42 INFO - PID 2678 | 07:15:44 INFO - PID 2678 | Cycle 1(1): loaded http://localhost:58512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58512/tests/dromaeo/cssquery-prototype.html) 07:15:45 INFO - PID 2678 | RSS: Main: 169861120 07:15:45 INFO - PID 2678 | 07:18:49 INFO - PID 2678 | Cycle 1(1): loaded http://localhost:58512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58512/tests/dromaeo/cssquery-yui.html) 07:18:49 INFO - PID 2678 | RSS: Main: 174686208 07:18:49 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | Cycle 1(1): loaded http://localhost:58512/tests/dromaeo/cssquery-yui.html (next: http://localhost:58512/tests/dromaeo/cssquery-dojo.html) 07:21:51 INFO - PID 2678 | RSS: Main: 175263744 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | __start_tp_report 07:21:51 INFO - PID 2678 | _x_x_mozilla_page_load 07:21:51 INFO - PID 2678 | _x_x_mozilla_page_load_details 07:21:51 INFO - PID 2678 | |i|pagename|runs| 07:21:51 INFO - PID 2678 | |0;dojo.html;3152.4956007038877;3177.1898165967673;3177.3168768714722;3196.8721251149955;3233.175540237239;6232.626042437446;6279;6279.152314437555;6306.779262725806;6403.871922561546;6104.542159338045;6162.168107305512;6200.224971878515;6209.596376235541;6214.40963108504;5674.347450043236;5724.5992780505385;5727.770889164439;5729.598928075036;5751.482366587006;5785.479306862381;5789.536837053026;5800.651960882361;5801.419858014207;5813.9418605814035;5846.23998880145;5846.736896839652;5849.122631605251;5890.499307558863;5943.108533719955;5738.42615738427;5799.420057994188;5818.389069147721;5891.911621325662;5905.320888097881;5628.577856660726;5674.148877668383;5765.769369225268;5776.653400795965;5778.682172480512;6170.043643235305;6215.409536094064;6261.937380626181;6273.215848018997;6323.841903952392;6712.630805305706;6716.09158848785;6739.460843132587;6810.148731408574;6819.079424277708;6745.696443659998;6820.147481564804;6823.727050917957;6825.180978282638;6845.178578570603;6303.0545418187185;6325.96837015812;6328.082428047907;6331.588446750992;6338.334474880071;7001.50989430735;7029.613371264527;7054.717811287491;7065.0815393998455;7070.36366726997;6617.239017512951;6631.602103873686;6642.169728783902;6735.8989615155815;6736.966315168393;6552.180977377828;6647.60114393138;6757.358050985247;6778.118844550177;6867.896981545281;6613.768518101843;6630.237522684856;6634.303398143125;6637.46900247979;6643.269240383554;6676.9666151668935;6681.899771503431;6711.563748356341;6711.765088221889;6726.22648395431;5392.379876314196;5393.7572809223675;5397.325334333208;5400.567954563626;5456.9358974999495;4675.322078298627;4721.102990431876;4753.524647535219;4755.0489902019735;4763.3807605011125;5707.771689132388;5837.620554663933;5931.762729490858;5932.139839723302;5937.70311484424;6678.532502724763;6722.764703235461;6725.293844146294;6725.932740672629;6727.394534491919;5827.621204621686;5848.37616660394;5895.322037965603;5921.289445266596;5924.052151655801;5832.154337621021;5886.411358864165;5911.674857882857;5917.112433134978;5983.461488466059;6465.515086368447;6468.288488266193;6518.413342799171;6518.706658200297;6524.9673751630935;6670.633115178712;6688.7324507019175;6699.028640846953;6703.66481675924;6706.960421134732;6376.776812811529;6434.260060093149;6441.420272175526;6547.312532184052;6553.770618028346;6586.341365863375;6590.5716128451495;6591.505637077143;6668.166479190101;6669.599824010575;6722.361375669304;6747.021681856005;6748.325167483213;6770.52606317553;6772.627505487048;6416.069669897745;6436.259830119596;6505.186851643544;6520.771772987922;6531.216254049545;6432.292447830641;6433.967830160819;6513.218413790375;6533.901991470037;6537.444317233088;6374;6432.9678351607945;6437.581557198767;6457.773977910751;6475.190601174853;6646;6666.566673166229;6671.299513551007;6677.03183038447;6682.198136223684;6400.743970241138;6444.548881578245;6452.032195170762;6477.578957367945;6480.351964803482 07:21:51 INFO - PID 2678 | |1;ext.html;825.9297959673428;857.4726543175949;887.8179973105513;908.4095338030284;914.3234006834942;42844.35733464001;43299.35050974234;43525.7823710881;43717.34423983635;43796;40188.19623607533;40456.39315410271;40464.79767601165;40560.391594126115;40613.79693101538;6677.565958212725;6868.62222577758;6872.175338959332;6875.6562171891455;6889.724411023578;6594.571352862073;7515.135759387658;7717.922820771804;7733.574653394061;7763.611819409007;7737.535747855119;7785.571793551352;7787.688492460295;7791.1040230373665;7793.76618701437;7512.887306690377;7691;7772.533647981083;7778.2999530042;7782.883256751154;7596.772096837104;7662.1954694756805;7663.386929045663;7665.655045522964;7666.540007599506;39779;40073.79963100166;40242.798786005886;40282.79858600718;40285;3505.4566542186003;3518.296340731864;3528.523649307336;3534.1871369585137;3537.893863184109;32151.83924080388;32240.355192896244;32308.676913230804;32322.35355292881;32353;4789.4971028042255;4810.326554282403;4813.013332266877;4839.7338146401935;4853.635977301681;226492;233316;234776;234867;234946;52267;52302;52407.47592524102;52511.737441313315;52674.47325526772;55464.16803747947;56769;56830.147547786815;56926;56939;17253.654926901392;17356.305747769948;17364.131793410532;17369.392071277445;17380;14316.498922537661;14316.713665726627;14338.784918226234;14388.496402626068;14395;14966.775498367533;15097.54707358781;15124.470643527424;15160.166190859609;15281.541553753405;5979.820605381846;6101.8474538136015;6104.725287362079;6116.388361163937;6157.230346206724;1003.6788227767045;1014.2443879309961;1026.707388394319;1027.5324727249083;1030.8762948446235;23535.52928941446;23715.407114821923;23722.04472843471;29621.25946851346;30411.23971900676;1098.340995402768;1099.0050221742201;1102.9172812039128;1104.9944750276197;1117.19594779775;12738;12895.548655797189;12898.226106433456;13100.475980960846;13166.341682916007;232088;232932;233247;233469;234235;55125.72437137789;55424.722876386164;59777;61174;61275.69362153161;1425.543825975678;1490.3442485306648;1498.220925118932;1500.6173425776358;1508.6982603479348;28328;28712.138635840958;28794.85602571974;29125;29395.85302073476;53223.4677653234;53748.73125634347;53803.46196537984;53803.46196537984;53863.73068134791;220873;221367;223392;223610;223860;36691;36774.44838327481;36839.81580092083;37518.624813751514;37574.43638345372;44751.55248447474;46490.535094649975;47073;47114.52885471102;47249;33032.33935321232;33454.163645909044;33487.83256083704;33747.15632109217;34092.829535853154;32943.176420589676;33083.669163308055;33257.334853302316;33405.49891751674;33459.33081338311;36523.269534608626;36846.44730328993;37021.25957480782;37074;37149.25701485901;31946.20134496656;32068.19829504281;32243.516347255278;32378;32607.18482037873;24167.75832241655;24265.75734242635;24378.390540236636;24645.137420190207;24692.259232223063 07:21:51 INFO - PID 2678 | |2;jquery.html;565.4486875296586;568.8037627018678;569.3054473542277;578.0317967404599;596.7583128832823;21918.123275069;22623;22949.196778112768;22995.655065174036;23018.96414661342;26369.472610547826;26816.329591760215;27045;27055.970802189866;27065.594016089774;6597.83505412365;6743.696533655997;6743.730250789962;6747.359000894907;6750.054992301082;5832.096025116114;6423.839404014913;6451.80644580661;6458.451031662291;6464.288928217892;6366.968165159191;6414.294427612982;6424.421802037839;6425.8714825703455;6431.163948686664;6377.1709677742065;6378.138951241593;6381.7766378176775;6391.45672617828;6435.549511534195;5972.283326000865;5975.820725378246;5977.671228082454;5980.611260268069;5998.820035398945;29681.406371872657;29826;30465.23836904095;30811.691883081105;30907.690923090708;1823.8176182381787;1865.7014877619515;1867.5144462439864;1869.0094250047496;1869.6447674941717;18547.165377557907;18564.257429702797;18823.152958116916;18898.52753681155;18905.527361816065;2355.5759963206615;2363.869987150706;2421.9394515137087;2422.915197968063;2437.8537287762615;137387;141969;142047.28976355155;142141;142299;14754.926225368805;15032.323545440482;15074.54776356711;15434.845651543565;15690.843091568939;24194.274171774523;24241.757582424303;24275;24294.635580466307;24418.389540261636;10168.847467287997;10548.208884333706;10672.893271067345;10823.729406764895;10849.45752712377;8708.95645521781;9068.773280668036;9898.356606820533;10002.249831262685;10075.496225188712;10385.792284154426;11502.884971150348;11670.183087183816;11866.940665296619;11954.820677689842;3759.4924685167152;3971.960280397159;4024.2353952749468;4408.823647054146;4426.800793964279;941.18117238002;964.7636329099275;976.2531663277598;979.8873129590046;993.2699465892563;19803.40589782309;20181.164113960105;20227.79772202259;20630.381088567367;20637.071331790106;1029.27950434696;1042.0933787604831;1043.2905624175482;1044.7753732947301;1052.095198129608;11070.944645276883;11248.212625116163;11305.547778088949;11332.150088743378;11359.545618175345;465778;467125;467133;467384;479218;116368;117726;118457;119063;119250.4037479807;1185.2236784905901;1188.7087663522493;1194.6057800925673;1207.335965219126;1211.5032836536977;17681.823181768534;17809.73285400694;17879.553011174823;18111.275548977894;18248.36130735418;57101.14348284696;58088;58173.127403089835;58823.11765323438;59398;73638.26361736529;73740.63129684531;74191.62904185445;74756.2524374771;75538.24461755312;20605.58788824245;20714.171433142506;20900.059497322352;20981.160753569686;20981.89509052506;23420.414489637897;23876.641850372605;23955;24438;25270;19301.4209573713;19312.61374772525;19371.612567748285;19435;19553;16360.590985225464;16668.49994500167;16881.493555193363;16898.831011689726;17310.913445432692;17502.73745893787;17523.21145548479;17858.732119017965;19896.403107906786;20123.396298110496;14181.858181418054;14430.350634221695;14493.710125797636;14512.782308265174;15250;18963.90518047401;18982.620347593245;19130.330438434587;19135;19304.13131409062 07:21:51 INFO - PID 2678 | |3;mootools.html;1387.646150231691;1440.4886265375792;1453.4622189789773;1455.4178328668525;1458.3364569121052;11863.822042669357;12406.317652529118;12421.192622479533;14091.78862317066;14556.563303100924;14178.14931104132;14449.133052016887;14464.855351446482;14473.276336183202;14489.78265326021;2564.76917077463;2633.934151646205;2682.316009417596;2698.3658840172543;2701.6217729517884;2673.5054015007286;2765.9170224893187;2769.7922655800794;2771.140946306641;2771.6812566554904;2706.120510833977;2737.178846346098;2757.1039412191017;2765.4883846488465;2770.321271288537;2622.5279449699046;2671.051776619301;2680.0217920459086;2688.4085501189707;2691.9192424227303;2583.4833033393397;2610.2169349195356;2619.240420278117;2622.960655590168;2651.4962157190266;13532.458701651922;13857.58427247174;13894;13932.860671393257;13935.790963135561;7760.650770715275;8032.759017229492;8072.112067672551;8084.272415482576;8102.918970810334;5214.687118772886;5321.627486075976;5381.946180538183;5476.534494567966;5487.945120548783;1812.6102887879038;1820.3430799608075;1824.8905065696101;1863.4223390748912;1873.8969356685377;23560.29319120412;23740.881295593583;23759.881200593885;23817.404564885845;23829.285121446384;6564.86870262592;6569.408753212234;6591.934080659228;6777.796666100025;6800.795976120724;15855.52433426999;15977.360905563648;16001.839981600035;16019.519414417586;16027.839721602635;7618.428617853572;7751.806204844811;7767.339776119094;7781.41639377049;7783.883241751379;7064.43484521237;7215.422766178693;7424.0348754661545;7448.441366897396;7455.329020388191;5115.64190506661;5323.813666521653;5331.653442526223;5349.732513374316;5383;1478.977815332771;1494.305148106136;1500.9849901501063;1528.0449718925672;1543.6526781474304;889.5907882374051;928.8653145293895;929.1869614087673;939.5020639061308;946.3375637054089;7569.621518924032;7647.923520764721;7651.081870175614;7660.923390766021;7714.884276735854;732.9450291228179;735.6358602491694;737.0528870401508;746.8991686122413;754.8226166850785;4692.085043416501;4885.120678277873;5096.694198348111;5210.062188805976;5281.55106815925;17484;18146.45560633183;19537.80462195388;19794;19937.202511899653;18758.81241187598;19746.40760777179;19753.308634197732;19793.10931008108;19884.70172947407;10559.524821383056;10633.149348052137;10840.241183117263;10907.509162087725;10911.781764364669;7750.457467977188;7772.727954521564;7893.960530197542;8165.305948994402;8249.670013199404;15703.450379236672;15706.607334816721;16287.67424651524;16458.259378327766;16858.747118792984;16059.27733251983;16479.588010299838;17272.136393180543;17347.566310841827;17556;10897.12822974176;10958.506867190836;10973.780524389627;10979.945100274448;11062.557497700001;12635.557755478514;12639.431225594686;12771.61685149447;12778.424970876518;12838.486460541473;10150.543225555015;10359.689209323733;10424.843627345748;10440.477976101012;10557.894421055691;10366.740831479274;10740.677779666623;10781.137508999418;10876.18428617841;10935.28920620157;8848.646054157762;9134.040925702971;9232.723018309462;9238;9425.293103017164;7171.318724721144;7250.274972502708;7299.9270007301375;7317.304856038668;7330.450216233698;7294.890576641461;7428.665710043169;7439.442041846775;7455.7017719290625;7524.924750752422 07:21:51 INFO - PID 2678 | |4;prototype.html;496.63745465809967;499.2511233150277;528.2182370092263;528.362226073484;536.0806217337268;6187.762447510493;6191.164192833966;6202.511397264658;6216.751329946796;6274.2470903491585;5877.559183061266;6035.18524999125;6046.7883624073165;6060.333363330041;6144.3548427415035;4823.252395878627;4858.927116093261;4875.24433712775;4913.901721965559;4925.729084900329;4764.880877978044;4905.754712264373;4949.529794669518;4953.4798846121175;4979.676321039139;4853.635977301698;4886.485189591221;4904.117258893398;4928.531789479994;4954.702717836942;4902.803887844482;4905.386826646669;4908.901821963576;4924.2367433047575;4926.531979461927;4395.384646149541;4409.184300904343;4421.977890110561;4425;4450.221211288012;5912.556558258105;6009.669468179249;6011.669358185298;6095.817125486243;6100.328963813977;5657.717114144318;5685.630434021817;5711.143328500758;5720.11338242573;5734.541236701054;6422.807315780534;6485.319041500622;6515.153030106056;6524.748961608238;6552.180977377828;4892.706437613754;4892.779824907852;4912.435069966964;4915.139850526144;4923.37528615556;6891.483138764613;6937.410320122795;6970.546914450544;6977.616231107287;6981.127359080115;4959.2561115832195;4962.280469331999;4986.177280748709;5018.780468312987;5028.371453568304;5032.924506132411;5057.8735531612;5058.4435712071645;5086.415062267886;5110.9488905110475;5620.634658747168;5680.744366503517;5712.200291959129;5714.314282286069;5740.167675687002;6463.321351258144;6556.311587283362;6585.5719378240265;6592.901106483407;6626.171728533934;1668.649583587436;1701.906395148254;1721.1136264823626;1736.6873962686584;1758.5955230297104;1206.4691535724428;1209.9879001209874;1214.1136970011942;1227.490591404575;1232.445399570179;5669.137085771659;5675.659460432387;5714.514266287412;5743.765090505478;5753.798617048467;6547.705353259114;6569.9343006569325;6650.800475985729;6719.160104986877;6737.966310168418;5713.857153571194;5743.368229494752;5753.395893431213;5823.883522329615;5865.706714664249;3561.8397172127316;3585.2470981093743;3586.3544561979093;3628.9818550907075;3631.927361452809;6551.541392102602;6560;6587.440067594308;6592.703328350236;6611.768588099393;6878.3465570770695;6882.793516194522;6902.102726645604;6922.731132311053;6940.687669054904;6436.903446448307;6464.838379040561;6487.416132548094;6555.115059467006;6592.450774067995;6640.601563906181;6659.433948114464;6678.49911256648;6681.498887583353;6700.195976482853;6557.245916719638;6635.966820165868;6650.83372915681;6656.7337306509135;6717.798466046026;6470.741170353133;6473.190851143607;6474.805755827333;6516.674166291761;6539.901901471577;4834.685745426536;4903.068417000758;4909.754512274443;4918.262260660929;4946.727929963887;6614.3385661435395;6745.898811517733;6761.492888033319;6782.423494003065;6792.796216113525;6499.057636642755;6522.510811689048;6546.116274303098;6569.57297775643;6572.80281591553;6492.28584855656;6531.216254049545;6531.379518945692;6542.44389226902;6582.308857569887;6017.31363861147;6160.507159427325;6273.52948528853;6273.874522509615;6400.935990640221;6413.807585772434;6415.390537898892;6440.9388995520985;6448.903266450913;6481.546291759531;6196.3803619639475;6202.666426718277;6273.843153921189;6285.454390971664;6288.402601752826 07:21:51 INFO - PID 2678 | |5;yui.html;899.9640014399424;917.1791246834084;923.8152369526097;925.500229875867;930.4045410937001;17873.642527149448;18788.90605546974;18834.529136771587;18906.960117193565;20426.897865510688;18979.810201897977;19107.71338429921;19124.61750764984;19233.711494327596;19255.61488770224;968.7529679931607;1012.8126296635146;1044.17510166968;1053.0417320238585;1062.198040479437;1071.6035067025211;1072.404815327493;1073.4632683658172;1076.5532304093792;1078.4877183337892;1073.420353009374;1081.7944590527775;1082.69684488343;1087.374759513279;1087.7933192693401;1077.3105212663902;1077.536659236528;1080.4543705428748;1081.4268437727937;1084.8589683341154;786.4612740272875;790.8260182759784;791.4064451661254;794.9324307433875;796.040770871099;18076.18657160431;18081.457556273333;18143.274269029356;18208.271669133217;18895.62208755817;20907.26824561133;20928;21330.573388532142;21351.786482135136;21544.784552154433;16294.34822607106;16786.496405107868;16915;17086.060266685326;17094.230759615846;3602.9279414411826;3609.6931760800103;3626.6192049834917;3631.8728844490315;3639.290338384016;128747;128768.35615821861;130277.34861325727;132249;133889.3305533476;16075.196240187945;16087.517374478784;16496.917515412348;16543.172841357886;16625;30527.847360763055;31297;31347.843260784008;31813.52279715806;32279.51580726291;7015.614141222281;8711.433756805787;8730.956345218234;8853.468791872509;8868.379213454997;3301.4057469655213;3423.7432192585657;3428.3828910796296;3428.9485657715154;3656.469811877263;5196.636235463481;5263.289455923401;5275.973620131952;5292.259083728281;5345.839624811262;980.2599037726471;998.7852611688522;1097.25386737018;1105.9225854190129;1107.7230692326918;693.4833549005922;699.4684040129538;706.6643344411466;717.150177040209;718.3463048625725;12528.561500347627;13142.60572182836;13598.32008399576;14123.223222722643;14280;661.1867403094221;661.9139511863427;681.8431760695067;710.1691021504852;717.9497435179592;5000.924986125211;5113.795448182105;5162;5246.816361427408;5276.15581506957;100010.4999474998;102088;102866;105106;109227.45386273018;91244;91979.54010229906;95536;97834;98679;80440;81790;82677.58661206656;84243;85823.14176858151;10433.53049112807;10495.967701640073;10552.261341706007;10558.630447934285;10696.732581685208;34450.310993780484;34761;36021.63978360183;36938.261234775695;37001.259974800894;70913.29086709066;71418.28581714116;71658.28341716724;73857.6307118461;74483.62758186174;19357.322493712654;19999.300024499073;20083.397498075083;20085.297014605003;20196.394108176777;17148;19225.32711355096;21879.12483500642;22106.115755369607;22217.333479995625;18140.90929545344;18477.90761046186;18738.906305468387;18834.52913677169;19004.23983040663;19969.500762480475;20136.79863201349;20579.69130463014;20704.68942965887;20766.273180438613;17796.733049004015;18312.450626481226;18462.723059153854;18821.529461763566;19001.619967600847;14003.159810411;14261.144331340152;14325.212113333866;14473.638159046108;14583.197924114276;14519.637009074857;14661.92669036648;14762.926185369004;14771.514359531939;14863.702725945637 07:21:51 INFO - PID 2678 | __end_tp_report 07:21:51 INFO - PID 2678 | __start_cc_report 07:21:51 INFO - PID 2678 | _x_x_mozilla_cycle_collect,388 07:21:51 INFO - PID 2678 | __end_cc_report 07:21:51 INFO - PID 2678 | __startTimestamp1501770111923__endTimestamp 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | ------- Summary: start ------- 07:21:51 INFO - PID 2678 | Number of tests: 6 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | [#0] dojo.html Cycles:165 Average:6200.43 Median:6434.26 stddev:721.85 (11.2%) stddev-sans-first:683.31 07:21:51 INFO - PID 2678 | Values: 3152.5 3177.2 3177.3 3196.9 3233.2 6232.6 6279.0 6279.2 6306.8 6403.9 6104.5 6162.2 6200.2 6209.6 6214.4 5674.3 5724.6 5727.8 5729.6 5751.5 5785.5 5789.5 5800.7 5801.4 5813.9 5846.2 5846.7 5849.1 5890.5 5943.1 5738.4 5799.4 5818.4 5891.9 5905.3 5628.6 5674.1 5765.8 5776.7 5778.7 6170.0 6215.4 6261.9 6273.2 6323.8 6712.6 6716.1 6739.5 6810.1 6819.1 6745.7 6820.1 6823.7 6825.2 6845.2 6303.1 6326.0 6328.1 6331.6 6338.3 7001.5 7029.6 7054.7 7065.1 7070.4 6617.2 6631.6 6642.2 6735.9 6737.0 6552.2 6647.6 6757.4 6778.1 6867.9 6613.8 6630.2 6634.3 6637.5 6643.3 6677.0 6681.9 6711.6 6711.8 6726.2 5392.4 5393.8 5397.3 5400.6 5456.9 4675.3 4721.1 4753.5 4755.0 4763.4 5707.8 5837.6 5931.8 5932.1 5937.7 6678.5 6722.8 6725.3 6725.9 6727.4 5827.6 5848.4 5895.3 5921.3 5924.1 5832.2 5886.4 5911.7 5917.1 5983.5 6465.5 6468.3 6518.4 6518.7 6525.0 6670.6 6688.7 6699.0 6703.7 6707.0 6376.8 6434.3 6441.4 6547.3 6553.8 6586.3 6590.6 6591.5 6668.2 6669.6 6722.4 6747.0 6748.3 6770.5 6772.6 6416.1 6436.3 6505.2 6520.8 6531.2 6432.3 6434.0 6513.2 6533.9 6537.4 6374.0 6433.0 6437.6 6457.8 6475.2 6646.0 6666.6 6671.3 6677.0 6682.2 6400.7 6444.5 6452.0 6477.6 6480.4 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | [#1] ext.html Cycles:180 Average:41152.41 Median:36607.13 stddev:59614.56 (162.8%) stddev-sans-first:59704.89 07:21:51 INFO - PID 2678 | Values: 825.9 857.5 887.8 908.4 914.3 42844.4 43299.4 43525.8 43717.3 43796.0 40188.2 40456.4 40464.8 40560.4 40613.8 6677.6 6868.6 6872.2 6875.7 6889.7 6594.6 7515.1 7717.9 7733.6 7763.6 7737.5 7785.6 7787.7 7791.1 7793.8 7512.9 7691.0 7772.5 7778.3 7782.9 7596.8 7662.2 7663.4 7665.7 7666.5 39779.0 40073.8 40242.8 40282.8 40285.0 3505.5 3518.3 3528.5 3534.2 3537.9 32151.8 32240.4 32308.7 32322.4 32353.0 4789.5 4810.3 4813.0 4839.7 4853.6 226492.0 233316.0 234776.0 234867.0 234946.0 52267.0 52302.0 52407.5 52511.7 52674.5 55464.2 56769.0 56830.1 56926.0 56939.0 17253.7 17356.3 17364.1 17369.4 17380.0 14316.5 14316.7 14338.8 14388.5 14395.0 14966.8 15097.5 15124.5 15160.2 15281.5 5979.8 6101.8 6104.7 6116.4 6157.2 1003.7 1014.2 1026.7 1027.5 1030.9 23535.5 23715.4 23722.0 29621.3 30411.2 1098.3 1099.0 1102.9 1105.0 1117.2 12738.0 12895.5 12898.2 13100.5 13166.3 232088.0 232932.0 233247.0 233469.0 234235.0 55125.7 55424.7 59777.0 61174.0 61275.7 1425.5 1490.3 1498.2 1500.6 1508.7 28328.0 28712.1 28794.9 29125.0 29395.9 53223.5 53748.7 53803.5 53803.5 53863.7 220873.0 221367.0 223392.0 223610.0 223860.0 36691.0 36774.4 36839.8 37518.6 37574.4 44751.6 46490.5 47073.0 47114.5 47249.0 33032.3 33454.2 33487.8 33747.2 34092.8 32943.2 33083.7 33257.3 33405.5 33459.3 36523.3 36846.4 37021.3 37074.0 37149.3 31946.2 32068.2 32243.5 32378.0 32607.2 24167.8 24265.8 24378.4 24645.1 24692.3 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | [#2] jquery.html Cycles:180 Average:34948.40 Median:20981.53 stddev:79544.55 (379.1%) stddev-sans-first:79725.80 07:21:51 INFO - PID 2678 | Values: 565.4 568.8 569.3 578.0 596.8 21918.1 22623.0 22949.2 22995.7 23019.0 26369.5 26816.3 27045.0 27056.0 27065.6 6597.8 6743.7 6743.7 6747.4 6750.1 5832.1 6423.8 6451.8 6458.5 6464.3 6367.0 6414.3 6424.4 6425.9 6431.2 6377.2 6378.1 6381.8 6391.5 6435.5 5972.3 5975.8 5977.7 5980.6 5998.8 29681.4 29826.0 30465.2 30811.7 30907.7 1823.8 1865.7 1867.5 1869.0 1869.6 18547.2 18564.3 18823.2 18898.5 18905.5 2355.6 2363.9 2421.9 2422.9 2437.9 137387.0 141969.0 142047.3 142141.0 142299.0 14754.9 15032.3 15074.5 15434.8 15690.8 24194.3 24241.8 24275.0 24294.6 24418.4 10168.8 10548.2 10672.9 10823.7 10849.5 8709.0 9068.8 9898.4 10002.2 10075.5 10385.8 11502.9 11670.2 11866.9 11954.8 3759.5 3972.0 4024.2 4408.8 4426.8 941.2 964.8 976.3 979.9 993.3 19803.4 20181.2 20227.8 20630.4 20637.1 1029.3 1042.1 1043.3 1044.8 1052.1 11070.9 11248.2 11305.5 11332.2 11359.5 465778.0 467125.0 467133.0 467384.0 479218.0 116368.0 117726.0 118457.0 119063.0 119250.4 1185.2 1188.7 1194.6 1207.3 1211.5 17681.8 17809.7 17879.6 18111.3 18248.4 57101.1 58088.0 58173.1 58823.1 59398.0 73638.3 73740.6 74191.6 74756.3 75538.2 20605.6 20714.2 20900.1 20981.2 20981.9 23420.4 23876.6 23955.0 24438.0 25270.0 19301.4 19312.6 19371.6 19435.0 19553.0 16360.6 16668.5 16881.5 16898.8 17310.9 17502.7 17523.2 17858.7 19896.4 20123.4 14181.9 14430.4 14493.7 14512.8 15250.0 18963.9 18982.6 19130.3 19135.0 19304.1 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | [#3] mootools.html Cycles:180 Average:8699.44 Median:2628.45 stddev:5900.76 (224.5%) stddev-sans-first:5891.74 07:21:51 INFO - PID 2678 | Values: 1387.6 1440.5 1453.5 1455.4 1458.3 11863.8 12406.3 12421.2 14091.8 14556.6 14178.1 14449.1 14464.9 14473.3 14489.8 2564.8 2633.9 2682.3 2698.4 2701.6 2673.5 2765.9 2769.8 2771.1 2771.7 2706.1 2737.2 2757.1 2765.5 2770.3 2622.5 2671.1 2680.0 2688.4 2691.9 2583.5 2610.2 2619.2 2623.0 2651.5 13532.5 13857.6 13894.0 13932.9 13935.8 7760.7 8032.8 8072.1 8084.3 8102.9 5214.7 5321.6 5381.9 5476.5 5487.9 1812.6 1820.3 1824.9 1863.4 1873.9 23560.3 23740.9 23759.9 23817.4 23829.3 6564.9 6569.4 6591.9 6777.8 6800.8 15855.5 15977.4 16001.8 16019.5 16027.8 7618.4 7751.8 7767.3 7781.4 7783.9 7064.4 7215.4 7424.0 7448.4 7455.3 5115.6 5323.8 5331.7 5349.7 5383.0 1479.0 1494.3 1501.0 1528.0 1543.7 889.6 928.9 929.2 939.5 946.3 7569.6 7647.9 7651.1 7660.9 7714.9 732.9 735.6 737.1 746.9 754.8 4692.1 4885.1 5096.7 5210.1 5281.6 17484.0 18146.5 19537.8 19794.0 19937.2 18758.8 19746.4 19753.3 19793.1 19884.7 10559.5 10633.1 10840.2 10907.5 10911.8 7750.5 7772.7 7894.0 8165.3 8249.7 15703.5 15706.6 16287.7 16458.3 16858.7 16059.3 16479.6 17272.1 17347.6 17556.0 10897.1 10958.5 10973.8 10979.9 11062.6 12635.6 12639.4 12771.6 12778.4 12838.5 10150.5 10359.7 10424.8 10440.5 10557.9 10366.7 10740.7 10781.1 10876.2 10935.3 8848.6 9134.0 9232.7 9238.0 9425.3 7171.3 7250.3 7299.9 7317.3 7330.5 7294.9 7428.7 7439.4 7455.7 7524.9 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | [#4] prototype.html Cycles:180 Average:5480.83 Median:6040.99 stddev:1542.83 (25.5%) stddev-sans-first:1501.11 07:21:51 INFO - PID 2678 | Values: 496.6 499.3 528.2 528.4 536.1 6187.8 6191.2 6202.5 6216.8 6274.2 5877.6 6035.2 6046.8 6060.3 6144.4 4823.3 4858.9 4875.2 4913.9 4925.7 4764.9 4905.8 4949.5 4953.5 4979.7 4853.6 4886.5 4904.1 4928.5 4954.7 4902.8 4905.4 4908.9 4924.2 4926.5 4395.4 4409.2 4422.0 4425.0 4450.2 5912.6 6009.7 6011.7 6095.8 6100.3 5657.7 5685.6 5711.1 5720.1 5734.5 6422.8 6485.3 6515.2 6524.7 6552.2 4892.7 4892.8 4912.4 4915.1 4923.4 6891.5 6937.4 6970.5 6977.6 6981.1 4959.3 4962.3 4986.2 5018.8 5028.4 5032.9 5057.9 5058.4 5086.4 5110.9 5620.6 5680.7 5712.2 5714.3 5740.2 6463.3 6556.3 6585.6 6592.9 6626.2 1668.6 1701.9 1721.1 1736.7 1758.6 1206.5 1210.0 1214.1 1227.5 1232.4 5669.1 5675.7 5714.5 5743.8 5753.8 6547.7 6569.9 6650.8 6719.2 6738.0 5713.9 5743.4 5753.4 5823.9 5865.7 3561.8 3585.2 3586.4 3629.0 3631.9 6551.5 6560.0 6587.4 6592.7 6611.8 6878.3 6882.8 6902.1 6922.7 6940.7 6436.9 6464.8 6487.4 6555.1 6592.5 6640.6 6659.4 6678.5 6681.5 6700.2 6557.2 6636.0 6650.8 6656.7 6717.8 6470.7 6473.2 6474.8 6516.7 6539.9 4834.7 4903.1 4909.8 4918.3 4946.7 6614.3 6745.9 6761.5 6782.4 6792.8 6499.1 6522.5 6546.1 6569.6 6572.8 6492.3 6531.2 6531.4 6542.4 6582.3 6017.3 6160.5 6273.5 6273.9 6400.9 6413.8 6415.4 6440.9 6448.9 6481.5 6196.4 6202.7 6273.8 6285.5 6288.4 07:21:51 INFO - PID 2678 | 07:21:51 INFO - PID 2678 | [#5] yui.html Cycles:180 Average:23576.53 Median:20041.35 stddev:31810.99 (158.7%) stddev-sans-first:31854.65 07:21:51 INFO - PID 2678 | Values: 900.0 917.2 923.8 925.5 930.4 17873.6 18788.9 18834.5 18907.0 20426.9 18979.8 19107.7 19124.6 19233.7 19255.6 968.8 1012.8 1044.2 1053.0 1062.2 1071.6 1072.4 1073.5 1076.6 1078.5 1073.4 1081.8 1082.7 1087.4 1087.8 1077.3 1077.5 1080.5 1081.4 1084.9 786.5 790.8 791.4 794.9 796.0 18076.2 18081.5 18143.3 18208.3 18895.6 20907.3 20928.0 21330.6 21351.8 21544.8 16294.3 16786.5 16915.0 17086.1 17094.2 3602.9 3609.7 3626.6 3631.9 3639.3 128747.0 128768.4 130277.3 132249.0 133889.3 16075.2 16087.5 16496.9 16543.2 16625.0 30527.8 31297.0 31347.8 31813.5 32279.5 7015.6 8711.4 8731.0 8853.5 8868.4 3301.4 3423.7 3428.4 3428.9 3656.5 5196.6 5263.3 5276.0 5292.3 5345.8 980.3 998.8 1097.3 1105.9 1107.7 693.5 699.5 706.7 717.2 718.3 12528.6 13142.6 13598.3 14123.2 14280.0 661.2 661.9 681.8 710.2 717.9 5000.9 5113.8 5162.0 5246.8 5276.2 100010.5 102088.0 102866.0 105106.0 109227.5 91244.0 91979.5 95536.0 97834.0 98679.0 80440.0 81790.0 82677.6 84243.0 85823.1 10433.5 10496.0 10552.3 10558.6 10696.7 34450.3 34761.0 36021.6 36938.3 37001.3 70913.3 71418.3 71658.3 73857.6 74483.6 19357.3 19999.3 20083.4 20085.3 20196.4 17148.0 19225.3 21879.1 22106.1 22217.3 18140.9 18477.9 18738.9 18834.5 19004.2 19969.5 20136.8 20579.7 20704.7 20766.3 17796.7 18312.5 18462.7 18821.5 19001.6 14003.2 14261.1 14325.2 14473.6 14583.2 14519.6 14661.9 14762.9 14771.5 14863.7 07:21:51 INFO - PID 2678 | -------- Summary: end -------- 07:21:51 INFO - PID 2678 | 07:21:52 INFO - TEST-INFO | 2678: exit 0 07:21:52 INFO - TEST-OK | dromaeo_css | took 1114317ms 07:21:52 INFO - TEST-START | kraken 07:21:52 INFO - Initialising browser for kraken test... 07:21:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58512/getInfo.html -profile /tmp/tmp3oIUDI/profile 07:21:52 INFO - TEST-INFO | started process 3143 (/builds/slave/test/build/application/firefox/firefox http://localhost:58512/getInfo.html) 07:21:58 INFO - TEST-INFO | 3143: exit 0 07:21:58 INFO - Browser initialized. 07:21:58 INFO - Running cycle 1/1 for kraken test... 07:21:58 INFO - TEST-INFO | started process 3350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3oIUDI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:59 INFO - PID 3350 | 07:21:59 INFO - PID 3350 | (/builds/slave/test/build/application/firefox/firefox:3399): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:21:59 INFO - PID 3350 | 07:22:09 INFO - PID 3350 | RSS: Main: 171208704 07:22:09 INFO - PID 3350 | 07:22:12 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58512/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:13 INFO - PID 3350 | RSS: Main: 176427008 07:22:13 INFO - PID 3350 | 07:22:16 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58512/tests/kraken/driver.html?testName=audio-dft) 07:22:16 INFO - PID 3350 | RSS: Main: 177053696 07:22:16 INFO - PID 3350 | 07:22:19 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58512/tests/kraken/driver.html?testName=audio-fft) 07:22:20 INFO - PID 3350 | RSS: Main: 171749376 07:22:20 INFO - PID 3350 | 07:22:22 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58512/tests/kraken/driver.html?testName=audio-oscillator) 07:22:23 INFO - PID 3350 | RSS: Main: 172597248 07:22:23 INFO - PID 3350 | 07:22:25 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:22:25 INFO - PID 3350 | RSS: Main: 173064192 07:22:25 INFO - PID 3350 | 07:22:29 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58512/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:29 INFO - PID 3350 | RSS: Main: 174968832 07:22:29 INFO - PID 3350 | 07:22:33 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58512/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:33 INFO - PID 3350 | RSS: Main: 175501312 07:22:33 INFO - PID 3350 | 07:22:36 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58512/tests/kraken/driver.html?testName=json-parse-financial) 07:22:37 INFO - PID 3350 | RSS: Main: 175267840 07:22:37 INFO - PID 3350 | 07:22:38 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:22:39 INFO - PID 3350 | RSS: Main: 175427584 07:22:39 INFO - PID 3350 | 07:22:41 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:22:41 INFO - PID 3350 | RSS: Main: 175157248 07:22:41 INFO - PID 3350 | 07:22:44 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:22:44 INFO - PID 3350 | RSS: Main: 172654592 07:22:44 INFO - PID 3350 | 07:22:47 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:22:48 INFO - PID 3350 | RSS: Main: 173199360 07:22:48 INFO - PID 3350 | 07:22:51 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:22:51 INFO - PID 3350 | RSS: Main: 173383680 07:22:51 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | Cycle 1(1): loaded http://localhost:58512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58512/tests/kraken/driver.html?testName=ai-astar) 07:22:53 INFO - PID 3350 | RSS: Main: 174845952 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | __start_tp_report 07:22:53 INFO - PID 3350 | _x_x_mozilla_page_load 07:22:53 INFO - PID 3350 | _x_x_mozilla_page_load_details 07:22:53 INFO - PID 3350 | |i|pagename|runs| 07:22:53 INFO - PID 3350 | |0;ai-astar;100;107;104;108;107;111;112;101;109;111 07:22:53 INFO - PID 3350 | |1;audio-beat-detection;142;120;143;162;120;151;150;117;188;125 07:22:53 INFO - PID 3350 | |2;audio-dft;164;163;170;162;163;163;167;164;168;162 07:22:53 INFO - PID 3350 | |3;audio-fft;78;75;74;177;76;74;75;90;96;76 07:22:53 INFO - PID 3350 | |4;audio-oscillator;82;79;132;78;78;78;129;78;78;124 07:22:53 INFO - PID 3350 | |5;imaging-gaussian-blur;114;114;114;115;114;114;114;119;114;114 07:22:53 INFO - PID 3350 | |6;imaging-darkroom;151;151;151;151;151;151;151;152;151;151 07:22:53 INFO - PID 3350 | |7;imaging-desaturate;95;94;94;94;94;94;95;95;94;94 07:22:53 INFO - PID 3350 | |8;json-parse-financial;58;55;57;57;55;56;55;56;56;55 07:22:53 INFO - PID 3350 | |9;json-stringify-tinderbox;53;53;54;55;53;53;54;53;54;53 07:22:53 INFO - PID 3350 | |10;stanford-crypto-aes;78;91;79;89;77;76;78;88;96;78 07:22:53 INFO - PID 3350 | |11;stanford-crypto-ccm;138;126;124;132;123;125;129;123;126;166 07:22:53 INFO - PID 3350 | |12;stanford-crypto-pbkdf2;176;178;180;173;170;178;174;179;176;177 07:22:53 INFO - PID 3350 | |13;stanford-crypto-sha256-iterative;67;67;76;71;66;67;65;70;67;66 07:22:53 INFO - PID 3350 | __end_tp_report 07:22:53 INFO - PID 3350 | __start_cc_report 07:22:53 INFO - PID 3350 | _x_x_mozilla_cycle_collect,1008 07:22:53 INFO - PID 3350 | __end_cc_report 07:22:53 INFO - PID 3350 | __startTimestamp1501770173852__endTimestamp 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | ------- Summary: start ------- 07:22:53 INFO - PID 3350 | Number of tests: 14 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.50 stddev:4.16 (3.8%) stddev-sans-first:3.56 07:22:53 INFO - PID 3350 | Values: 100.0 107.0 104.0 108.0 107.0 111.0 112.0 101.0 109.0 111.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:146.50 stddev:22.47 (15.3%) stddev-sans-first:23.83 07:22:53 INFO - PID 3350 | Values: 142.0 120.0 143.0 162.0 120.0 151.0 150.0 117.0 188.0 125.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 07:22:53 INFO - PID 3350 | Values: 164.0 163.0 170.0 162.0 163.0 163.0 167.0 164.0 168.0 162.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#3] audio-fft Cycles:10 Average:89.10 Median:76.00 stddev:31.79 (41.8%) stddev-sans-first:33.46 07:22:53 INFO - PID 3350 | Values: 78.0 75.0 74.0 177.0 76.0 74.0 75.0 90.0 96.0 76.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:78.00 stddev:24.07 (30.9%) stddev-sans-first:25.17 07:22:53 INFO - PID 3350 | Values: 82.0 79.0 132.0 78.0 78.0 78.0 129.0 78.0 78.0 124.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.66 07:22:53 INFO - PID 3350 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 114.0 119.0 114.0 114.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:22:53 INFO - PID 3350 | Values: 151.0 151.0 151.0 151.0 151.0 151.0 151.0 152.0 151.0 151.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:22:53 INFO - PID 3350 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:0.83 07:22:53 INFO - PID 3350 | Values: 58.0 55.0 57.0 57.0 55.0 56.0 55.0 56.0 56.0 55.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 07:22:53 INFO - PID 3350 | Values: 53.0 53.0 54.0 55.0 53.0 53.0 54.0 53.0 54.0 53.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:7.23 (8.7%) stddev-sans-first:7.43 07:22:53 INFO - PID 3350 | Values: 78.0 91.0 79.0 89.0 77.0 76.0 78.0 88.0 96.0 78.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:127.50 stddev:13.09 (10.3%) stddev-sans-first:13.65 07:22:53 INFO - PID 3350 | Values: 138.0 126.0 124.0 132.0 123.0 125.0 129.0 123.0 126.0 166.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.50 stddev:3.03 (1.7%) stddev-sans-first:3.22 07:22:53 INFO - PID 3350 | Values: 176.0 178.0 180.0 173.0 170.0 178.0 174.0 179.0 176.0 177.0 07:22:53 INFO - PID 3350 | 07:22:53 INFO - PID 3350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:3.29 (4.9%) stddev-sans-first:3.46 07:22:53 INFO - PID 3350 | Values: 67.0 67.0 76.0 71.0 66.0 67.0 65.0 70.0 67.0 66.0 07:22:53 INFO - PID 3350 | -------- Summary: end -------- 07:22:53 INFO - PID 3350 | 07:22:54 INFO - PID 3350 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:22:54 INFO - TEST-INFO | 3350: exit 0 07:22:54 INFO - TEST-OK | kraken | took 61917ms 07:22:54 INFO - SUITE-END | took 1176s 07:22:55 INFO - Completed test suite (00:19:36) 07:22:55 INFO - javascript benchmark 07:22:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8599.171507182346, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.4956007038877, 3177.1898165967673, 3177.3168768714722, 3196.8721251149955, 3233.175540237239, 6232.626042437446, 6279.0, 6279.152314437555, 6306.779262725806, 6403.871922561546, 6104.542159338045, 6162.168107305512, 6200.224971878515, 6209.596376235541, 6214.40963108504, 5674.347450043236, 5724.5992780505385, 5727.770889164439, 5729.598928075036, 5751.482366587006, 5785.479306862381, 5789.536837053026, 5800.651960882361, 5801.419858014207, 5813.9418605814035, 5846.23998880145, 5846.736896839652, 5849.122631605251, 5890.499307558863, 5943.108533719955, 5738.42615738427, 5799.420057994188, 5818.389069147721, 5891.911621325662, 5905.320888097881, 5628.577856660726, 5674.148877668383, 5765.769369225268, 5776.653400795965, 5778.682172480512, 6170.043643235305, 6215.409536094064, 6261.937380626181, 6273.215848018997, 6323.841903952392, 6712.630805305706, 6716.09158848785, 6739.460843132587, 6810.148731408574, 6819.079424277708, 6745.696443659998, 6820.147481564804, 6823.727050917957, 6825.180978282638, 6845.178578570603, 6303.0545418187185, 6325.96837015812, 6328.082428047907, 6331.588446750992, 6338.334474880071, 7001.50989430735, 7029.613371264527, 7054.717811287491, 7065.0815393998455, 7070.36366726997, 6617.239017512951, 6631.602103873686, 6642.169728783902, 6735.8989615155815, 6736.966315168393, 6552.180977377828, 6647.60114393138, 6757.358050985247, 6778.118844550177, 6867.896981545281, 6613.768518101843, 6630.237522684856, 6634.303398143125, 6637.46900247979, 6643.269240383554, 6676.9666151668935, 6681.899771503431, 6711.563748356341, 6711.765088221889, 6726.22648395431, 5392.379876314196, 5393.7572809223675, 5397.325334333208, 5400.567954563626, 5456.9358974999495, 4675.322078298627, 4721.102990431876, 4753.524647535219, 4755.0489902019735, 4763.3807605011125, 5707.771689132388, 5837.620554663933, 5931.762729490858, 5932.139839723302, 5937.70311484424, 6678.532502724763, 6722.764703235461, 6725.293844146294, 6725.932740672629, 6727.394534491919, 5827.621204621686, 5848.37616660394, 5895.322037965603, 5921.289445266596, 5924.052151655801, 5832.154337621021, 5886.411358864165, 5911.674857882857, 5917.112433134978, 5983.461488466059, 6465.515086368447, 6468.288488266193, 6518.413342799171, 6518.706658200297, 6524.9673751630935, 6670.633115178712, 6688.7324507019175, 6699.028640846953, 6703.66481675924, 6706.960421134732, 6376.776812811529, 6434.260060093149, 6441.420272175526, 6547.312532184052, 6553.770618028346, 6586.341365863375, 6590.5716128451495, 6591.505637077143, 6668.166479190101, 6669.599824010575, 6722.361375669304, 6747.021681856005, 6748.325167483213, 6770.52606317553, 6772.627505487048, 6416.069669897745, 6436.259830119596, 6505.186851643544, 6520.771772987922, 6531.216254049545, 6432.292447830641, 6433.967830160819, 6513.218413790375, 6533.901991470037, 6537.444317233088, 6374.0, 6432.9678351607945, 6437.581557198767, 6457.773977910751, 6475.190601174853, 6646.0, 6666.566673166229, 6671.299513551007, 6677.03183038447, 6682.198136223684, 6400.743970241138, 6444.548881578245, 6452.032195170762, 6477.578957367945, 6480.351964803482], "value": 6146.788562208591, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.9297959673428, 857.4726543175949, 887.8179973105513, 908.4095338030284, 914.3234006834942, 42844.35733464001, 43299.35050974234, 43525.7823710881, 43717.34423983635, 43796.0, 40188.19623607533, 40456.39315410271, 40464.79767601165, 40560.391594126115, 40613.79693101538, 6677.565958212725, 6868.62222577758, 6872.175338959332, 6875.6562171891455, 6889.724411023578, 6594.571352862073, 7515.135759387658, 7717.922820771804, 7733.574653394061, 7763.611819409007, 7737.535747855119, 7785.571793551352, 7787.688492460295, 7791.1040230373665, 7793.76618701437, 7512.887306690377, 7691.0, 7772.533647981083, 7778.2999530042, 7782.883256751154, 7596.772096837104, 7662.1954694756805, 7663.386929045663, 7665.655045522964, 7666.540007599506, 39779.0, 40073.79963100166, 40242.798786005886, 40282.79858600718, 40285.0, 3505.4566542186003, 3518.296340731864, 3528.523649307336, 3534.1871369585137, 3537.893863184109, 32151.83924080388, 32240.355192896244, 32308.676913230804, 32322.35355292881, 32353.0, 4789.4971028042255, 4810.326554282403, 4813.013332266877, 4839.7338146401935, 4853.635977301681, 226492.0, 233316.0, 234776.0, 234867.0, 234946.0, 52267.0, 52302.0, 52407.47592524102, 52511.737441313315, 52674.47325526772, 55464.16803747947, 56769.0, 56830.147547786815, 56926.0, 56939.0, 17253.654926901392, 17356.305747769948, 17364.131793410532, 17369.392071277445, 17380.0, 14316.498922537661, 14316.713665726627, 14338.784918226234, 14388.496402626068, 14395.0, 14966.775498367533, 15097.54707358781, 15124.470643527424, 15160.166190859609, 15281.541553753405, 5979.820605381846, 6101.8474538136015, 6104.725287362079, 6116.388361163937, 6157.230346206724, 1003.6788227767045, 1014.2443879309961, 1026.707388394319, 1027.5324727249083, 1030.8762948446235, 23535.52928941446, 23715.407114821923, 23722.04472843471, 29621.25946851346, 30411.23971900676, 1098.340995402768, 1099.0050221742201, 1102.9172812039128, 1104.9944750276197, 1117.19594779775, 12738.0, 12895.548655797189, 12898.226106433456, 13100.475980960846, 13166.341682916007, 232088.0, 232932.0, 233247.0, 233469.0, 234235.0, 55125.72437137789, 55424.722876386164, 59777.0, 61174.0, 61275.69362153161, 1425.543825975678, 1490.3442485306648, 1498.220925118932, 1500.6173425776358, 1508.6982603479348, 28328.0, 28712.138635840958, 28794.85602571974, 29125.0, 29395.85302073476, 53223.4677653234, 53748.73125634347, 53803.46196537984, 53803.46196537984, 53863.73068134791, 220873.0, 221367.0, 223392.0, 223610.0, 223860.0, 36691.0, 36774.44838327481, 36839.81580092083, 37518.624813751514, 37574.43638345372, 44751.55248447474, 46490.535094649975, 47073.0, 47114.52885471102, 47249.0, 33032.33935321232, 33454.163645909044, 33487.83256083704, 33747.15632109217, 34092.829535853154, 32943.176420589676, 33083.669163308055, 33257.334853302316, 33405.49891751674, 33459.33081338311, 36523.269534608626, 36846.44730328993, 37021.25957480782, 37074.0, 37149.25701485901, 31946.20134496656, 32068.19829504281, 32243.516347255278, 32378.0, 32607.18482037873, 24167.75832241655, 24265.75734242635, 24378.390540236636, 24645.137420190207, 24692.259232223063], "value": 18102.11472537071, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4486875296586, 568.8037627018678, 569.3054473542277, 578.0317967404599, 596.7583128832823, 21918.123275069, 22623.0, 22949.196778112768, 22995.655065174036, 23018.96414661342, 26369.472610547826, 26816.329591760215, 27045.0, 27055.970802189866, 27065.594016089774, 6597.83505412365, 6743.696533655997, 6743.730250789962, 6747.359000894907, 6750.054992301082, 5832.096025116114, 6423.839404014913, 6451.80644580661, 6458.451031662291, 6464.288928217892, 6366.968165159191, 6414.294427612982, 6424.421802037839, 6425.8714825703455, 6431.163948686664, 6377.1709677742065, 6378.138951241593, 6381.7766378176775, 6391.45672617828, 6435.549511534195, 5972.283326000865, 5975.820725378246, 5977.671228082454, 5980.611260268069, 5998.820035398945, 29681.406371872657, 29826.0, 30465.23836904095, 30811.691883081105, 30907.690923090708, 1823.8176182381787, 1865.7014877619515, 1867.5144462439864, 1869.0094250047496, 1869.6447674941717, 18547.165377557907, 18564.257429702797, 18823.152958116916, 18898.52753681155, 18905.527361816065, 2355.5759963206615, 2363.869987150706, 2421.9394515137087, 2422.915197968063, 2437.8537287762615, 137387.0, 141969.0, 142047.28976355155, 142141.0, 142299.0, 14754.926225368805, 15032.323545440482, 15074.54776356711, 15434.845651543565, 15690.843091568939, 24194.274171774523, 24241.757582424303, 24275.0, 24294.635580466307, 24418.389540261636, 10168.847467287997, 10548.208884333706, 10672.893271067345, 10823.729406764895, 10849.45752712377, 8708.95645521781, 9068.773280668036, 9898.356606820533, 10002.249831262685, 10075.496225188712, 10385.792284154426, 11502.884971150348, 11670.183087183816, 11866.940665296619, 11954.820677689842, 3759.4924685167152, 3971.960280397159, 4024.2353952749468, 4408.823647054146, 4426.800793964279, 941.18117238002, 964.7636329099275, 976.2531663277598, 979.8873129590046, 993.2699465892563, 19803.40589782309, 20181.164113960105, 20227.79772202259, 20630.381088567367, 20637.071331790106, 1029.27950434696, 1042.0933787604831, 1043.2905624175482, 1044.7753732947301, 1052.095198129608, 11070.944645276883, 11248.212625116163, 11305.547778088949, 11332.150088743378, 11359.545618175345, 465778.0, 467125.0, 467133.0, 467384.0, 479218.0, 116368.0, 117726.0, 118457.0, 119063.0, 119250.4037479807, 1185.2236784905901, 1188.7087663522493, 1194.6057800925673, 1207.335965219126, 1211.5032836536977, 17681.823181768534, 17809.73285400694, 17879.553011174823, 18111.275548977894, 18248.36130735418, 57101.14348284696, 58088.0, 58173.127403089835, 58823.11765323438, 59398.0, 73638.26361736529, 73740.63129684531, 74191.62904185445, 74756.2524374771, 75538.24461755312, 20605.58788824245, 20714.171433142506, 20900.059497322352, 20981.160753569686, 20981.89509052506, 23420.414489637897, 23876.641850372605, 23955.0, 24438.0, 25270.0, 19301.4209573713, 19312.61374772525, 19371.612567748285, 19435.0, 19553.0, 16360.590985225464, 16668.49994500167, 16881.493555193363, 16898.831011689726, 17310.913445432692, 17502.73745893787, 17523.21145548479, 17858.732119017965, 19896.403107906786, 20123.396298110496, 14181.858181418054, 14430.350634221695, 14493.710125797636, 14512.782308265174, 15250.0, 18963.90518047401, 18982.620347593245, 19130.330438434587, 19135.0, 19304.13131409062], "value": 12409.17298005885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.646150231691, 1440.4886265375792, 1453.4622189789773, 1455.4178328668525, 1458.3364569121052, 11863.822042669357, 12406.317652529118, 12421.192622479533, 14091.78862317066, 14556.563303100924, 14178.14931104132, 14449.133052016887, 14464.855351446482, 14473.276336183202, 14489.78265326021, 2564.76917077463, 2633.934151646205, 2682.316009417596, 2698.3658840172543, 2701.6217729517884, 2673.5054015007286, 2765.9170224893187, 2769.7922655800794, 2771.140946306641, 2771.6812566554904, 2706.120510833977, 2737.178846346098, 2757.1039412191017, 2765.4883846488465, 2770.321271288537, 2622.5279449699046, 2671.051776619301, 2680.0217920459086, 2688.4085501189707, 2691.9192424227303, 2583.4833033393397, 2610.2169349195356, 2619.240420278117, 2622.960655590168, 2651.4962157190266, 13532.458701651922, 13857.58427247174, 13894.0, 13932.860671393257, 13935.790963135561, 7760.650770715275, 8032.759017229492, 8072.112067672551, 8084.272415482576, 8102.918970810334, 5214.687118772886, 5321.627486075976, 5381.946180538183, 5476.534494567966, 5487.945120548783, 1812.6102887879038, 1820.3430799608075, 1824.8905065696101, 1863.4223390748912, 1873.8969356685377, 23560.29319120412, 23740.881295593583, 23759.881200593885, 23817.404564885845, 23829.285121446384, 6564.86870262592, 6569.408753212234, 6591.934080659228, 6777.796666100025, 6800.795976120724, 15855.52433426999, 15977.360905563648, 16001.839981600035, 16019.519414417586, 16027.839721602635, 7618.428617853572, 7751.806204844811, 7767.339776119094, 7781.41639377049, 7783.883241751379, 7064.43484521237, 7215.422766178693, 7424.0348754661545, 7448.441366897396, 7455.329020388191, 5115.64190506661, 5323.813666521653, 5331.653442526223, 5349.732513374316, 5383.0, 1478.977815332771, 1494.305148106136, 1500.9849901501063, 1528.0449718925672, 1543.6526781474304, 889.5907882374051, 928.8653145293895, 929.1869614087673, 939.5020639061308, 946.3375637054089, 7569.621518924032, 7647.923520764721, 7651.081870175614, 7660.923390766021, 7714.884276735854, 732.9450291228179, 735.6358602491694, 737.0528870401508, 746.8991686122413, 754.8226166850785, 4692.085043416501, 4885.120678277873, 5096.694198348111, 5210.062188805976, 5281.55106815925, 17484.0, 18146.45560633183, 19537.80462195388, 19794.0, 19937.202511899653, 18758.81241187598, 19746.40760777179, 19753.308634197732, 19793.10931008108, 19884.70172947407, 10559.524821383056, 10633.149348052137, 10840.241183117263, 10907.509162087725, 10911.781764364669, 7750.457467977188, 7772.727954521564, 7893.960530197542, 8165.305948994402, 8249.670013199404, 15703.450379236672, 15706.607334816721, 16287.67424651524, 16458.259378327766, 16858.747118792984, 16059.27733251983, 16479.588010299838, 17272.136393180543, 17347.566310841827, 17556.0, 10897.12822974176, 10958.506867190836, 10973.780524389627, 10979.945100274448, 11062.557497700001, 12635.557755478514, 12639.431225594686, 12771.61685149447, 12778.424970876518, 12838.486460541473, 10150.543225555015, 10359.689209323733, 10424.843627345748, 10440.477976101012, 10557.894421055691, 10366.740831479274, 10740.677779666623, 10781.137508999418, 10876.18428617841, 10935.28920620157, 8848.646054157762, 9134.040925702971, 9232.723018309462, 9238.0, 9425.293103017164, 7171.318724721144, 7250.274972502708, 7299.9270007301375, 7317.304856038668, 7330.450216233698, 7294.890576641461, 7428.665710043169, 7439.442041846775, 7455.7017719290625, 7524.924750752422], "value": 6363.468240385457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.63745465809967, 499.2511233150277, 528.2182370092263, 528.362226073484, 536.0806217337268, 6187.762447510493, 6191.164192833966, 6202.511397264658, 6216.751329946796, 6274.2470903491585, 5877.559183061266, 6035.18524999125, 6046.7883624073165, 6060.333363330041, 6144.3548427415035, 4823.252395878627, 4858.927116093261, 4875.24433712775, 4913.901721965559, 4925.729084900329, 4764.880877978044, 4905.754712264373, 4949.529794669518, 4953.4798846121175, 4979.676321039139, 4853.635977301698, 4886.485189591221, 4904.117258893398, 4928.531789479994, 4954.702717836942, 4902.803887844482, 4905.386826646669, 4908.901821963576, 4924.2367433047575, 4926.531979461927, 4395.384646149541, 4409.184300904343, 4421.977890110561, 4425.0, 4450.221211288012, 5912.556558258105, 6009.669468179249, 6011.669358185298, 6095.817125486243, 6100.328963813977, 5657.717114144318, 5685.630434021817, 5711.143328500758, 5720.11338242573, 5734.541236701054, 6422.807315780534, 6485.319041500622, 6515.153030106056, 6524.748961608238, 6552.180977377828, 4892.706437613754, 4892.779824907852, 4912.435069966964, 4915.139850526144, 4923.37528615556, 6891.483138764613, 6937.410320122795, 6970.546914450544, 6977.616231107287, 6981.127359080115, 4959.2561115832195, 4962.280469331999, 4986.177280748709, 5018.780468312987, 5028.371453568304, 5032.924506132411, 5057.8735531612, 5058.4435712071645, 5086.415062267886, 5110.9488905110475, 5620.634658747168, 5680.744366503517, 5712.200291959129, 5714.314282286069, 5740.167675687002, 6463.321351258144, 6556.311587283362, 6585.5719378240265, 6592.901106483407, 6626.171728533934, 1668.649583587436, 1701.906395148254, 1721.1136264823626, 1736.6873962686584, 1758.5955230297104, 1206.4691535724428, 1209.9879001209874, 1214.1136970011942, 1227.490591404575, 1232.445399570179, 5669.137085771659, 5675.659460432387, 5714.514266287412, 5743.765090505478, 5753.798617048467, 6547.705353259114, 6569.9343006569325, 6650.800475985729, 6719.160104986877, 6737.966310168418, 5713.857153571194, 5743.368229494752, 5753.395893431213, 5823.883522329615, 5865.706714664249, 3561.8397172127316, 3585.2470981093743, 3586.3544561979093, 3628.9818550907075, 3631.927361452809, 6551.541392102602, 6560.0, 6587.440067594308, 6592.703328350236, 6611.768588099393, 6878.3465570770695, 6882.793516194522, 6902.102726645604, 6922.731132311053, 6940.687669054904, 6436.903446448307, 6464.838379040561, 6487.416132548094, 6555.115059467006, 6592.450774067995, 6640.601563906181, 6659.433948114464, 6678.49911256648, 6681.498887583353, 6700.195976482853, 6557.245916719638, 6635.966820165868, 6650.83372915681, 6656.7337306509135, 6717.798466046026, 6470.741170353133, 6473.190851143607, 6474.805755827333, 6516.674166291761, 6539.901901471577, 4834.685745426536, 4903.068417000758, 4909.754512274443, 4918.262260660929, 4946.727929963887, 6614.3385661435395, 6745.898811517733, 6761.492888033319, 6782.423494003065, 6792.796216113525, 6499.057636642755, 6522.510811689048, 6546.116274303098, 6569.57297775643, 6572.80281591553, 6492.28584855656, 6531.216254049545, 6531.379518945692, 6542.44389226902, 6582.308857569887, 6017.31363861147, 6160.507159427325, 6273.52948528853, 6273.874522509615, 6400.935990640221, 6413.807585772434, 6415.390537898892, 6440.9388995520985, 6448.903266450913, 6481.546291759531, 6196.3803619639475, 6202.666426718277, 6273.843153921189, 6285.454390971664, 6288.402601752826], "value": 5028.080030939568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.9640014399424, 917.1791246834084, 923.8152369526097, 925.500229875867, 930.4045410937001, 17873.642527149448, 18788.90605546974, 18834.529136771587, 18906.960117193565, 20426.897865510688, 18979.810201897977, 19107.71338429921, 19124.61750764984, 19233.711494327596, 19255.61488770224, 968.7529679931607, 1012.8126296635146, 1044.17510166968, 1053.0417320238585, 1062.198040479437, 1071.6035067025211, 1072.404815327493, 1073.4632683658172, 1076.5532304093792, 1078.4877183337892, 1073.420353009374, 1081.7944590527775, 1082.69684488343, 1087.374759513279, 1087.7933192693401, 1077.3105212663902, 1077.536659236528, 1080.4543705428748, 1081.4268437727937, 1084.8589683341154, 786.4612740272875, 790.8260182759784, 791.4064451661254, 794.9324307433875, 796.040770871099, 18076.18657160431, 18081.457556273333, 18143.274269029356, 18208.271669133217, 18895.62208755817, 20907.26824561133, 20928.0, 21330.573388532142, 21351.786482135136, 21544.784552154433, 16294.34822607106, 16786.496405107868, 16915.0, 17086.060266685326, 17094.230759615846, 3602.9279414411826, 3609.6931760800103, 3626.6192049834917, 3631.8728844490315, 3639.290338384016, 128747.0, 128768.35615821861, 130277.34861325727, 132249.0, 133889.3305533476, 16075.196240187945, 16087.517374478784, 16496.917515412348, 16543.172841357886, 16625.0, 30527.847360763055, 31297.0, 31347.843260784008, 31813.52279715806, 32279.51580726291, 7015.614141222281, 8711.433756805787, 8730.956345218234, 8853.468791872509, 8868.379213454997, 3301.4057469655213, 3423.7432192585657, 3428.3828910796296, 3428.9485657715154, 3656.469811877263, 5196.636235463481, 5263.289455923401, 5275.973620131952, 5292.259083728281, 5345.839624811262, 980.2599037726471, 998.7852611688522, 1097.25386737018, 1105.9225854190129, 1107.7230692326918, 693.4833549005922, 699.4684040129538, 706.6643344411466, 717.150177040209, 718.3463048625725, 12528.561500347627, 13142.60572182836, 13598.32008399576, 14123.223222722643, 14280.0, 661.1867403094221, 661.9139511863427, 681.8431760695067, 710.1691021504852, 717.9497435179592, 5000.924986125211, 5113.795448182105, 5162.0, 5246.816361427408, 5276.15581506957, 100010.4999474998, 102088.0, 102866.0, 105106.0, 109227.45386273018, 91244.0, 91979.54010229906, 95536.0, 97834.0, 98679.0, 80440.0, 81790.0, 82677.58661206656, 84243.0, 85823.14176858151, 10433.53049112807, 10495.967701640073, 10552.261341706007, 10558.630447934285, 10696.732581685208, 34450.310993780484, 34761.0, 36021.63978360183, 36938.261234775695, 37001.259974800894, 70913.29086709066, 71418.28581714116, 71658.28341716724, 73857.6307118461, 74483.62758186174, 19357.322493712654, 19999.300024499073, 20083.397498075083, 20085.297014605003, 20196.394108176777, 17148.0, 19225.32711355096, 21879.12483500642, 22106.115755369607, 22217.333479995625, 18140.90929545344, 18477.90761046186, 18738.906305468387, 18834.52913677169, 19004.23983040663, 19969.500762480475, 20136.79863201349, 20579.69130463014, 20704.68942965887, 20766.273180438613, 17796.733049004015, 18312.450626481226, 18462.723059153854, 18821.529461763566, 19001.619967600847, 14003.159810411, 14261.144331340152, 14325.212113333866, 14473.638159046108, 14583.197924114276, 14519.637009074857, 14661.92669036648, 14762.926185369004, 14771.514359531939, 14863.702725945637], "value": 9151.54643973002, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 104.0, 108.0, 107.0, 111.0, 112.0, 101.0, 109.0, 111.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 120.0, 143.0, 162.0, 120.0, 151.0, 150.0, 117.0, 188.0, 125.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 170.0, 162.0, 163.0, 163.0, 167.0, 164.0, 168.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 177.0, 76.0, 74.0, 75.0, 90.0, 96.0, 76.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 132.0, 78.0, 78.0, 78.0, 129.0, 78.0, 78.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 119.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 151.0, 151.0, 151.0, 152.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 57.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 53.0, 53.0, 54.0, 53.0, 54.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 91.0, 79.0, 89.0, 77.0, 76.0, 78.0, 88.0, 96.0, 78.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 126.0, 124.0, 132.0, 123.0, 125.0, 129.0, 123.0, 126.0, 166.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 180.0, 173.0, 170.0, 178.0, 174.0, 179.0, 176.0, 177.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 76.0, 71.0, 66.0, 67.0, 65.0, 70.0, 67.0, 66.0], "value": 68.2, "unit": "score"}]}]} 07:22:55 INFO - Return code: 0 07:22:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:22:55 INFO - # TBPL SUCCESS # 07:22:55 INFO - Running post-action listener: _package_coverage_data 07:22:55 INFO - Running post-action listener: _resource_record_post_action 07:22:55 INFO - [mozharness: 2017-08-03 14:22:55.142793Z] Finished run-tests step (success) 07:22:55 INFO - Running post-run listener: _resource_record_post_run 07:22:55 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 434106368; Read time: 116; Write time: 280180 07:22:55 INFO - TinderboxPrint: CPU usage
13.1% 07:22:55 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 116 07:22:55 INFO - TinderboxPrint: I/O write bytes / time
434,106,368 / 280,180 07:22:55 INFO - TinderboxPrint: CPU idle
8,275.2 (86.8%) 07:22:55 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 07:22:55 INFO - TinderboxPrint: Swap in / out
0 / 0 07:22:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112300032; Read time: 76; Write time: 101704 07:22:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:22:55 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320688128; Read time: 24; Write time: 178424 07:22:55 INFO - Running post-run listener: _upload_blobber_files 07:22:55 INFO - Blob upload gear active. 07:22:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:22:55 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 07:22:55 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:22:55 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:22:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:22:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:22:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:23:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:04 INFO - (blobuploader) - INFO - Done attempting. 07:23:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:23:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:05 INFO - (blobuploader) - INFO - Done attempting. 07:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:06 INFO - (blobuploader) - INFO - Done attempting. 07:23:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:23:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:23:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:07 INFO - (blobuploader) - INFO - Done attempting. 07:23:07 INFO - (blobuploader) - INFO - Iteration through files over. 07:23:07 INFO - Return code: 0 07:23:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:23:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:23:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb9e25bc7d905d6779e687a415b48c7e89d4e994896fc82f3f773042242dd787c7c95e17145d404d0ab3079e5095f122281f492c657ce073d4a5e3f00ea463c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fc579106eea1c9eba86032462ac27f29fa2c2eed80e013b9bc4dad6ee12da325c01f544454adcb0f9ad18f14934ef2c71e6b7b439571f329befadc93fe8e17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf09e0729036878b26660f2522e47b15d396ff12aa462cb12d4e1ceff13288c20cc8300a88aacdfa934541cef8d4db4d46983c012c5b71d222a5213dd398cc6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8087561f2d223c3e7f02dd01b806e0b90bf87e8139a9b5b4d19d48716a8f955678c7fc0fc1f69a462da8c8165ebc4f7d6a3f7f184844ca2cf777edc982e97d1f"} 07:23:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:23:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:23:07 INFO - Contents: 07:23:07 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb9e25bc7d905d6779e687a415b48c7e89d4e994896fc82f3f773042242dd787c7c95e17145d404d0ab3079e5095f122281f492c657ce073d4a5e3f00ea463c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fc579106eea1c9eba86032462ac27f29fa2c2eed80e013b9bc4dad6ee12da325c01f544454adcb0f9ad18f14934ef2c71e6b7b439571f329befadc93fe8e17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf09e0729036878b26660f2522e47b15d396ff12aa462cb12d4e1ceff13288c20cc8300a88aacdfa934541cef8d4db4d46983c012c5b71d222a5213dd398cc6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8087561f2d223c3e7f02dd01b806e0b90bf87e8139a9b5b4d19d48716a8f955678c7fc0fc1f69a462da8c8165ebc4f7d6a3f7f184844ca2cf777edc982e97d1f"} 07:23:07 INFO - Running post-run listener: copy_logs_to_upload_dir 07:23:07 INFO - Copying logs to upload dir... 07:23:07 INFO - mkdir: /builds/slave/test/build/upload/logs 07:23:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.241879 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-03 07:23:06.775608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:06.783821) ========= 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=cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb9e25bc7d905d6779e687a415b48c7e89d4e994896fc82f3f773042242dd787c7c95e17145d404d0ab3079e5095f122281f492c657ce073d4a5e3f00ea463c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fc579106eea1c9eba86032462ac27f29fa2c2eed80e013b9bc4dad6ee12da325c01f544454adcb0f9ad18f14934ef2c71e6b7b439571f329befadc93fe8e17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf09e0729036878b26660f2522e47b15d396ff12aa462cb12d4e1ceff13288c20cc8300a88aacdfa934541cef8d4db4d46983c012c5b71d222a5213dd398cc6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8087561f2d223c3e7f02dd01b806e0b90bf87e8139a9b5b4d19d48716a8f955678c7fc0fc1f69a462da8c8165ebc4f7d6a3f7f184844ca2cf777edc982e97d1f"} build_url:https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb9e25bc7d905d6779e687a415b48c7e89d4e994896fc82f3f773042242dd787c7c95e17145d404d0ab3079e5095f122281f492c657ce073d4a5e3f00ea463c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fc579106eea1c9eba86032462ac27f29fa2c2eed80e013b9bc4dad6ee12da325c01f544454adcb0f9ad18f14934ef2c71e6b7b439571f329befadc93fe8e17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf09e0729036878b26660f2522e47b15d396ff12aa462cb12d4e1ceff13288c20cc8300a88aacdfa934541cef8d4db4d46983c012c5b71d222a5213dd398cc6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8087561f2d223c3e7f02dd01b806e0b90bf87e8139a9b5b4d19d48716a8f955678c7fc0fc1f69a462da8c8165ebc4f7d6a3f7f184844ca2cf777edc982e97d1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:06.809874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:06.810189) ========= 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=cbe409c6de289db6ac707de3000001d4-1501760981.210143-1389254160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:06.893286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 07:23:06.895634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 07:23:06.895923) ========= ========= Total master_lag: 0.15 =========