builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1500988263.42 results: success (0) revision: 07484bfdb96bc7297c404e377eea93f1d8ca4442 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.422442) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.422831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.423118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.496250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.499150) ========= 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=7de08804244eb36560b44971000001c3-1500987286.376829-197251129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 06:11:04-- 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% 226M=0s 2017-07-25 06:11:04 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120697 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.655234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.655530) ========= 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=7de08804244eb36560b44971000001c3-1500987286.376829-197251129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016593 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.739040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.739327) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 07484bfdb96bc7297c404e377eea93f1d8ca4442 --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 07484bfdb96bc7297c404e377eea93f1d8ca4442 --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=7de08804244eb36560b44971000001c3-1500987286.376829-197251129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 06:11:04,656 truncating revision to first 12 chars 2017-07-25 06:11:04,656 Setting DEBUG logging. 2017-07-25 06:11:04,656 attempt 1/10 2017-07-25 06:11:04,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/07484bfdb96b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 06:11:04,987 unpacking tar archive at: mozilla-central-07484bfdb96b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.391285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.391556) ========= script_repo_revision: 07484bfdb96bc7297c404e377eea93f1d8ca4442 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.391892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.395157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.405309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-25 06:11:04.405560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7de08804244eb36560b44971000001c3-1500987286.376829-197251129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:11:05 INFO - MultiFileLogger online at 20170725 06:11:05 in /builds/slave/test 06:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:05 INFO - {'append_to_log': False, 06:11:05 INFO - 'base_work_dir': '/builds/slave/test', 06:11:05 INFO - 'blob_upload_branch': 'Firefox', 06:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:05 INFO - 'branch': 'Firefox', 06:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:05 INFO - 'code_coverage': False, 06:11:05 INFO - 'config_files': ('talos/linux_config.py',), 06:11:05 INFO - 'default_actions': ('clobber', 06:11:05 INFO - 'read-buildbot-config', 06:11:05 INFO - 'download-and-extract', 06:11:05 INFO - 'populate-webroot', 06:11:05 INFO - 'create-virtualenv', 06:11:05 INFO - 'install', 06:11:05 INFO - 'setup-mitmproxy', 06:11:05 INFO - 'run-tests'), 06:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:05 INFO - 'disable_ccov_upload': False, 06:11:05 INFO - 'download_minidump_stackwalk': True, 06:11:05 INFO - 'download_symbols': 'ondemand', 06:11:05 INFO - 'enable_stylo': False, 06:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:05 INFO - 'gecko_profile': False, 06:11:05 INFO - 'gecko_profile_interval': 0, 06:11:05 INFO - 'installer_path': 'installer.exe', 06:11:05 INFO - 'log_level': 'info', 06:11:05 INFO - 'log_name': 'talos', 06:11:05 INFO - 'log_to_console': True, 06:11:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:11:05 INFO - 'opt_config_files': (), 06:11:05 INFO - 'pip_index': False, 06:11:05 INFO - 'suite': 'dromaeojs-e10s', 06:11:05 INFO - 'system_bits': '32', 06:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:05 INFO - 'title': 'talos-linux64-ix-003', 06:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:05 INFO - 'use_talos_json': True, 06:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:05 INFO - 'work_dir': 'build'} 06:11:05 INFO - [mozharness: 2017-07-25 13:11:05.418003Z] Running clobber step. 06:11:05 INFO - Running pre-action listener: _resource_record_pre_action 06:11:05 INFO - Running main action method: clobber 06:11:05 INFO - rmtree: /builds/slave/test/build 06:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:06 INFO - Running post-action listener: _resource_record_post_action 06:11:06 INFO - [mozharness: 2017-07-25 13:11:06.973541Z] Finished clobber step (success) 06:11:06 INFO - [mozharness: 2017-07-25 13:11:06.973643Z] Running read-buildbot-config step. 06:11:06 INFO - Running pre-action listener: _resource_record_pre_action 06:11:06 INFO - Running main action method: read_buildbot_config 06:11:06 INFO - Using buildbot properties: 06:11:06 INFO - { 06:11:06 INFO - "project": "", 06:11:06 INFO - "product": "firefox", 06:11:06 INFO - "who": "cbook@mozilla.com", 06:11:06 INFO - "installer_path": "public/build/target.tar.bz2", 06:11:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 06:11:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:11:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 06:11:06 INFO - "stage_platform": "linux64-stylosequential", 06:11:06 INFO - "basedir": "/builds/slave/test", 06:11:06 INFO - "buildnumber": 0, 06:11:06 INFO - "platform": "ubuntu64_hw_styloseq", 06:11:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:11:06 INFO - "slavebuilddir": "test", 06:11:06 INFO - "taskId": "OHzVUoL6R12HUMO69jMv3A", 06:11:06 INFO - "branch": "mozilla-central", 06:11:06 INFO - "script_repo_revision": "production", 06:11:06 INFO - "revision": "07484bfdb96bc7297c404e377eea93f1d8ca4442", 06:11:06 INFO - "slavename": "talos-linux64-ix-003", 06:11:06 INFO - "repo_path": "mozilla-central" 06:11:06 INFO - } 06:11:06 INFO - Finding installer, test and symbols from parent task. 06:11:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OHzVUoL6R12HUMO69jMv3A'}, attempt #1 06:11:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OHzVUoL6R12HUMO69jMv3A'}, attempt #1 06:11:08 INFO - Task dependencies: blOgpJOoQfmX7a7f7IMY-A 06:11:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A'}, attempt #1 06:11:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/test_packages.json 06:11:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip 06:11:08 INFO - Running post-action listener: _resource_record_post_action 06:11:08 INFO - [mozharness: 2017-07-25 13:11:08.452154Z] Finished read-buildbot-config step (success) 06:11:08 INFO - [mozharness: 2017-07-25 13:11:08.452377Z] Running download-and-extract step. 06:11:08 INFO - Running pre-action listener: _resource_record_pre_action 06:11:08 INFO - Running main action method: download_and_extract 06:11:08 INFO - mkdir: /builds/slave/test/build/tests 06:11:08 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')]} 06:11:08 INFO - trying https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.test_packages.json 06:11:08 INFO - Downloading https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:11:09 INFO - Downloaded 989 bytes. 06:11:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:11:09 INFO - Using the following test package requirements: 06:11:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:11:09 INFO - u'common': [u'target.common.tests.zip'], 06:11:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:11:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:11:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:11:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:11:09 INFO - u'mozbase': [u'target.common.tests.zip'], 06:11:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:11:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:11:09 INFO - u'web-platform': [u'target.common.tests.zip', 06:11:09 INFO - u'target.web-platform.tests.tar.gz'], 06:11:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:11:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:11:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip 06:11:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:11:09 INFO - Fetch https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip into memory 06:11:17 INFO - Content-Length response header: 72762042 06:11:17 INFO - Bytes received: 72762042 06:11:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:11:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip 06:11:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:11:28 INFO - Fetch https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip into memory 06:11:31 INFO - Content-Length response header: 72762042 06:11:31 INFO - Bytes received: 72762042 06:11:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.talos.tests.zip 06:11:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:11:45 INFO - Fetch https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.talos.tests.zip into memory 06:11:46 INFO - Content-Length response header: 14498866 06:11:46 INFO - Bytes received: 14498866 06:11: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')]} 06:11:46 INFO - trying https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:46 INFO - Downloading https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:11:48 INFO - Downloaded 62009754 bytes. 06:11:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:48 INFO - mkdir: /builds/slave/test/properties 06:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:48 INFO - Contents: 06:11:48 INFO - build_url:https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:48 INFO - Running post-action listener: _resource_record_post_action 06:11:48 INFO - Running post-action listener: set_extra_try_arguments 06:11:48 INFO - [mozharness: 2017-07-25 13:11:48.610480Z] Finished download-and-extract step (success) 06:11:48 INFO - [mozharness: 2017-07-25 13:11:48.610707Z] Running populate-webroot step. 06:11:48 INFO - Running pre-action listener: _resource_record_pre_action 06:11:48 INFO - Running main action method: populate_webroot 06:11:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:11:48 INFO - 'tests': ['damp', 'tps']}, 06:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:11:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:11:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:11:48 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:48 INFO - 'ts_paint', 06:11:48 INFO - 'tpaint', 06:11:48 INFO - 'sessionrestore', 06:11:48 INFO - 'sessionrestore_many_windows', 06:11:48 INFO - 'sessionrestore_no_auto_restore', 06:11:48 INFO - 'tabpaint']}, 06:11:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:11:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:11:48 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:11:48 INFO - 'talos_options': ['--mitmproxy', 06:11:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:11:48 INFO - '--firstNonBlankPaint'], 06:11:48 INFO - 'tests': ['quantum_pageload_google', 06:11:48 INFO - 'quantum_pageload_youtube', 06:11:48 INFO - 'quantum_pageload_amazon', 06:11:48 INFO - 'quantum_pageload_facebook']}, 06:11:48 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:11:48 INFO - 'talos_options': ['--stylo', 06:11:48 INFO - '--mitmproxy', 06:11:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:11:48 INFO - '--firstNonBlankPaint'], 06:11:48 INFO - 'tests': ['quantum_pageload_google', 06:11:48 INFO - 'quantum_pageload_youtube', 06:11:48 INFO - 'quantum_pageload_amazon', 06:11:48 INFO - 'quantum_pageload_facebook']}, 06:11:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:48 INFO - 'tsvgr_opacity', 06:11:48 INFO - 'tart', 06:11:48 INFO - 'tscrollx', 06:11:48 INFO - 'cart', 06:11:48 INFO - 'tsvg_static']}, 06:11:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:11:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:11:48 INFO - 'talos_options': ['--xperf_path', 06:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:48 INFO - 'tests': ['tp5n']}}} 06:11:48 INFO - Running post-action listener: _resource_record_post_action 06:11:48 INFO - [mozharness: 2017-07-25 13:11:48.626902Z] Finished populate-webroot step (success) 06:11:48 INFO - [mozharness: 2017-07-25 13:11:48.626993Z] Running create-virtualenv step. 06:11:48 INFO - Running pre-action listener: _resource_record_pre_action 06:11:48 INFO - Running main action method: create_virtualenv 06:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:48 INFO - Using real prefix '/usr' 06:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:51 INFO - Installing pip.................done. 06:11:51 INFO - Return code: 0 06:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:11:51 INFO - Reading from file tmpfile_stdout 06:11:51 INFO - Output received: 06:11:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11:51 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')]} 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:51 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')]} 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:51 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:51 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 06:11:51 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 06:11:51 INFO - Using env: {'DISPLAY': ':0', 06:11:51 INFO - 'HOME': '/home/cltbld', 06:11:51 INFO - 'LANG': 'en_US.UTF-8', 06:11:51 INFO - 'LANGUAGE': 'en_US:en', 06:11:51 INFO - 'LOGNAME': 'cltbld', 06:11:51 INFO - 'MAIL': '/var/mail/cltbld', 06:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:51 INFO - 'MOZ_NO_REMOTE': '1', 06:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:51 INFO - 'NO_EM_RESTART': '1', 06:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:51 INFO - 'PWD': '/builds/slave/test', 06:11:51 INFO - 'SHELL': '/bin/bash', 06:11:51 INFO - 'SHLVL': '1', 06:11:51 INFO - 'TERM': 'linux', 06:11:51 INFO - 'TMOUT': '86400', 06:11:51 INFO - 'USER': 'cltbld', 06:11:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:51 INFO - '_': '/tools/buildbot/bin/python'} 06:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:11:51 INFO - Cleaning up... 06:11:51 INFO - Return code: 0 06:11:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11:51 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')]} 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:51 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')]} 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:51 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:51 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 06:11:51 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 06:11:51 INFO - Using env: {'DISPLAY': ':0', 06:11:51 INFO - 'HOME': '/home/cltbld', 06:11:51 INFO - 'LANG': 'en_US.UTF-8', 06:11:51 INFO - 'LANGUAGE': 'en_US:en', 06:11:51 INFO - 'LOGNAME': 'cltbld', 06:11:51 INFO - 'MAIL': '/var/mail/cltbld', 06:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:51 INFO - 'MOZ_NO_REMOTE': '1', 06:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:51 INFO - 'NO_EM_RESTART': '1', 06:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:51 INFO - 'PWD': '/builds/slave/test', 06:11:51 INFO - 'SHELL': '/bin/bash', 06:11:51 INFO - 'SHLVL': '1', 06:11:51 INFO - 'TERM': 'linux', 06:11:51 INFO - 'TMOUT': '86400', 06:11:51 INFO - 'USER': 'cltbld', 06:11:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:51 INFO - '_': '/tools/buildbot/bin/python'} 06:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:51 INFO - Downloading/unpacking psutil>=3.1.1 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:53 INFO - Installing collected packages: psutil 06:11:53 INFO - Running setup.py install for psutil 06:11:53 INFO - building 'psutil._psutil_linux' extension 06:11:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:11:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:11:53 INFO - building 'psutil._psutil_posix' extension 06:11:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:11:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:53 INFO - Successfully installed psutil 06:11:53 INFO - Cleaning up... 06:11:53 INFO - Return code: 0 06:11:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11: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')]} 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:53 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:53 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 06:11:53 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 06:11:53 INFO - Using env: {'DISPLAY': ':0', 06:11:53 INFO - 'HOME': '/home/cltbld', 06:11:53 INFO - 'LANG': 'en_US.UTF-8', 06:11:53 INFO - 'LANGUAGE': 'en_US:en', 06:11:53 INFO - 'LOGNAME': 'cltbld', 06:11:53 INFO - 'MAIL': '/var/mail/cltbld', 06:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:53 INFO - 'MOZ_NO_REMOTE': '1', 06:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:53 INFO - 'NO_EM_RESTART': '1', 06:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:53 INFO - 'PWD': '/builds/slave/test', 06:11:53 INFO - 'SHELL': '/bin/bash', 06:11:53 INFO - 'SHLVL': '1', 06:11:53 INFO - 'TERM': 'linux', 06:11:53 INFO - 'TMOUT': '86400', 06:11:53 INFO - 'USER': 'cltbld', 06:11:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:53 INFO - '_': '/tools/buildbot/bin/python'} 06:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:54 INFO - Installing collected packages: mozsystemmonitor 06:11:54 INFO - Running setup.py install for mozsystemmonitor 06:11:54 INFO - Successfully installed mozsystemmonitor 06:11:54 INFO - Cleaning up... 06:11:55 INFO - Return code: 0 06:11:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:55 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')]} 06:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:55 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')]} 06:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:55 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:55 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 06:11:55 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 06:11:55 INFO - Using env: {'DISPLAY': ':0', 06:11:55 INFO - 'HOME': '/home/cltbld', 06:11:55 INFO - 'LANG': 'en_US.UTF-8', 06:11:55 INFO - 'LANGUAGE': 'en_US:en', 06:11:55 INFO - 'LOGNAME': 'cltbld', 06:11:55 INFO - 'MAIL': '/var/mail/cltbld', 06:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:55 INFO - 'MOZ_NO_REMOTE': '1', 06:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:55 INFO - 'NO_EM_RESTART': '1', 06:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:55 INFO - 'PWD': '/builds/slave/test', 06:11:55 INFO - 'SHELL': '/bin/bash', 06:11:55 INFO - 'SHLVL': '1', 06:11:55 INFO - 'TERM': 'linux', 06:11:55 INFO - 'TMOUT': '86400', 06:11:55 INFO - 'USER': 'cltbld', 06:11:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:55 INFO - '_': '/tools/buildbot/bin/python'} 06:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:55 INFO - Downloading/unpacking jsonschema==2.5.1 06:11: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 06:11: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 06:11: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 06:11: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 06:11:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:56 INFO - warning: no files found matching '*.txt' 06:11:56 INFO - no previously-included directories found matching 'build' 06:11:56 INFO - no previously-included directories found matching 'dist' 06:11:56 INFO - no previously-included directories found matching '.git*' 06:11:56 INFO - Installing collected packages: jsonschema, functools32 06:11:56 INFO - Running setup.py install for functools32 06:11:56 INFO - warning: no files found matching '*.txt' 06:11:56 INFO - no previously-included directories found matching 'build' 06:11:56 INFO - no previously-included directories found matching 'dist' 06:11:56 INFO - no previously-included directories found matching '.git*' 06:11:56 INFO - Successfully installed jsonschema functools32 06:11:56 INFO - Cleaning up... 06:11:56 INFO - Return code: 0 06:11:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11: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')]} 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:56 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 06:11:56 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 06:11:56 INFO - Using env: {'DISPLAY': ':0', 06:11:56 INFO - 'HOME': '/home/cltbld', 06:11:56 INFO - 'LANG': 'en_US.UTF-8', 06:11:56 INFO - 'LANGUAGE': 'en_US:en', 06:11:56 INFO - 'LOGNAME': 'cltbld', 06:11:56 INFO - 'MAIL': '/var/mail/cltbld', 06:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:56 INFO - 'MOZ_NO_REMOTE': '1', 06:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:56 INFO - 'NO_EM_RESTART': '1', 06:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:56 INFO - 'PWD': '/builds/slave/test', 06:11:56 INFO - 'SHELL': '/bin/bash', 06:11:56 INFO - 'SHLVL': '1', 06:11:56 INFO - 'TERM': 'linux', 06:11:56 INFO - 'TMOUT': '86400', 06:11:56 INFO - 'USER': 'cltbld', 06:11:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:56 INFO - '_': '/tools/buildbot/bin/python'} 06:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:11:56 INFO - Cleaning up... 06:11:56 INFO - Return code: 0 06:11:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11: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')]} 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:56 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 06:11:56 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 06:11:56 INFO - Using env: {'DISPLAY': ':0', 06:11:56 INFO - 'HOME': '/home/cltbld', 06:11:56 INFO - 'LANG': 'en_US.UTF-8', 06:11:56 INFO - 'LANGUAGE': 'en_US:en', 06:11:56 INFO - 'LOGNAME': 'cltbld', 06:11:56 INFO - 'MAIL': '/var/mail/cltbld', 06:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:56 INFO - 'MOZ_NO_REMOTE': '1', 06:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:56 INFO - 'NO_EM_RESTART': '1', 06:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:56 INFO - 'PWD': '/builds/slave/test', 06:11:56 INFO - 'SHELL': '/bin/bash', 06:11:56 INFO - 'SHLVL': '1', 06:11:56 INFO - 'TERM': 'linux', 06:11:56 INFO - 'TMOUT': '86400', 06:11:56 INFO - 'USER': 'cltbld', 06:11:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:56 INFO - '_': '/tools/buildbot/bin/python'} 06:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:11: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 06:11: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 06:11: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 06:11: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 06:11:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:11:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:11:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - Downloading docopt-0.6.1.tar.gz 06:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:11:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:11:58 INFO - Running setup.py install for blobuploader 06:11:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:11:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:11:58 INFO - Running setup.py install for requests 06:11:59 INFO - Running setup.py install for docopt 06:11:59 INFO - Successfully installed blobuploader requests docopt 06:11:59 INFO - Cleaning up... 06:11:59 INFO - Return code: 0 06:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11: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')]} 06:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:59 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:59 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 06:11:59 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 06:11:59 INFO - Using env: {'DISPLAY': ':0', 06:11:59 INFO - 'HOME': '/home/cltbld', 06:11:59 INFO - 'LANG': 'en_US.UTF-8', 06:11:59 INFO - 'LANGUAGE': 'en_US:en', 06:11:59 INFO - 'LOGNAME': 'cltbld', 06:11:59 INFO - 'MAIL': '/var/mail/cltbld', 06:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:59 INFO - 'MOZ_NO_REMOTE': '1', 06:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:59 INFO - 'NO_EM_RESTART': '1', 06:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:59 INFO - 'PWD': '/builds/slave/test', 06:11:59 INFO - 'SHELL': '/bin/bash', 06:11:59 INFO - 'SHLVL': '1', 06:11:59 INFO - 'TERM': 'linux', 06:11:59 INFO - 'TMOUT': '86400', 06:11:59 INFO - 'USER': 'cltbld', 06:11:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:59 INFO - '_': '/tools/buildbot/bin/python'} 06:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:59 INFO - Running setup.py (path:/tmp/pip-6Ir_rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:59 INFO - Running setup.py (path:/tmp/pip-r5CUYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:59 INFO - Running setup.py (path:/tmp/pip-zFD7pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:59 INFO - Running setup.py (path:/tmp/pip-2L0zTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:59 INFO - Running setup.py (path:/tmp/pip-qg28m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:59 INFO - Running setup.py (path:/tmp/pip-YVVbtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:00 INFO - Running setup.py (path:/tmp/pip-v9eOK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:00 INFO - Running setup.py (path:/tmp/pip-91CMTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:00 INFO - Running setup.py (path:/tmp/pip-b6f5VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:00 INFO - Running setup.py (path:/tmp/pip-aHWZfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:00 INFO - Running setup.py (path:/tmp/pip-9_0pWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:00 INFO - Running setup.py (path:/tmp/pip-yPheUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:00 INFO - Running setup.py (path:/tmp/pip-kYNS3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:00 INFO - Running setup.py (path:/tmp/pip-diUo0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:00 INFO - Running setup.py (path:/tmp/pip-NHdHsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:00 INFO - Running setup.py (path:/tmp/pip-G7gOwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:00 INFO - Running setup.py (path:/tmp/pip-VaMUeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:00 INFO - Running setup.py install for manifestparser 06:12:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:00 INFO - Running setup.py install for mozcrash 06:12:01 INFO - Running setup.py install for mozdebug 06:12:01 INFO - Running setup.py install for mozdevice 06:12:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozfile 06:12:01 INFO - Running setup.py install for mozhttpd 06:12:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozinfo 06:12:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozInstall 06:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozleak 06:12:01 INFO - Running setup.py install for mozlog 06:12:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for moznetwork 06:12:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozprocess 06:12:02 INFO - Running setup.py install for mozprofile 06:12:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:02 INFO - Running setup.py install for mozrunner 06:12:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:02 INFO - Running setup.py install for mozscreenshot 06:12:02 INFO - Running setup.py install for moztest 06:12:02 INFO - Running setup.py install for mozversion 06:12:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:02 INFO - Cleaning up... 06:12:02 INFO - Return code: 0 06:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:02 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')]} 06:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:02 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')]} 06:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:02 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:12:02 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 06:12:02 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 06:12:02 INFO - Using env: {'DISPLAY': ':0', 06:12:02 INFO - 'HOME': '/home/cltbld', 06:12:02 INFO - 'LANG': 'en_US.UTF-8', 06:12:02 INFO - 'LANGUAGE': 'en_US:en', 06:12:02 INFO - 'LOGNAME': 'cltbld', 06:12:02 INFO - 'MAIL': '/var/mail/cltbld', 06:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:02 INFO - 'MOZ_NO_REMOTE': '1', 06:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:02 INFO - 'NO_EM_RESTART': '1', 06:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:02 INFO - 'PWD': '/builds/slave/test', 06:12:02 INFO - 'SHELL': '/bin/bash', 06:12:02 INFO - 'SHLVL': '1', 06:12:02 INFO - 'TERM': 'linux', 06:12:02 INFO - 'TMOUT': '86400', 06:12:02 INFO - 'USER': 'cltbld', 06:12:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:02 INFO - '_': '/tools/buildbot/bin/python'} 06:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:02 INFO - Running setup.py (path:/tmp/pip-_InzrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:02 INFO - Running setup.py (path:/tmp/pip-pdKjjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:02 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)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:02 INFO - Running setup.py (path:/tmp/pip-wU2sdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:03 INFO - Running setup.py (path:/tmp/pip-8NmHZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:03 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)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:03 INFO - Running setup.py (path:/tmp/pip-p6hCLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:03 INFO - Running setup.py (path:/tmp/pip-lipjW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:03 INFO - Running setup.py (path:/tmp/pip-u4Afbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:03 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)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:03 INFO - Running setup.py (path:/tmp/pip-w07Ae4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:03 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)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:03 INFO - Running setup.py (path:/tmp/pip-weTqgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:03 INFO - Running setup.py (path:/tmp/pip-PW4YF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:03 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)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:03 INFO - Running setup.py (path:/tmp/pip-JazFs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:03 INFO - Running setup.py (path:/tmp/pip-t8YIsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:03 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)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:03 INFO - Running setup.py (path:/tmp/pip-MMt8SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:03 INFO - Running setup.py (path:/tmp/pip-Ph7z6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:03 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)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:03 INFO - Running setup.py (path:/tmp/pip-rwKfFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:03 INFO - Running setup.py (path:/tmp/pip-fCdIZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:04 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)) 06:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:04 INFO - Running setup.py (path:/tmp/pip-IxJalS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:12:04 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)) 06:12:04 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)) 06:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:12:04 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)) 06:12:04 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)) 06:12:04 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)) 06:12:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:05 INFO - Downloading blessings-1.6.tar.gz 06:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:05 INFO - Installing collected packages: blessings 06:12:05 INFO - Running setup.py install for blessings 06:12:05 INFO - Successfully installed blessings 06:12:05 INFO - Cleaning up... 06:12:05 INFO - Return code: 0 06:12:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:05 INFO - Reading from file tmpfile_stdout 06:12:05 INFO - Current package versions: 06:12:05 INFO - argparse == 1.2.1 06:12:05 INFO - blessings == 1.6 06:12:05 INFO - blobuploader == 1.2.4 06:12:05 INFO - docopt == 0.6.1 06:12:05 INFO - functools32 == 3.2.3-2 06:12:05 INFO - jsonschema == 2.5.1 06:12:05 INFO - manifestparser == 1.1 06:12:05 INFO - mozInstall == 1.13 06:12:05 INFO - mozcrash == 1.0 06:12:05 INFO - mozdebug == 0.1 06:12:05 INFO - mozdevice == 0.51 06:12:05 INFO - mozfile == 1.2 06:12:05 INFO - mozhttpd == 0.7 06:12:05 INFO - mozinfo == 0.10 06:12:05 INFO - mozleak == 0.1 06:12:05 INFO - mozlog == 3.5 06:12:05 INFO - moznetwork == 0.27 06:12:05 INFO - mozprocess == 0.25 06:12:05 INFO - mozprofile == 0.28 06:12:05 INFO - mozrunner == 6.13 06:12:05 INFO - mozscreenshot == 0.1 06:12:05 INFO - mozsystemmonitor == 0.3 06:12:05 INFO - moztest == 0.8 06:12:05 INFO - mozversion == 1.4 06:12:05 INFO - psutil == 3.1.1 06:12:05 INFO - requests == 1.2.3 06:12:05 INFO - wsgiref == 0.1.2 06:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:05 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')]} 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:05 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')]} 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:05 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:12:05 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 06:12:05 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 06:12:05 INFO - Using env: {'DISPLAY': ':0', 06:12:05 INFO - 'HOME': '/home/cltbld', 06:12:05 INFO - 'LANG': 'en_US.UTF-8', 06:12:05 INFO - 'LANGUAGE': 'en_US:en', 06:12:05 INFO - 'LOGNAME': 'cltbld', 06:12:05 INFO - 'MAIL': '/var/mail/cltbld', 06:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:05 INFO - 'MOZ_NO_REMOTE': '1', 06:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:05 INFO - 'NO_EM_RESTART': '1', 06:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:05 INFO - 'PWD': '/builds/slave/test', 06:12:05 INFO - 'SHELL': '/bin/bash', 06:12:05 INFO - 'SHLVL': '1', 06:12:05 INFO - 'TERM': 'linux', 06:12:05 INFO - 'TMOUT': '86400', 06:12:05 INFO - 'USER': 'cltbld', 06:12:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:05 INFO - '_': '/tools/buildbot/bin/python'} 06:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:12:06 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:07 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:12:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:12:07 INFO - Installing collected packages: marionette-driver, simplejson 06:12:07 INFO - Running setup.py install for marionette-driver 06:12:07 INFO - Running setup.py install for simplejson 06:12:07 INFO - building 'simplejson._speedups' extension 06:12:07 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 06:12:08 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 06:12:08 INFO - Successfully installed marionette-driver simplejson 06:12:08 INFO - Cleaning up... 06:12:08 INFO - Return code: 0 06:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:08 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')]} 06:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:08 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')]} 06:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:08 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 0x26ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, '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': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:12:08 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 06:12:08 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 06:12:08 INFO - Using env: {'DISPLAY': ':0', 06:12:08 INFO - 'HOME': '/home/cltbld', 06:12:08 INFO - 'LANG': 'en_US.UTF-8', 06:12:08 INFO - 'LANGUAGE': 'en_US:en', 06:12:08 INFO - 'LOGNAME': 'cltbld', 06:12:08 INFO - 'MAIL': '/var/mail/cltbld', 06:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:08 INFO - 'MOZ_NO_REMOTE': '1', 06:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:08 INFO - 'NO_EM_RESTART': '1', 06:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:08 INFO - 'PWD': '/builds/slave/test', 06:12:08 INFO - 'SHELL': '/bin/bash', 06:12:08 INFO - 'SHLVL': '1', 06:12:08 INFO - 'TERM': 'linux', 06:12:08 INFO - 'TMOUT': '86400', 06:12:08 INFO - 'USER': 'cltbld', 06:12:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:08 INFO - '_': '/tools/buildbot/bin/python'} 06:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:08 INFO - Cleaning up... 06:12:08 INFO - Return code: 0 06:12:08 INFO - Running post-action listener: _resource_record_post_action 06:12:08 INFO - Running post-action listener: _start_resource_monitoring 06:12:08 INFO - Starting resource monitoring. 06:12:08 INFO - [mozharness: 2017-07-25 13:12:08.886616Z] Finished create-virtualenv step (success) 06:12:08 INFO - [mozharness: 2017-07-25 13:12:08.887140Z] Running install step. 06:12:08 INFO - Running pre-action listener: _resource_record_pre_action 06:12:08 INFO - Running main action method: install 06:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:09 INFO - Reading from file tmpfile_stdout 06:12:09 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:09 INFO - Reading from file tmpfile_stdout 06:12:09 INFO - Output received: 06:12:09 INFO - Usage: mozinstall [options] installer 06:12:09 INFO - Options: 06:12:09 INFO - -h, --help show this help message and exit 06:12:09 INFO - -d DEST, --destination=DEST 06:12:09 INFO - Directory to install application into. [default: 06:12:09 INFO - "/builds/slave/test"] 06:12:09 INFO - --app=APP Application being installed. [default: firefox] 06:12:09 INFO - mkdir: /builds/slave/test/build/application 06:12:09 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'] 06:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:12:27 INFO - Reading from file tmpfile_stdout 06:12:27 INFO - Output received: 06:12:27 INFO - /builds/slave/test/build/application/firefox/firefox 06:12:27 INFO - Running post-action listener: _resource_record_post_action 06:12:27 INFO - [mozharness: 2017-07-25 13:12:27.556167Z] Finished install step (success) 06:12:27 INFO - [mozharness: 2017-07-25 13:12:27.556422Z] Running setup-mitmproxy step. 06:12:27 INFO - Running pre-action listener: _resource_record_pre_action 06:12:27 INFO - Running main action method: setup_mitmproxy 06:12:27 INFO - Skipping: mitmproxy is not required 06:12:27 INFO - Running post-action listener: _resource_record_post_action 06:12:27 INFO - [mozharness: 2017-07-25 13:12:27.557670Z] Finished setup-mitmproxy step (success) 06:12:27 INFO - [mozharness: 2017-07-25 13:12:27.557894Z] Running run-tests step. 06:12:27 INFO - Running pre-action listener: _resource_record_pre_action 06:12:27 INFO - Running pre-action listener: _set_gcov_prefix 06:12:27 INFO - Running main action method: run_tests 06:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:27 INFO - Python 2.7.3 06:12:27 INFO - Return code: 0 06:12:27 INFO - grabbing minidump binary from tooltool 06:12:27 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')]} 06:12:27 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 0x2a1aeb0>, '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 0x2a1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1c240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:12:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:12:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:12:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:27 INFO - Return code: 0 06:12:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:12:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:27 INFO - ENV: RUST_BACKTRACE is now 1 06:12:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:12:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:12:27 INFO - Using env: {'DISPLAY': ':0', 06:12:27 INFO - 'HOME': '/home/cltbld', 06:12:27 INFO - 'LANG': 'en_US.UTF-8', 06:12:27 INFO - 'LANGUAGE': 'en_US:en', 06:12:27 INFO - 'LOGNAME': 'cltbld', 06:12:27 INFO - 'MAIL': '/var/mail/cltbld', 06:12:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:27 INFO - 'MOZ_NO_REMOTE': '1', 06:12:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:27 INFO - 'NO_EM_RESTART': '1', 06:12:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:27 INFO - 'PWD': '/builds/slave/test', 06:12:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:27 INFO - 'RUST_BACKTRACE': '1', 06:12:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:12:27 INFO - 'SHELL': '/bin/bash', 06:12:27 INFO - 'SHLVL': '1', 06:12:27 INFO - 'STYLO_FORCE_ENABLED': '1', 06:12:27 INFO - 'TERM': 'linux', 06:12:27 INFO - 'TMOUT': '86400', 06:12:27 INFO - 'USER': 'cltbld', 06:12:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500987286.376829-197251129', 06:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:27 INFO - '_': '/tools/buildbot/bin/python'} 06:12:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:12:27 INFO - mozversion application_buildid: 20170725122752 06:12:27 INFO - mozversion application_changeset: 07484bfdb96bc7297c404e377eea93f1d8ca4442 06:12:27 INFO - mozversion application_display_name: Nightly 06:12:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:27 INFO - mozversion application_name: Firefox 06:12:27 INFO - mozversion application_remotingname: firefox 06:12:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:12:27 INFO - mozversion application_vendor: Mozilla 06:12:27 INFO - mozversion application_version: 56.0a1 06:12:27 INFO - mozversion platform_buildid: 20170725122752 06:12:27 INFO - mozversion platform_changeset: 07484bfdb96bc7297c404e377eea93f1d8ca4442 06:12:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:12:27 INFO - mozversion platform_version: 56.0a1 06:12:27 INFO - using testdate: 1500988347 06:12:27 INFO - actual date: 1500988347 06:12:27 INFO - starting webserver on 'localhost:49275' 06:12:27 INFO - SUITE-START | Running 2 tests 06:12:27 INFO - TEST-START | dromaeo_css 06:12:27 INFO - Initialising browser for dromaeo_css test... 06:12:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49275/getInfo.html -profile /tmp/tmpXHoemR/profile 06:12:27 INFO - TEST-INFO | started process 2924 (/builds/slave/test/build/application/firefox/firefox http://localhost:49275/getInfo.html) 06:12:34 INFO - TEST-INFO | 2924: exit 0 06:12:34 INFO - Browser initialized. 06:12:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:34 INFO - TEST-INFO | started process 3157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHoemR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:35 INFO - PID 3157 | 06:12:35 INFO - PID 3157 | (/builds/slave/test/build/application/firefox/firefox:3212): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:12:35 INFO - PID 3157 | 06:12:45 INFO - PID 3157 | RSS: Main: 174415872 06:12:45 INFO - PID 3157 | 06:15:44 INFO - PID 3157 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:15:45 INFO - PID 3157 | RSS: Main: 175230976 06:15:45 INFO - PID 3157 | 06:18:47 INFO - PID 3157 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:18:47 INFO - PID 3157 | RSS: Main: 173088768 06:18:47 INFO - PID 3157 | 06:21:49 INFO - PID 3157 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:21:50 INFO - PID 3157 | RSS: Main: 175226880 06:21:50 INFO - PID 3157 | 06:24:52 INFO - PID 3157 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:24:52 INFO - PID 3157 | RSS: Main: 173740032 06:24:52 INFO - PID 3157 | 06:27:56 INFO - PID 3157 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:27:57 INFO - PID 3157 | RSS: Main: 174854144 06:27:57 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:30:59 INFO - PID 3157 | RSS: Main: 177119232 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | __start_tp_report 06:30:59 INFO - PID 3157 | _x_x_mozilla_page_load 06:30:59 INFO - PID 3157 | _x_x_mozilla_page_load_details 06:30:59 INFO - PID 3157 | |i|pagename|runs| 06:30:59 INFO - PID 3157 | |0;dojo.html;3100.1629560018796;3102.798318109324;3138.0585824252717;3142.1987393214727;3195.7762956593033;6161.075838624203;6256.186695729549;6286.811395658137;6328.367163283664;6335.9683201583985;6092.421219984094;6203.038529027996;6242.812715618527;6338.144350512679;6355.428011478966;5689.51639110674;5751.56863235257;5773.451522105414;5808.12878068289;5808.157817116505;224.7804238254307;5651.32184137904;5769;5811.0702287633985;5831.212786273863;5666.320041595014;5681.545476361881;5756.366799652035;5762.308522977249;5767.855803604902;5686.118651609007;5704.743286552115;5757.856053598652;5763.567732420085;5773.826785196451;5655.575831812631;5659.8585035374035;5732.0255556555485;5732.082866741302;5742.54059675225;6052.54605904559;6140.263168419773;6202.658853763041;6248.812535623939;6251.406116418979;6480.708368123399;6559.278479367265;6571.244306904719;6600;6604.339566043405;6768.5600435972;6790.185177778649;6810.387065164109;6811.523193376465;6818.2159051708695;6138.109974053782;6148.7233074511305;6227.782027629057;6228.22147231596;6301.810945671591;6589.80230593083;6652.534322597372;6827.52207345481;6936.826579335557;6941.757038503628;6524.706388212542;6611.438027767597;6617.834554136185;6620.702068406933;6635.767748128792;6657.367550082734;6684.766033188815;6699.296573859772;6754.932450675528;6763.7632682855865;6545.14913061299;6630.1380820494;6639.867202656016;6665.133532640726;6764.323567643295;6477.902831457532;6556.737730490822;6564.179477565304;6570.080188773575;6770.018347339608;5259.342582177228;5314.73426328682;5381.838544843661;5401.270828438189;5415.53967912724;4463.598276155161;4558.680892337505;4576.954230457719;4587.632989360844;4618.65360097994;5595.160725891149;5644.604877658525;5713.171590119493;5719.7140142992685;5741.368449470555;6535.738570457223;6635.601863888182;6636.303188165173;6643;6643.60138391698;5675.744591493392;5678.205051292823;5678.290213723285;5683.062294721407;5700.600957932905;5866.061430171152;5916.852078698067;5925.792597259161;5926.407359264125;5937.346891841894;6494.220693516808;6499.2850786413455;6565.310642382481;6573.309802470767;6586.04502347157;6450.322716114928;6723.966380168068;6757.100086182433;6772.661366931732;6813.318668133147;6419.390157934989;6453.870922581616;6503.317151699192;6518.5111116667385;6533.934660653333;6420.486361091008;6504.378041677899;6517.902231466437;6519.4132528072705;6577.539572229898;6563.9343606565235;6585.3085426029575;6637.469002479694;6665.300143484864;6703.363180497845;6298.5905916117135;6351.968240158954;6373.808785736435;6454.612723236621;6467.223933128054;6532.477401807749;6565.212174539086;6580.868382632416;6591.868162636816;6622.039804228456;6358.046293056079;6417.7753778617525;6486.513511486563;6516.250631177475;6517.543771936109;6407.359264073555;6504.902426463512;6516.283208847118;6571.769988050395;6636.037774522763;6280.623162610258;6378.87242255143;6394.968025159845;6407.807765767035;6429.54993150475 06:30:59 INFO - PID 3157 | |1;ext.html;803.4094940218941;835.707502374169;873.9300855931526;877.5919197573127;1158.7798318319524;30398.848005759966;40945;42263.57736422639;42273.7886310568;42278;41277.38083928736;41488.377674334835;41526.584734152646;41823.79088104563;41890.37164442536;7089.929100708991;7327.487075904689;7647.579383133925;7657.387409007266;7658.923410765905;7539.924600754004;7565.243475652445;7652.464327497078;7656.196099409565;7659;7568.053993250844;7628.466007379486;7640.044994375703;7643.656035478417;7667.42494312926;7586.62066896653;7610.885836712426;7639.465237433354;7643.273888980538;7646.808829779245;7465.477416580841;7561.508501947355;7564.773056808304;7567.810804729871;7570.735024274179;38130.23739525194;38309;38398.61601383978;38490.230195396216;38515.22969540622;3624.1664417183933;3629.038304849217;3634.27314537091;3640.9271814563826;3646.9452958205648;30312.393752124834;30620.387592248255;30661.693383066107;30705;30852.382952341053;4685.508021657711;4766.118268120409;4916.139675556799;4978.551930326252;5067.6452648314635;178623;178713;179242.9999999987;180157;180930;47921.5207847924;47978;48056.5194348052;49053.754731226116;49965.500344996086;51144;51170;51255.74372128116;51475.742621287405;51540;14971;14984;16401.753973690404;16670.66658666844;16676.74984875228;13490.325483725774;13496.662583435296;13505.527306544223;13596.252206128758;13609.047366684237;14177.929110354382;14299.428022879176;14305.713885722227;14321.713565728627;14348;5758.3665796762325;5763.942360576424;5770;5842.166549223623;5871.383504732027;987.3187500624546;1006.2302338710892;1015.1219195395929;1015.7003683913264;1037.0096557787294;22395.552088958455;22613.321600352017;22645.43386415353;22651.320460386214;23213.303600892;1070.769784496337;1103.8564986551696;1125.8198688209848;1128.542940109257;1129.4522156753967;11964;12072.336021518726;12130;12135.393230338448;12317.69205769845;231975;232919;233118;234037;234311;50596.74701626542;50949.49050509447;51088;51109;51471;1450.4923276853228;1472.3963175098158;1488.8511148885025;1493.2309860421892;1495.5662857771342;21867.453313667287;21993;22081.889590551946;22190.889045554668;22231.77768222362;36040.459393109646;36135.09662258464;36319.63680363163;36344.09139771527;47889;204210;204468;204817;205270;205332;34888.825555872056;35374.64625353713;35550.28899421945;35565.28869422649;35627.46558801568;42085.57914420817;43977.34033989429;44318.77840610776;44461.77769111134;44530.777346113064;30773.692263077082;31581.368372631958;32193;32242;32293;29943.700562994964;31938.840305798323;32450.350992979536;32617;32625.18437039093;34499.82750086234;34868.82565587156;34964.300713986086;35054.47418288677;35156.824215878754;29500.704992949795;30371.2407189822;30714.692853071185;31009.379812404077;31171;21581.35255942324;22744.772552274266;22894.198703045313;23184.536309273382;23464.64803027922 06:30:59 INFO - PID 3157 | |2;jquery.html;563.901317269478;572.8338781753291;586.422373961648;588.8675048114175;603.4297588778603;22346.664800027993;22505.324840254776;23162.073517059318;23163.18928837491;23244.88377558112;25474.108406205785;26141.60787588183;26160.73839261607;26174;26225.868870655668;6513.67431628419;6669.233038200597;6672.332766723337;6673.4661227101715;6676;6126.111713801496;6181.536384771138;6255.499560035186;6557.475401967831;6605.0422688710105;6512.925367314388;6525.119108920282;6538.084668146464;6543.083968244449;6567.047778072177;6505.251896031922;6528.281888992184;6532.085508028856;6536.888728916096;6542.967285163568;6095.359987201325;6099.664518451484;6102.359252278536;6108.205933228696;6114.816555503342;28633;29668.554971675443;30298.242543936358;30381.24046898823;30635.08094757161;1924.316867512027;1960.3922783937026;1974.8518861085477;1980.2673010985884;1981.0391959899437;18762.62474750511;19603;19610.411687649394;19615.117319720648;19624.41126766199;2284.303287497313;2301.4131396493785;2334.3107937719446;2403.783659470656;2459.114718701266;132237;135342;136987;140626;140662;14191.503297384543;14589.708205836036;15147.394104235707;15383;15511.146886921328;23601.29196124119;23614.527709445716;23643.93602287901;23646.172383966477;23673.408164795674;10776.461176941122;10796.730081747863;10861.81819999306;10952.616658416917;11013.889861101286;8491.532965686823;10083.344582602254;10172.237082218864;10191.133753631024;10336.638217662347;8190.631421586043;9228.907710922938;9285.700001999725;9324.673636422693;9407.623695052258;2731.3035176030385;2761.2249689062764;2792.6648802143873;2849.216465472012;2874.18085845533;950.1163917556738;954.5418199264392;962.7457110671199;983.2330781989916;995.2833959549113;19462.22151113968;19635.31276405319;19767.604647906963;19986.60026799485;20177.596448070955;994.3685759542598;1008.6318493749728;1044.9425281609433;1048.3709774135457;1049.9895001050045;10784.784304314027;11022.724431889266;11190.384528850991;11214.271072380268;11353.262037967506;462971;471655;474574;476530;477118;109836;110208;110475.44762276138;110484;117707.41146294214;1201.9459124339426;1212.8605210400917;1229.0597692764863;1229.1580267516779;1233.4511142541483;21428.357149285548;21523;21618.567628647652;21641.78358216398;21921.890390547946;54692;56992.43007570037;57098.42901570931;57617.71191144017;58282.4171758277;71819.28180718335;72584.27415725775;72589.6370518144;73491.63254183695;73744.63127684327;12563.246205227715;14284.57146285613;14916.552503424915;15350.923245383701;15391.61520961985;23626.52746945017;23743.52512949766;23769.762302376756;23805.880970595037;23841;18429.26282948721;18613.906930465262;18754;18829.34097306588;18871.245150193838;15845.762313565076;16501.504954851374;16543.338266469207;17294.616430685768;17342.73985890238;18704.906475467535;18924.14841332116;19167;19299.807001930363;19399.515012124808;14918.552443426715;14967.251637418303;14968.925155374154;14969.850301496846;15006.549803505912;18770.436886893414;18971;19001.42995710131;19048.619027619647;19060.142293596546 06:30:59 INFO - PID 3157 | |3;mootools.html;1319.1952908725677;1368.5757415201288;1375.5116933488619;1392.6100691806298;1394.1565352961459;13667.794983075262;14274.857251427482;14293.642658933544;14317.355718992645;14345.856541434583;13471.932640336809;14430.494932677359;14510.564683059498;14512.129272243672;14534.563963081124;2703.91888243353;2759.779217662582;2771.2933202033455;2776.3753155540044;2781.401998570307;2590.870456477178;2631.7105118437053;2695.595660650908;2700.2844246274653;2741.931451713703;2612.8432294062322;2659.2421159969413;2660.162048954573;2663.73362663734;2665.466906618684;2531.822772405923;2574.5751950928075;2582.6255192997096;2591.3651155467032;2596.597527383249;2554.412485128431;2591.2744431559195;2598.8960441582312;2599.571070773339;2605.4137818990766;13657.931710341483;14042.648933776634;14076.648083797885;14087.225202613852;14097;7550.3582195513445;7837.960810195969;7857.253560911761;7864.5281283123195;7876.5667888266125;4912.115819152551;4967.379077615298;5067.822626208065;5189.6886186828915;5202.76587553561;1891.2529550827346;1908.6373589018042;1917.8657493975427;1944.387517931861;1969.5371587676884;21816.781832181634;21948;21996;22091.337259882068;22161.33515994523;6261.342559031327;6408.58344207625;6558.672066396661;6590.80227593173;6610.7686230982645;15316.923415382851;15334.616634584225;15336.079835209923;15358.769618455732;15364.769528457082;6924.549904256207;7376.852462950711;7558.470907036454;7558.962205188939;7573.318401343795;6750.223724271772;7180.31786980236;7182.604956727326;7183.389411900047;7202.855942881113;4712.387389639325;4743.501932297128;4830.589399900978;4844.909895273535;4900.872799256191;1332.4270563657526;1371.348609410542;1411.4213172599184;1433.8351089624618;1460.1093333066822;867.7873920889297;915.844306467902;917.0554329041098;923.9953800230955;932.3333816321363;7578.810529736801;7924.6037698116015;7993.200679932076;8025.07711613172;8123.18768123183;972.4894430424084;989.6338354808767;1013.1843865688045;1013.2704452793977;1020.739711373595;4923.507649235048;5132.615053870974;5153.922691159635;5163.7676304566385;5273.024490469275;19397.32109376165;20198.394048178285;20283.797162028484;20304.492387690425;20312.796872031387;18966.336178233694;19082.618347632968;19453.31913383025;19505.317313893946;19599.118039687964;10709.732256693489;11025.228234023542;11030.22788404804;11127.387993660264;11144;7480.214577469287;7828.491148075357;8265.421420500506;8286.4199506034;8289.58552072406;16122.193890305673;16375.590610234363;16849.91575042117;17016.744748829024;17175.65648687044;16945.915270423568;17226.827731723024;17244.827551724324;17267.654646907242;17449.825501745327;10978.670639880816;11205.887941120485;11222.326660400402;11231.26996745209;11248.100151987657;12948.546800861925;13205.273709946045;13322.33388330599;13350.866491334962;13368.799468007794;10108.949455252676;10505.31715438494;10621.628243011457;10759.784804303714;10882.401467919024;10128.59485620567;10150.74623134398;10485.951404859454;10517;10735.94632026835;9232.907670923474;9334.859977100214;9338.206252468344;9339.626414943326;9362.016988216412;6537;6929.307069293232;6999.09011828459;7027.789166325018;7043.577385356895;6842.384185423336;7216.530925489827;7345.77962661121;7352.11774587053;7420.5547667140145 06:30:59 INFO - PID 3157 | |4;prototype.html;496.55997606939894;503.9294498770172;524.4205153305597;535.0689799748436;538.1550964984975;6075.939240607592;6221.41353954742;6267.749290028399;6338.397852204039;6388.456981156602;6062.45437910589;6107.969460152693;6139.324674285836;6145.477634401082;6157.291911430187;4973.751312434382;4991.500849914997;4991.525805048533;4998.325226094467;5029.698218106907;4992.40091189056;4995.975020124894;5004.124278251292;5004.874878128039;5029.647924645276;4816.518348165173;4985.476524964881;5004.224345226496;5029.899402011957;5040.697558146523;4842.44311904132;4955.999999999982;4970.950290497103;4974.950250497485;4978.253262010691;4413.58070983256;4450.376947227391;4465.441819772528;4523.36672865799;4533.591976722078;6105.267367915834;6144.84637884052;6217.968910155466;6223.346548612376;6234.968825155891;5516.455392490109;5668.319801623831;5739;5753;5787.102999035156;6481;6485.67571621417;6488.188976377953;6523.93476065238;6581.506387020945;4840.6127509799135;4862.222044472867;4887.7311747853855;4942.530459606368;4952.826651067231;6751.291114433012;6844.247132815386;6959.234484206733;7014.824629384255;7040.823979400556;5044.445111037783;5057;5067.619928505377;5076.949230507647;5080.263361812516;5130.358705161855;5152.793888244503;5168.638195326366;5169.741512924414;5173.611979101583;5605.5895964735555;5675.701340956919;5697.6296540724725;5697.857553561194;5771.249737534094;6480.222373315138;6537.771178008842;6550.508711846631;6577.2436169841085;6589.703463344161;1677.9748303775452;1736.8797125854005;1771.9468415947542;1772.6100257943233;1803.1344954421952;1166.6383421139474;1233.9516402771355;1237.0207667731559;1258.2890666773244;1263.4693428759942;5668.376478587352;5707.315122185281;5710.314762228559;5711.114777209539;5757.769689212469;6475.417212450902;6547.410733033955;6632.403083722488;6636.767713130017;6717.798466046026;5730.828075157752;5756.740946657411;5762.683052432157;5779.942200578024;5825.7378417971295;3562.5546806649168;3585.533880595558;3594.928101438009;3638.1268495560876;3648.872289469856;6517.641529715911;6518.185226846645;6524.934750652433;6575.868482630321;6578.375054369827;6967.512274140863;6972.51192416526;6977.720891164398;7012.368886800213;7022.297770223039;6385.776497822554;6471.644059576768;6486.610803351814;6490.182748830241;6544.214694236627;6647.437852104848;6650;6733.225679046776;6738.157730283715;6771.695273712793;6584.76953306632;6599.967000164968;6610.4711623071;6645.700943457459;6663.36698013688;6379.926523879665;6423.550351475352;6434.099226108255;6450.612963222222;6473.996530537775;4964.404271487445;4980.477049909852;4994.550490455877;5034.622403319839;5059.06407314648;6538.476921846336;6734.56225345351;6738.966305168443;6809.182898052265;6813.148356455443;6361.201071528512;6469.902951455826;6502.902456463252;6527.477801775942;6568.967155164193;6468.795283066045;6504.503964088191;6529.151210342625;6536.542442029203;6582.3746744059235;5958.940410595838;6091.939080609137;6336.20797400325;6424.582402143846;6454.064160696579;6438.323975982642;6459.935400645933;6483.902741458787;6536.640484773383;6541.34586541342;6315.747370105144;6322.747090116344;6329.430351268408;6356.300806911144;6380.649064301322 06:30:59 INFO - PID 3157 | |5;yui.html;905.6558507767047;911.4030310146852;913.977150571236;929.4702019848685;931.6785708930419;16581.336746530156;18122.18450169744;19078;19120.139593718282;19271.32550360736;16363.854530182862;18305.54236144097;20468.07893644786;20512.28207012755;20654.38036858893;956.4213650741306;997.8303688372957;1010.7675234696006;1036.5801850250662;1037.5227395398126;1058.179910569311;1060.7189094889861;1060.862087928572;1061.4215252687266;1065.1585247654343;1071.5231721883765;1110.6057349640882;1114.3926560024765;1116.865976082867;1117.044926587768;1096.3202814255133;1100.2958106811648;1109.1958330210614;1109.2346281066039;1109.362116782849;794.2295972906271;798.9041315042174;799.1768478467188;800.1278606319082;800.9159038300953;18037.909810450863;18428.078596070143;19061.809381906143;19242.615147697106;19269.614607707907;19898.801011989985;20284.5943081139;20969.370918872457;20982.895085524473;21054.26310079155;14803.185824779634;14807.777883331759;14943.925280373638;15059.623509412242;15081.924590377088;3487.7035451986612;3541.0793193769546;3547.592026916912;3548.946765798515;3549.0240183949363;121604;121715;127481.36259318644;128788.35605821911;131086;14755.77866332006;15415.383384664488;15485.767713484307;15623.218839058229;15684.294206760724;29279.707202928123;29632.851835740683;29674.109776706733;29720;29810.701892980793;8055.718049868226;8485.109063548362;8505.95747021261;8573.399862009599;8583.18459746323;3728.813559322023;3912.4522566840665;4003.979980100081;4170.207660544487;4299.591538803808;5132.435432102466;5227.869303267449;5231.267622532849;5231.633785635046;5236.083685355047;1036.7511797168625;1071.0842229893485;1071.1912506057877;1081.8972197641212;1083.4420273559124;681.9488538359643;688.5730846874969;704.257008855652;709.7054722290295;716.7706333973183;11379.203455758017;11449.484773185226;11457.312561246352;12363.62909112728;12966;697.5953946710896;705.3334598804183;708.3518580498888;708.3518580498888;722.4256715910864;5095.87260318495;5279.52484276417;5408.45915408456;5533.446655334435;5724.513416359573;101034.4948275254;101895;102699;107637.46181269044;114792;89450;97105;97276;99509;101727;77532;79680.20319796844;92218.53890730637;92254;92706;12434.316112613893;12494.625161245178;12772.680682983;12942.417591208607;13057.21656700601;38503.422448662735;38855.61144388633;40219.798901005306;41890.37164442597;42429.36355954725;73141.6342918282;76251;77661.22338776539;77764;82238.17761822305;19779.307724229584;20342.389728308175;20377.69433458529;20402.693959590913;20637;20680.68978965347;21012.022697895794;21432.357029289145;22322.21872234464;22650.886745566168;18904.905475472533;19626;19796.802031979496;19963.20147194096;19980.800191998474;18404.17181226821;19069.237230510626;19152.425427237205;19403.4178974631;19691.40925772229;18799.342023029127;18923.23190010264;19131.61736765285;19373.612527749083;19635.901820491377;14082.507112251433;14095.506657266946;14113;14283.571492855232;14750.852491474949;14156.43374265059;14999.2500374983;15025.774613381027;15035.924820375829;15248.3900643973 06:30:59 INFO - PID 3157 | __end_tp_report 06:30:59 INFO - PID 3157 | __start_cc_report 06:30:59 INFO - PID 3157 | _x_x_mozilla_cycle_collect,360 06:30:59 INFO - PID 3157 | __end_cc_report 06:30:59 INFO - PID 3157 | __startTimestamp1500989459348__endTimestamp 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | ------- Summary: start ------- 06:30:59 INFO - PID 3157 | Number of tests: 6 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | [#0] dojo.html Cycles:165 Average:6101.79 Median:6407.36 stddev:860.70 (13.4%) stddev-sans-first:830.50 06:30:59 INFO - PID 3157 | Values: 3100.2 3102.8 3138.1 3142.2 3195.8 6161.1 6256.2 6286.8 6328.4 6336.0 6092.4 6203.0 6242.8 6338.1 6355.4 5689.5 5751.6 5773.5 5808.1 5808.2 224.8 5651.3 5769.0 5811.1 5831.2 5666.3 5681.5 5756.4 5762.3 5767.9 5686.1 5704.7 5757.9 5763.6 5773.8 5655.6 5659.9 5732.0 5732.1 5742.5 6052.5 6140.3 6202.7 6248.8 6251.4 6480.7 6559.3 6571.2 6600.0 6604.3 6768.6 6790.2 6810.4 6811.5 6818.2 6138.1 6148.7 6227.8 6228.2 6301.8 6589.8 6652.5 6827.5 6936.8 6941.8 6524.7 6611.4 6617.8 6620.7 6635.8 6657.4 6684.8 6699.3 6754.9 6763.8 6545.1 6630.1 6639.9 6665.1 6764.3 6477.9 6556.7 6564.2 6570.1 6770.0 5259.3 5314.7 5381.8 5401.3 5415.5 4463.6 4558.7 4577.0 4587.6 4618.7 5595.2 5644.6 5713.2 5719.7 5741.4 6535.7 6635.6 6636.3 6643.0 6643.6 5675.7 5678.2 5678.3 5683.1 5700.6 5866.1 5916.9 5925.8 5926.4 5937.3 6494.2 6499.3 6565.3 6573.3 6586.0 6450.3 6724.0 6757.1 6772.7 6813.3 6419.4 6453.9 6503.3 6518.5 6533.9 6420.5 6504.4 6517.9 6519.4 6577.5 6563.9 6585.3 6637.5 6665.3 6703.4 6298.6 6352.0 6373.8 6454.6 6467.2 6532.5 6565.2 6580.9 6591.9 6622.0 6358.0 6417.8 6486.5 6516.3 6517.5 6407.4 6504.9 6516.3 6571.8 6636.0 6280.6 6378.9 6395.0 6407.8 6429.5 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | [#1] ext.html Cycles:180 Average:37388.83 Median:35105.65 stddev:53679.10 (152.9%) stddev-sans-first:53759.39 06:30:59 INFO - PID 3157 | Values: 803.4 835.7 873.9 877.6 1158.8 30398.8 40945.0 42263.6 42273.8 42278.0 41277.4 41488.4 41526.6 41823.8 41890.4 7089.9 7327.5 7647.6 7657.4 7658.9 7539.9 7565.2 7652.5 7656.2 7659.0 7568.1 7628.5 7640.0 7643.7 7667.4 7586.6 7610.9 7639.5 7643.3 7646.8 7465.5 7561.5 7564.8 7567.8 7570.7 38130.2 38309.0 38398.6 38490.2 38515.2 3624.2 3629.0 3634.3 3640.9 3646.9 30312.4 30620.4 30661.7 30705.0 30852.4 4685.5 4766.1 4916.1 4978.6 5067.6 178623.0 178713.0 179243.0 180157.0 180930.0 47921.5 47978.0 48056.5 49053.8 49965.5 51144.0 51170.0 51255.7 51475.7 51540.0 14971.0 14984.0 16401.8 16670.7 16676.7 13490.3 13496.7 13505.5 13596.3 13609.0 14177.9 14299.4 14305.7 14321.7 14348.0 5758.4 5763.9 5770.0 5842.2 5871.4 987.3 1006.2 1015.1 1015.7 1037.0 22395.6 22613.3 22645.4 22651.3 23213.3 1070.8 1103.9 1125.8 1128.5 1129.5 11964.0 12072.3 12130.0 12135.4 12317.7 231975.0 232919.0 233118.0 234037.0 234311.0 50596.7 50949.5 51088.0 51109.0 51471.0 1450.5 1472.4 1488.9 1493.2 1495.6 21867.5 21993.0 22081.9 22190.9 22231.8 36040.5 36135.1 36319.6 36344.1 47889.0 204210.0 204468.0 204817.0 205270.0 205332.0 34888.8 35374.6 35550.3 35565.3 35627.5 42085.6 43977.3 44318.8 44461.8 44530.8 30773.7 31581.4 32193.0 32242.0 32293.0 29943.7 31938.8 32450.4 32617.0 32625.2 34499.8 34868.8 34964.3 35054.5 35156.8 29500.7 30371.2 30714.7 31009.4 31171.0 21581.4 22744.8 22894.2 23184.5 23464.6 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | [#2] jquery.html Cycles:180 Average:34452.81 Median:2292.86 stddev:79736.18 (3477.6%) stddev-sans-first:79919.26 06:30:59 INFO - PID 3157 | Values: 563.9 572.8 586.4 588.9 603.4 22346.7 22505.3 23162.1 23163.2 23244.9 25474.1 26141.6 26160.7 26174.0 26225.9 6513.7 6669.2 6672.3 6673.5 6676.0 6126.1 6181.5 6255.5 6557.5 6605.0 6512.9 6525.1 6538.1 6543.1 6567.0 6505.3 6528.3 6532.1 6536.9 6543.0 6095.4 6099.7 6102.4 6108.2 6114.8 28633.0 29668.6 30298.2 30381.2 30635.1 1924.3 1960.4 1974.9 1980.3 1981.0 18762.6 19603.0 19610.4 19615.1 19624.4 2284.3 2301.4 2334.3 2403.8 2459.1 132237.0 135342.0 136987.0 140626.0 140662.0 14191.5 14589.7 15147.4 15383.0 15511.1 23601.3 23614.5 23643.9 23646.2 23673.4 10776.5 10796.7 10861.8 10952.6 11013.9 8491.5 10083.3 10172.2 10191.1 10336.6 8190.6 9228.9 9285.7 9324.7 9407.6 2731.3 2761.2 2792.7 2849.2 2874.2 950.1 954.5 962.7 983.2 995.3 19462.2 19635.3 19767.6 19986.6 20177.6 994.4 1008.6 1044.9 1048.4 1050.0 10784.8 11022.7 11190.4 11214.3 11353.3 462971.0 471655.0 474574.0 476530.0 477118.0 109836.0 110208.0 110475.4 110484.0 117707.4 1201.9 1212.9 1229.1 1229.2 1233.5 21428.4 21523.0 21618.6 21641.8 21921.9 54692.0 56992.4 57098.4 57617.7 58282.4 71819.3 72584.3 72589.6 73491.6 73744.6 12563.2 14284.6 14916.6 15350.9 15391.6 23626.5 23743.5 23769.8 23805.9 23841.0 18429.3 18613.9 18754.0 18829.3 18871.2 15845.8 16501.5 16543.3 17294.6 17342.7 18704.9 18924.1 19167.0 19299.8 19399.5 14918.6 14967.3 14968.9 14969.9 15006.5 18770.4 18971.0 19001.4 19048.6 19060.1 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | [#3] mootools.html Cycles:180 Average:8684.34 Median:2578.60 stddev:5893.36 (228.5%) stddev-sans-first:5883.91 06:30:59 INFO - PID 3157 | Values: 1319.2 1368.6 1375.5 1392.6 1394.2 13667.8 14274.9 14293.6 14317.4 14345.9 13471.9 14430.5 14510.6 14512.1 14534.6 2703.9 2759.8 2771.3 2776.4 2781.4 2590.9 2631.7 2695.6 2700.3 2741.9 2612.8 2659.2 2660.2 2663.7 2665.5 2531.8 2574.6 2582.6 2591.4 2596.6 2554.4 2591.3 2598.9 2599.6 2605.4 13657.9 14042.6 14076.6 14087.2 14097.0 7550.4 7838.0 7857.3 7864.5 7876.6 4912.1 4967.4 5067.8 5189.7 5202.8 1891.3 1908.6 1917.9 1944.4 1969.5 21816.8 21948.0 21996.0 22091.3 22161.3 6261.3 6408.6 6558.7 6590.8 6610.8 15316.9 15334.6 15336.1 15358.8 15364.8 6924.5 7376.9 7558.5 7559.0 7573.3 6750.2 7180.3 7182.6 7183.4 7202.9 4712.4 4743.5 4830.6 4844.9 4900.9 1332.4 1371.3 1411.4 1433.8 1460.1 867.8 915.8 917.1 924.0 932.3 7578.8 7924.6 7993.2 8025.1 8123.2 972.5 989.6 1013.2 1013.3 1020.7 4923.5 5132.6 5153.9 5163.8 5273.0 19397.3 20198.4 20283.8 20304.5 20312.8 18966.3 19082.6 19453.3 19505.3 19599.1 10709.7 11025.2 11030.2 11127.4 11144.0 7480.2 7828.5 8265.4 8286.4 8289.6 16122.2 16375.6 16849.9 17016.7 17175.7 16945.9 17226.8 17244.8 17267.7 17449.8 10978.7 11205.9 11222.3 11231.3 11248.1 12948.5 13205.3 13322.3 13350.9 13368.8 10108.9 10505.3 10621.6 10759.8 10882.4 10128.6 10150.7 10486.0 10517.0 10735.9 9232.9 9334.9 9338.2 9339.6 9362.0 6537.0 6929.3 6999.1 7027.8 7043.6 6842.4 7216.5 7345.8 7352.1 7420.6 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | [#4] prototype.html Cycles:180 Average:5506.82 Median:6123.65 stddev:1535.77 (25.1%) stddev-sans-first:1493.33 06:30:59 INFO - PID 3157 | Values: 496.6 503.9 524.4 535.1 538.2 6075.9 6221.4 6267.7 6338.4 6388.5 6062.5 6108.0 6139.3 6145.5 6157.3 4973.8 4991.5 4991.5 4998.3 5029.7 4992.4 4996.0 5004.1 5004.9 5029.6 4816.5 4985.5 5004.2 5029.9 5040.7 4842.4 4956.0 4971.0 4975.0 4978.3 4413.6 4450.4 4465.4 4523.4 4533.6 6105.3 6144.8 6218.0 6223.3 6235.0 5516.5 5668.3 5739.0 5753.0 5787.1 6481.0 6485.7 6488.2 6523.9 6581.5 4840.6 4862.2 4887.7 4942.5 4952.8 6751.3 6844.2 6959.2 7014.8 7040.8 5044.4 5057.0 5067.6 5076.9 5080.3 5130.4 5152.8 5168.6 5169.7 5173.6 5605.6 5675.7 5697.6 5697.9 5771.2 6480.2 6537.8 6550.5 6577.2 6589.7 1678.0 1736.9 1771.9 1772.6 1803.1 1166.6 1234.0 1237.0 1258.3 1263.5 5668.4 5707.3 5710.3 5711.1 5757.8 6475.4 6547.4 6632.4 6636.8 6717.8 5730.8 5756.7 5762.7 5779.9 5825.7 3562.6 3585.5 3594.9 3638.1 3648.9 6517.6 6518.2 6524.9 6575.9 6578.4 6967.5 6972.5 6977.7 7012.4 7022.3 6385.8 6471.6 6486.6 6490.2 6544.2 6647.4 6650.0 6733.2 6738.2 6771.7 6584.8 6600.0 6610.5 6645.7 6663.4 6379.9 6423.6 6434.1 6450.6 6474.0 4964.4 4980.5 4994.6 5034.6 5059.1 6538.5 6734.6 6739.0 6809.2 6813.1 6361.2 6469.9 6502.9 6527.5 6569.0 6468.8 6504.5 6529.2 6536.5 6582.4 5958.9 6091.9 6336.2 6424.6 6454.1 6438.3 6459.9 6483.9 6536.6 6541.3 6315.7 6322.7 6329.4 6356.3 6380.6 06:30:59 INFO - PID 3157 | 06:30:59 INFO - PID 3157 | [#5] yui.html Cycles:180 Average:23870.55 Median:19931.00 stddev:32138.73 (161.2%) stddev-sans-first:32182.62 06:30:59 INFO - PID 3157 | Values: 905.7 911.4 914.0 929.5 931.7 16581.3 18122.2 19078.0 19120.1 19271.3 16363.9 18305.5 20468.1 20512.3 20654.4 956.4 997.8 1010.8 1036.6 1037.5 1058.2 1060.7 1060.9 1061.4 1065.2 1071.5 1110.6 1114.4 1116.9 1117.0 1096.3 1100.3 1109.2 1109.2 1109.4 794.2 798.9 799.2 800.1 800.9 18037.9 18428.1 19061.8 19242.6 19269.6 19898.8 20284.6 20969.4 20982.9 21054.3 14803.2 14807.8 14943.9 15059.6 15081.9 3487.7 3541.1 3547.6 3548.9 3549.0 121604.0 121715.0 127481.4 128788.4 131086.0 14755.8 15415.4 15485.8 15623.2 15684.3 29279.7 29632.9 29674.1 29720.0 29810.7 8055.7 8485.1 8506.0 8573.4 8583.2 3728.8 3912.5 4004.0 4170.2 4299.6 5132.4 5227.9 5231.3 5231.6 5236.1 1036.8 1071.1 1071.2 1081.9 1083.4 681.9 688.6 704.3 709.7 716.8 11379.2 11449.5 11457.3 12363.6 12966.0 697.6 705.3 708.4 708.4 722.4 5095.9 5279.5 5408.5 5533.4 5724.5 101034.5 101895.0 102699.0 107637.5 114792.0 89450.0 97105.0 97276.0 99509.0 101727.0 77532.0 79680.2 92218.5 92254.0 92706.0 12434.3 12494.6 12772.7 12942.4 13057.2 38503.4 38855.6 40219.8 41890.4 42429.4 73141.6 76251.0 77661.2 77764.0 82238.2 19779.3 20342.4 20377.7 20402.7 20637.0 20680.7 21012.0 21432.4 22322.2 22650.9 18904.9 19626.0 19796.8 19963.2 19980.8 18404.2 19069.2 19152.4 19403.4 19691.4 18799.3 18923.2 19131.6 19373.6 19635.9 14082.5 14095.5 14113.0 14283.6 14750.9 14156.4 14999.3 15025.8 15035.9 15248.4 06:30:59 INFO - PID 3157 | -------- Summary: end -------- 06:30:59 INFO - PID 3157 | 06:31:00 INFO - TEST-INFO | 3157: exit 0 06:31:00 INFO - TEST-OK | dromaeo_css | took 1112113ms 06:31:00 INFO - TEST-START | kraken 06:31:00 INFO - Initialising browser for kraken test... 06:31:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49275/getInfo.html -profile /tmp/tmp965ImW/profile 06:31:00 INFO - TEST-INFO | started process 3535 (/builds/slave/test/build/application/firefox/firefox http://localhost:49275/getInfo.html) 06:31:06 INFO - TEST-INFO | 3535: exit 0 06:31:06 INFO - Browser initialized. 06:31:06 INFO - Running cycle 1/1 for kraken test... 06:31:06 INFO - TEST-INFO | started process 3762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp965ImW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:07 INFO - PID 3762 | 06:31:07 INFO - PID 3762 | (/builds/slave/test/build/application/firefox/firefox:3817): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:31:07 INFO - PID 3762 | 06:31:17 INFO - PID 3762 | RSS: Main: 172326912 06:31:17 INFO - PID 3762 | 06:31:20 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:21 INFO - PID 3762 | RSS: Main: 178556928 06:31:21 INFO - PID 3762 | 06:31:23 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:31:24 INFO - PID 3762 | RSS: Main: 177983488 06:31:24 INFO - PID 3762 | 06:31:27 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:31:28 INFO - PID 3762 | RSS: Main: 173826048 06:31:28 INFO - PID 3762 | 06:31:30 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:31:31 INFO - PID 3762 | RSS: Main: 173625344 06:31:31 INFO - PID 3762 | 06:31:33 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:33 INFO - PID 3762 | RSS: Main: 174678016 06:31:33 INFO - PID 3762 | 06:31:36 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:37 INFO - PID 3762 | RSS: Main: 177348608 06:31:37 INFO - PID 3762 | 06:31:41 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:41 INFO - PID 3762 | RSS: Main: 176496640 06:31:41 INFO - PID 3762 | 06:31:44 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:31:45 INFO - PID 3762 | RSS: Main: 177717248 06:31:45 INFO - PID 3762 | 06:31:46 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:31:47 INFO - PID 3762 | RSS: Main: 178143232 06:31:47 INFO - PID 3762 | 06:31:49 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:49 INFO - PID 3762 | RSS: Main: 174891008 06:31:49 INFO - PID 3762 | 06:31:52 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:52 INFO - PID 3762 | RSS: Main: 174956544 06:31:52 INFO - PID 3762 | 06:31:55 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:56 INFO - PID 3762 | RSS: Main: 175349760 06:31:56 INFO - PID 3762 | 06:31:59 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:31:59 INFO - PID 3762 | RSS: Main: 175181824 06:31:59 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:32:01 INFO - PID 3762 | RSS: Main: 176893952 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | __start_tp_report 06:32:01 INFO - PID 3762 | _x_x_mozilla_page_load 06:32:01 INFO - PID 3762 | _x_x_mozilla_page_load_details 06:32:01 INFO - PID 3762 | |i|pagename|runs| 06:32:01 INFO - PID 3762 | |0;ai-astar;101;111;102;109;109;110;112;107;111;109 06:32:01 INFO - PID 3762 | |1;audio-beat-detection;148;118;149;193;124;148;158;125;176;123 06:32:01 INFO - PID 3762 | |2;audio-dft;163;164;163;162;162;161;170;168;162;169 06:32:01 INFO - PID 3762 | |3;audio-fft;76;79;76;182;76;74;76;88;99;75 06:32:01 INFO - PID 3762 | |4;audio-oscillator;80;81;140;81;81;82;128;82;81;129 06:32:01 INFO - PID 3762 | |5;imaging-gaussian-blur;114;115;114;114;114;114;115;113;114;117 06:32:01 INFO - PID 3762 | |6;imaging-darkroom;153;151;150;151;151;151;151;154;153;154 06:32:01 INFO - PID 3762 | |7;imaging-desaturate;94;94;93;94;99;99;99;95;99;94 06:32:01 INFO - PID 3762 | |8;json-parse-financial;56;63;55;54;55;55;58;63;55;55 06:32:01 INFO - PID 3762 | |9;json-stringify-tinderbox;53;54;54;54;53;53;60;54;57;53 06:32:01 INFO - PID 3762 | |10;stanford-crypto-aes;78;84;77;85;80;77;81;88;79;80 06:32:01 INFO - PID 3762 | |11;stanford-crypto-ccm;128;126;132;130;130;125;126;132;130;164 06:32:01 INFO - PID 3762 | |12;stanford-crypto-pbkdf2;173;181;174;191;183;189;191;180;176;183 06:32:01 INFO - PID 3762 | |13;stanford-crypto-sha256-iterative;70;70;72;69;68;67;67;67;70;68 06:32:01 INFO - PID 3762 | __end_tp_report 06:32:01 INFO - PID 3762 | __start_cc_report 06:32:01 INFO - PID 3762 | _x_x_mozilla_cycle_collect,975 06:32:01 INFO - PID 3762 | __end_cc_report 06:32:01 INFO - PID 3762 | __startTimestamp1500989521933__endTimestamp 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | ------- Summary: start ------- 06:32:01 INFO - PID 3762 | Number of tests: 14 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.75 (3.4%) stddev-sans-first:2.98 06:32:01 INFO - PID 3762 | Values: 101.0 111.0 102.0 109.0 109.0 110.0 112.0 107.0 111.0 109.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:148.50 stddev:24.74 (16.7%) stddev-sans-first:26.23 06:32:01 INFO - PID 3762 | Values: 148.0 118.0 149.0 193.0 124.0 148.0 158.0 125.0 176.0 123.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.31 (2.0%) stddev-sans-first:3.47 06:32:01 INFO - PID 3762 | Values: 163.0 164.0 163.0 162.0 162.0 161.0 170.0 168.0 162.0 169.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#3] audio-fft Cycles:10 Average:90.10 Median:76.00 stddev:33.22 (43.7%) stddev-sans-first:34.85 06:32:01 INFO - PID 3762 | Values: 76.0 79.0 76.0 182.0 76.0 74.0 76.0 88.0 99.0 75.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:81.00 stddev:24.93 (30.8%) stddev-sans-first:25.72 06:32:01 INFO - PID 3762 | Values: 80.0 81.0 140.0 81.0 81.0 82.0 128.0 82.0 81.0 129.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 06:32:01 INFO - PID 3762 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 115.0 113.0 114.0 117.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:1.45 (1.0%) stddev-sans-first:1.48 06:32:01 INFO - PID 3762 | Values: 153.0 151.0 150.0 151.0 151.0 151.0 151.0 154.0 153.0 154.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:97.00 stddev:2.62 (2.7%) stddev-sans-first:2.68 06:32:01 INFO - PID 3762 | Values: 94.0 94.0 93.0 94.0 99.0 99.0 99.0 95.0 99.0 94.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:55.50 stddev:3.38 (6.1%) stddev-sans-first:3.57 06:32:01 INFO - PID 3762 | Values: 56.0 63.0 55.0 54.0 55.0 55.0 58.0 63.0 55.0 55.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:2.27 (4.2%) stddev-sans-first:2.35 06:32:01 INFO - PID 3762 | Values: 53.0 54.0 54.0 54.0 53.0 53.0 60.0 54.0 57.0 53.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:3.67 (4.6%) stddev-sans-first:3.73 06:32:01 INFO - PID 3762 | Values: 78.0 84.0 77.0 85.0 80.0 77.0 81.0 88.0 79.0 80.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:130.00 stddev:11.41 (8.8%) stddev-sans-first:12.00 06:32:01 INFO - PID 3762 | Values: 128.0 126.0 132.0 130.0 130.0 125.0 126.0 132.0 130.0 164.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:183.00 stddev:6.66 (3.6%) stddev-sans-first:6.19 06:32:01 INFO - PID 3762 | Values: 173.0 181.0 174.0 191.0 183.0 189.0 191.0 180.0 176.0 183.0 06:32:01 INFO - PID 3762 | 06:32:01 INFO - PID 3762 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.69 (2.4%) stddev-sans-first:1.73 06:32:01 INFO - PID 3762 | Values: 70.0 70.0 72.0 69.0 68.0 67.0 67.0 67.0 70.0 68.0 06:32:01 INFO - PID 3762 | -------- Summary: end -------- 06:32:01 INFO - PID 3762 | 06:32:02 INFO - PID 3762 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:32:02 INFO - TEST-INFO | 3762: exit 0 06:32:02 INFO - TEST-OK | kraken | took 62639ms 06:32:02 INFO - SUITE-END | took 1174s 06:32:03 INFO - Completed test suite (00:19:35) 06:32:03 INFO - javascript benchmark 06:32:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8478.276027989297, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.1629560018796, 3102.798318109324, 3138.0585824252717, 3142.1987393214727, 3195.7762956593033, 6161.075838624203, 6256.186695729549, 6286.811395658137, 6328.367163283664, 6335.9683201583985, 6092.421219984094, 6203.038529027996, 6242.812715618527, 6338.144350512679, 6355.428011478966, 5689.51639110674, 5751.56863235257, 5773.451522105414, 5808.12878068289, 5808.157817116505, 224.7804238254307, 5651.32184137904, 5769.0, 5811.0702287633985, 5831.212786273863, 5666.320041595014, 5681.545476361881, 5756.366799652035, 5762.308522977249, 5767.855803604902, 5686.118651609007, 5704.743286552115, 5757.856053598652, 5763.567732420085, 5773.826785196451, 5655.575831812631, 5659.8585035374035, 5732.0255556555485, 5732.082866741302, 5742.54059675225, 6052.54605904559, 6140.263168419773, 6202.658853763041, 6248.812535623939, 6251.406116418979, 6480.708368123399, 6559.278479367265, 6571.244306904719, 6600.0, 6604.339566043405, 6768.5600435972, 6790.185177778649, 6810.387065164109, 6811.523193376465, 6818.2159051708695, 6138.109974053782, 6148.7233074511305, 6227.782027629057, 6228.22147231596, 6301.810945671591, 6589.80230593083, 6652.534322597372, 6827.52207345481, 6936.826579335557, 6941.757038503628, 6524.706388212542, 6611.438027767597, 6617.834554136185, 6620.702068406933, 6635.767748128792, 6657.367550082734, 6684.766033188815, 6699.296573859772, 6754.932450675528, 6763.7632682855865, 6545.14913061299, 6630.1380820494, 6639.867202656016, 6665.133532640726, 6764.323567643295, 6477.902831457532, 6556.737730490822, 6564.179477565304, 6570.080188773575, 6770.018347339608, 5259.342582177228, 5314.73426328682, 5381.838544843661, 5401.270828438189, 5415.53967912724, 4463.598276155161, 4558.680892337505, 4576.954230457719, 4587.632989360844, 4618.65360097994, 5595.160725891149, 5644.604877658525, 5713.171590119493, 5719.7140142992685, 5741.368449470555, 6535.738570457223, 6635.601863888182, 6636.303188165173, 6643.0, 6643.60138391698, 5675.744591493392, 5678.205051292823, 5678.290213723285, 5683.062294721407, 5700.600957932905, 5866.061430171152, 5916.852078698067, 5925.792597259161, 5926.407359264125, 5937.346891841894, 6494.220693516808, 6499.2850786413455, 6565.310642382481, 6573.309802470767, 6586.04502347157, 6450.322716114928, 6723.966380168068, 6757.100086182433, 6772.661366931732, 6813.318668133147, 6419.390157934989, 6453.870922581616, 6503.317151699192, 6518.5111116667385, 6533.934660653333, 6420.486361091008, 6504.378041677899, 6517.902231466437, 6519.4132528072705, 6577.539572229898, 6563.9343606565235, 6585.3085426029575, 6637.469002479694, 6665.300143484864, 6703.363180497845, 6298.5905916117135, 6351.968240158954, 6373.808785736435, 6454.612723236621, 6467.223933128054, 6532.477401807749, 6565.212174539086, 6580.868382632416, 6591.868162636816, 6622.039804228456, 6358.046293056079, 6417.7753778617525, 6486.513511486563, 6516.250631177475, 6517.543771936109, 6407.359264073555, 6504.902426463512, 6516.283208847118, 6571.769988050395, 6636.037774522763, 6280.623162610258, 6378.87242255143, 6394.968025159845, 6407.807765767035, 6429.54993150475], "value": 6041.078268527423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.4094940218941, 835.707502374169, 873.9300855931526, 877.5919197573127, 1158.7798318319524, 30398.848005759966, 40945.0, 42263.57736422639, 42273.7886310568, 42278.0, 41277.38083928736, 41488.377674334835, 41526.584734152646, 41823.79088104563, 41890.37164442536, 7089.929100708991, 7327.487075904689, 7647.579383133925, 7657.387409007266, 7658.923410765905, 7539.924600754004, 7565.243475652445, 7652.464327497078, 7656.196099409565, 7659.0, 7568.053993250844, 7628.466007379486, 7640.044994375703, 7643.656035478417, 7667.42494312926, 7586.62066896653, 7610.885836712426, 7639.465237433354, 7643.273888980538, 7646.808829779245, 7465.477416580841, 7561.508501947355, 7564.773056808304, 7567.810804729871, 7570.735024274179, 38130.23739525194, 38309.0, 38398.61601383978, 38490.230195396216, 38515.22969540622, 3624.1664417183933, 3629.038304849217, 3634.27314537091, 3640.9271814563826, 3646.9452958205648, 30312.393752124834, 30620.387592248255, 30661.693383066107, 30705.0, 30852.382952341053, 4685.508021657711, 4766.118268120409, 4916.139675556799, 4978.551930326252, 5067.6452648314635, 178623.0, 178713.0, 179242.9999999987, 180157.0, 180930.0, 47921.5207847924, 47978.0, 48056.5194348052, 49053.754731226116, 49965.500344996086, 51144.0, 51170.0, 51255.74372128116, 51475.742621287405, 51540.0, 14971.0, 14984.0, 16401.753973690404, 16670.66658666844, 16676.74984875228, 13490.325483725774, 13496.662583435296, 13505.527306544223, 13596.252206128758, 13609.047366684237, 14177.929110354382, 14299.428022879176, 14305.713885722227, 14321.713565728627, 14348.0, 5758.3665796762325, 5763.942360576424, 5770.0, 5842.166549223623, 5871.383504732027, 987.3187500624546, 1006.2302338710892, 1015.1219195395929, 1015.7003683913264, 1037.0096557787294, 22395.552088958455, 22613.321600352017, 22645.43386415353, 22651.320460386214, 23213.303600892, 1070.769784496337, 1103.8564986551696, 1125.8198688209848, 1128.542940109257, 1129.4522156753967, 11964.0, 12072.336021518726, 12130.0, 12135.393230338448, 12317.69205769845, 231975.0, 232919.0, 233118.0, 234037.0, 234311.0, 50596.74701626542, 50949.49050509447, 51088.0, 51109.0, 51471.0, 1450.4923276853228, 1472.3963175098158, 1488.8511148885025, 1493.2309860421892, 1495.5662857771342, 21867.453313667287, 21993.0, 22081.889590551946, 22190.889045554668, 22231.77768222362, 36040.459393109646, 36135.09662258464, 36319.63680363163, 36344.09139771527, 47889.0, 204210.0, 204468.0, 204817.0, 205270.0, 205332.0, 34888.825555872056, 35374.64625353713, 35550.28899421945, 35565.28869422649, 35627.46558801568, 42085.57914420817, 43977.34033989429, 44318.77840610776, 44461.77769111134, 44530.777346113064, 30773.692263077082, 31581.368372631958, 32193.0, 32242.0, 32293.0, 29943.700562994964, 31938.840305798323, 32450.350992979536, 32617.0, 32625.18437039093, 34499.82750086234, 34868.82565587156, 34964.300713986086, 35054.47418288677, 35156.824215878754, 29500.704992949795, 30371.2407189822, 30714.692853071185, 31009.379812404077, 31171.0, 21581.35255942324, 22744.772552274266, 22894.198703045313, 23184.536309273382, 23464.64803027922], "value": 17069.739658119215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.901317269478, 572.8338781753291, 586.422373961648, 588.8675048114175, 603.4297588778603, 22346.664800027993, 22505.324840254776, 23162.073517059318, 23163.18928837491, 23244.88377558112, 25474.108406205785, 26141.60787588183, 26160.73839261607, 26174.0, 26225.868870655668, 6513.67431628419, 6669.233038200597, 6672.332766723337, 6673.4661227101715, 6676.0, 6126.111713801496, 6181.536384771138, 6255.499560035186, 6557.475401967831, 6605.0422688710105, 6512.925367314388, 6525.119108920282, 6538.084668146464, 6543.083968244449, 6567.047778072177, 6505.251896031922, 6528.281888992184, 6532.085508028856, 6536.888728916096, 6542.967285163568, 6095.359987201325, 6099.664518451484, 6102.359252278536, 6108.205933228696, 6114.816555503342, 28633.0, 29668.554971675443, 30298.242543936358, 30381.24046898823, 30635.08094757161, 1924.316867512027, 1960.3922783937026, 1974.8518861085477, 1980.2673010985884, 1981.0391959899437, 18762.62474750511, 19603.0, 19610.411687649394, 19615.117319720648, 19624.41126766199, 2284.303287497313, 2301.4131396493785, 2334.3107937719446, 2403.783659470656, 2459.114718701266, 132237.0, 135342.0, 136987.0, 140626.0, 140662.0, 14191.503297384543, 14589.708205836036, 15147.394104235707, 15383.0, 15511.146886921328, 23601.29196124119, 23614.527709445716, 23643.93602287901, 23646.172383966477, 23673.408164795674, 10776.461176941122, 10796.730081747863, 10861.81819999306, 10952.616658416917, 11013.889861101286, 8491.532965686823, 10083.344582602254, 10172.237082218864, 10191.133753631024, 10336.638217662347, 8190.631421586043, 9228.907710922938, 9285.700001999725, 9324.673636422693, 9407.623695052258, 2731.3035176030385, 2761.2249689062764, 2792.6648802143873, 2849.216465472012, 2874.18085845533, 950.1163917556738, 954.5418199264392, 962.7457110671199, 983.2330781989916, 995.2833959549113, 19462.22151113968, 19635.31276405319, 19767.604647906963, 19986.60026799485, 20177.596448070955, 994.3685759542598, 1008.6318493749728, 1044.9425281609433, 1048.3709774135457, 1049.9895001050045, 10784.784304314027, 11022.724431889266, 11190.384528850991, 11214.271072380268, 11353.262037967506, 462971.0, 471655.0, 474574.0, 476530.0, 477118.0, 109836.0, 110208.0, 110475.44762276138, 110484.0, 117707.41146294214, 1201.9459124339426, 1212.8605210400917, 1229.0597692764863, 1229.1580267516779, 1233.4511142541483, 21428.357149285548, 21523.0, 21618.567628647652, 21641.78358216398, 21921.890390547946, 54692.0, 56992.43007570037, 57098.42901570931, 57617.71191144017, 58282.4171758277, 71819.28180718335, 72584.27415725775, 72589.6370518144, 73491.63254183695, 73744.63127684327, 12563.246205227715, 14284.57146285613, 14916.552503424915, 15350.923245383701, 15391.61520961985, 23626.52746945017, 23743.52512949766, 23769.762302376756, 23805.880970595037, 23841.0, 18429.26282948721, 18613.906930465262, 18754.0, 18829.34097306588, 18871.245150193838, 15845.762313565076, 16501.504954851374, 16543.338266469207, 17294.616430685768, 17342.73985890238, 18704.906475467535, 18924.14841332116, 19167.0, 19299.807001930363, 19399.515012124808, 14918.552443426715, 14967.251637418303, 14968.925155374154, 14969.850301496846, 15006.549803505912, 18770.436886893414, 18971.0, 19001.42995710131, 19048.619027619647, 19060.142293596546], "value": 12119.718833070305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.1952908725677, 1368.5757415201288, 1375.5116933488619, 1392.6100691806298, 1394.1565352961459, 13667.794983075262, 14274.857251427482, 14293.642658933544, 14317.355718992645, 14345.856541434583, 13471.932640336809, 14430.494932677359, 14510.564683059498, 14512.129272243672, 14534.563963081124, 2703.91888243353, 2759.779217662582, 2771.2933202033455, 2776.3753155540044, 2781.401998570307, 2590.870456477178, 2631.7105118437053, 2695.595660650908, 2700.2844246274653, 2741.931451713703, 2612.8432294062322, 2659.2421159969413, 2660.162048954573, 2663.73362663734, 2665.466906618684, 2531.822772405923, 2574.5751950928075, 2582.6255192997096, 2591.3651155467032, 2596.597527383249, 2554.412485128431, 2591.2744431559195, 2598.8960441582312, 2599.571070773339, 2605.4137818990766, 13657.931710341483, 14042.648933776634, 14076.648083797885, 14087.225202613852, 14097.0, 7550.3582195513445, 7837.960810195969, 7857.253560911761, 7864.5281283123195, 7876.5667888266125, 4912.115819152551, 4967.379077615298, 5067.822626208065, 5189.6886186828915, 5202.76587553561, 1891.2529550827346, 1908.6373589018042, 1917.8657493975427, 1944.387517931861, 1969.5371587676884, 21816.781832181634, 21948.0, 21996.0, 22091.337259882068, 22161.33515994523, 6261.342559031327, 6408.58344207625, 6558.672066396661, 6590.80227593173, 6610.7686230982645, 15316.923415382851, 15334.616634584225, 15336.079835209923, 15358.769618455732, 15364.769528457082, 6924.549904256207, 7376.852462950711, 7558.470907036454, 7558.962205188939, 7573.318401343795, 6750.223724271772, 7180.31786980236, 7182.604956727326, 7183.389411900047, 7202.855942881113, 4712.387389639325, 4743.501932297128, 4830.589399900978, 4844.909895273535, 4900.872799256191, 1332.4270563657526, 1371.348609410542, 1411.4213172599184, 1433.8351089624618, 1460.1093333066822, 867.7873920889297, 915.844306467902, 917.0554329041098, 923.9953800230955, 932.3333816321363, 7578.810529736801, 7924.6037698116015, 7993.200679932076, 8025.07711613172, 8123.18768123183, 972.4894430424084, 989.6338354808767, 1013.1843865688045, 1013.2704452793977, 1020.739711373595, 4923.507649235048, 5132.615053870974, 5153.922691159635, 5163.7676304566385, 5273.024490469275, 19397.32109376165, 20198.394048178285, 20283.797162028484, 20304.492387690425, 20312.796872031387, 18966.336178233694, 19082.618347632968, 19453.31913383025, 19505.317313893946, 19599.118039687964, 10709.732256693489, 11025.228234023542, 11030.22788404804, 11127.387993660264, 11144.0, 7480.214577469287, 7828.491148075357, 8265.421420500506, 8286.4199506034, 8289.58552072406, 16122.193890305673, 16375.590610234363, 16849.91575042117, 17016.744748829024, 17175.65648687044, 16945.915270423568, 17226.827731723024, 17244.827551724324, 17267.654646907242, 17449.825501745327, 10978.670639880816, 11205.887941120485, 11222.326660400402, 11231.26996745209, 11248.100151987657, 12948.546800861925, 13205.273709946045, 13322.33388330599, 13350.866491334962, 13368.799468007794, 10108.949455252676, 10505.31715438494, 10621.628243011457, 10759.784804303714, 10882.401467919024, 10128.59485620567, 10150.74623134398, 10485.951404859454, 10517.0, 10735.94632026835, 9232.907670923474, 9334.859977100214, 9338.206252468344, 9339.626414943326, 9362.016988216412, 6537.0, 6929.307069293232, 6999.09011828459, 7027.789166325018, 7043.577385356895, 6842.384185423336, 7216.530925489827, 7345.77962661121, 7352.11774587053, 7420.5547667140145], "value": 6358.700438996565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.55997606939894, 503.9294498770172, 524.4205153305597, 535.0689799748436, 538.1550964984975, 6075.939240607592, 6221.41353954742, 6267.749290028399, 6338.397852204039, 6388.456981156602, 6062.45437910589, 6107.969460152693, 6139.324674285836, 6145.477634401082, 6157.291911430187, 4973.751312434382, 4991.500849914997, 4991.525805048533, 4998.325226094467, 5029.698218106907, 4992.40091189056, 4995.975020124894, 5004.124278251292, 5004.874878128039, 5029.647924645276, 4816.518348165173, 4985.476524964881, 5004.224345226496, 5029.899402011957, 5040.697558146523, 4842.44311904132, 4955.999999999982, 4970.950290497103, 4974.950250497485, 4978.253262010691, 4413.58070983256, 4450.376947227391, 4465.441819772528, 4523.36672865799, 4533.591976722078, 6105.267367915834, 6144.84637884052, 6217.968910155466, 6223.346548612376, 6234.968825155891, 5516.455392490109, 5668.319801623831, 5739.0, 5753.0, 5787.102999035156, 6481.0, 6485.67571621417, 6488.188976377953, 6523.93476065238, 6581.506387020945, 4840.6127509799135, 4862.222044472867, 4887.7311747853855, 4942.530459606368, 4952.826651067231, 6751.291114433012, 6844.247132815386, 6959.234484206733, 7014.824629384255, 7040.823979400556, 5044.445111037783, 5057.0, 5067.619928505377, 5076.949230507647, 5080.263361812516, 5130.358705161855, 5152.793888244503, 5168.638195326366, 5169.741512924414, 5173.611979101583, 5605.5895964735555, 5675.701340956919, 5697.6296540724725, 5697.857553561194, 5771.249737534094, 6480.222373315138, 6537.771178008842, 6550.508711846631, 6577.2436169841085, 6589.703463344161, 1677.9748303775452, 1736.8797125854005, 1771.9468415947542, 1772.6100257943233, 1803.1344954421952, 1166.6383421139474, 1233.9516402771355, 1237.0207667731559, 1258.2890666773244, 1263.4693428759942, 5668.376478587352, 5707.315122185281, 5710.314762228559, 5711.114777209539, 5757.769689212469, 6475.417212450902, 6547.410733033955, 6632.403083722488, 6636.767713130017, 6717.798466046026, 5730.828075157752, 5756.740946657411, 5762.683052432157, 5779.942200578024, 5825.7378417971295, 3562.5546806649168, 3585.533880595558, 3594.928101438009, 3638.1268495560876, 3648.872289469856, 6517.641529715911, 6518.185226846645, 6524.934750652433, 6575.868482630321, 6578.375054369827, 6967.512274140863, 6972.51192416526, 6977.720891164398, 7012.368886800213, 7022.297770223039, 6385.776497822554, 6471.644059576768, 6486.610803351814, 6490.182748830241, 6544.214694236627, 6647.437852104848, 6650.0, 6733.225679046776, 6738.157730283715, 6771.695273712793, 6584.76953306632, 6599.967000164968, 6610.4711623071, 6645.700943457459, 6663.36698013688, 6379.926523879665, 6423.550351475352, 6434.099226108255, 6450.612963222222, 6473.996530537775, 4964.404271487445, 4980.477049909852, 4994.550490455877, 5034.622403319839, 5059.06407314648, 6538.476921846336, 6734.56225345351, 6738.966305168443, 6809.182898052265, 6813.148356455443, 6361.201071528512, 6469.902951455826, 6502.902456463252, 6527.477801775942, 6568.967155164193, 6468.795283066045, 6504.503964088191, 6529.151210342625, 6536.542442029203, 6582.3746744059235, 5958.940410595838, 6091.939080609137, 6336.20797400325, 6424.582402143846, 6454.064160696579, 6438.323975982642, 6459.935400645933, 6483.902741458787, 6536.640484773383, 6541.34586541342, 6315.747370105144, 6322.747090116344, 6329.430351268408, 6356.300806911144, 6380.649064301322], "value": 5056.87879902719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.6558507767047, 911.4030310146852, 913.977150571236, 929.4702019848685, 931.6785708930419, 16581.336746530156, 18122.18450169744, 19078.0, 19120.139593718282, 19271.32550360736, 16363.854530182862, 18305.54236144097, 20468.07893644786, 20512.28207012755, 20654.38036858893, 956.4213650741306, 997.8303688372957, 1010.7675234696006, 1036.5801850250662, 1037.5227395398126, 1058.179910569311, 1060.7189094889861, 1060.862087928572, 1061.4215252687266, 1065.1585247654343, 1071.5231721883765, 1110.6057349640882, 1114.3926560024765, 1116.865976082867, 1117.044926587768, 1096.3202814255133, 1100.2958106811648, 1109.1958330210614, 1109.2346281066039, 1109.362116782849, 794.2295972906271, 798.9041315042174, 799.1768478467188, 800.1278606319082, 800.9159038300953, 18037.909810450863, 18428.078596070143, 19061.809381906143, 19242.615147697106, 19269.614607707907, 19898.801011989985, 20284.5943081139, 20969.370918872457, 20982.895085524473, 21054.26310079155, 14803.185824779634, 14807.777883331759, 14943.925280373638, 15059.623509412242, 15081.924590377088, 3487.7035451986612, 3541.0793193769546, 3547.592026916912, 3548.946765798515, 3549.0240183949363, 121604.0, 121715.0, 127481.36259318644, 128788.35605821911, 131086.0, 14755.77866332006, 15415.383384664488, 15485.767713484307, 15623.218839058229, 15684.294206760724, 29279.707202928123, 29632.851835740683, 29674.109776706733, 29720.0, 29810.701892980793, 8055.718049868226, 8485.109063548362, 8505.95747021261, 8573.399862009599, 8583.18459746323, 3728.813559322023, 3912.4522566840665, 4003.979980100081, 4170.207660544487, 4299.591538803808, 5132.435432102466, 5227.869303267449, 5231.267622532849, 5231.633785635046, 5236.083685355047, 1036.7511797168625, 1071.0842229893485, 1071.1912506057877, 1081.8972197641212, 1083.4420273559124, 681.9488538359643, 688.5730846874969, 704.257008855652, 709.7054722290295, 716.7706333973183, 11379.203455758017, 11449.484773185226, 11457.312561246352, 12363.62909112728, 12966.0, 697.5953946710896, 705.3334598804183, 708.3518580498888, 708.3518580498888, 722.4256715910864, 5095.87260318495, 5279.52484276417, 5408.45915408456, 5533.446655334435, 5724.513416359573, 101034.4948275254, 101895.0, 102699.0, 107637.46181269044, 114792.0, 89450.0, 97105.0, 97276.0, 99509.0, 101727.0, 77532.0, 79680.20319796844, 92218.53890730637, 92254.0, 92706.0, 12434.316112613893, 12494.625161245178, 12772.680682983, 12942.417591208607, 13057.21656700601, 38503.422448662735, 38855.61144388633, 40219.798901005306, 41890.37164442597, 42429.36355954725, 73141.6342918282, 76251.0, 77661.22338776539, 77764.0, 82238.17761822305, 19779.307724229584, 20342.389728308175, 20377.69433458529, 20402.693959590913, 20637.0, 20680.68978965347, 21012.022697895794, 21432.357029289145, 22322.21872234464, 22650.886745566168, 18904.905475472533, 19626.0, 19796.802031979496, 19963.20147194096, 19980.800191998474, 18404.17181226821, 19069.237230510626, 19152.425427237205, 19403.4178974631, 19691.40925772229, 18799.342023029127, 18923.23190010264, 19131.61736765285, 19373.612527749083, 19635.901820491377, 14082.507112251433, 14095.506657266946, 14113.0, 14283.571492855232, 14750.852491474949, 14156.43374265059, 14999.2500374983, 15025.774613381027, 15035.924820375829, 15248.3900643973], "value": 9241.309304697545, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 102.0, 109.0, 109.0, 110.0, 112.0, 107.0, 111.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 149.0, 193.0, 124.0, 148.0, 158.0, 125.0, 176.0, 123.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 162.0, 161.0, 170.0, 168.0, 162.0, 169.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 182.0, 76.0, 74.0, 76.0, 88.0, 99.0, 75.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 140.0, 81.0, 81.0, 82.0, 128.0, 82.0, 81.0, 129.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 117.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 150.0, 151.0, 151.0, 151.0, 151.0, 154.0, 153.0, 154.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 99.0, 99.0, 99.0, 95.0, 99.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 55.0, 54.0, 55.0, 55.0, 58.0, 63.0, 55.0, 55.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 60.0, 54.0, 57.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 77.0, 85.0, 80.0, 77.0, 81.0, 88.0, 79.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 132.0, 130.0, 130.0, 125.0, 126.0, 132.0, 130.0, 164.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 181.0, 174.0, 191.0, 183.0, 189.0, 191.0, 180.0, 176.0, 183.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 72.0, 69.0, 68.0, 67.0, 67.0, 67.0, 70.0, 68.0], "value": 68.8, "unit": "score"}]}]} 06:32:03 INFO - Return code: 0 06:32:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:03 INFO - # TBPL SUCCESS # 06:32:03 INFO - Running post-action listener: _package_coverage_data 06:32:03 INFO - Running post-action listener: _resource_record_post_action 06:32:03 INFO - [mozharness: 2017-07-25 13:32:03.237683Z] Finished run-tests step (success) 06:32:03 INFO - Running post-run listener: _resource_record_post_run 06:32:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 437592064; Read time: 24; Write time: 319920 06:32:03 INFO - TinderboxPrint: CPU usage
13.2% 06:32:03 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 24 06:32:03 INFO - TinderboxPrint: I/O write bytes / time
437,592,064 / 319,920 06:32:03 INFO - TinderboxPrint: CPU idle
8,265.5 (86.8%) 06:32:03 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 06:32:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:32:03 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 111370240; Read time: 0; Write time: 113604 06:32:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:32:03 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 326221824; Read time: 24; Write time: 206316 06:32:03 INFO - Running post-run listener: _upload_blobber_files 06:32:03 INFO - Blob upload gear active. 06:32:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:32:03 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:03 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:05 INFO - (blobuploader) - INFO - Done attempting. 06:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:05 INFO - (blobuploader) - INFO - Done attempting. 06:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:06 INFO - (blobuploader) - INFO - Done attempting. 06:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:09 INFO - (blobuploader) - INFO - Done attempting. 06:32:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:09 INFO - Return code: 0 06:32:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e028773e4d187c6b49337eb13df5f471e3456b04d6fd05a6ef7a055923ea0a974f49504bda0abd1db752df0b1723c7227a20aefd17c419f74e2c44852a6c34", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9a2ae21cabb1f07d53d6cb4d5aa81583441af7826e572361e773d7769ed3bd7bdb513b7150516cf30a8c2f0e51855ecf6e0b081c4b98a8af228a6bb74b63e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdbb5d7e6ee21a53625a358e6c1799cc409c79d697636b5ddac0e96e6c02b493ebada4a4024f5f5a067bcc5a618adaa1493f9f9c4097f5d3c850cc19d230bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1e0dd5b5d64ed4c878f0b50379779b2de19622bf8f4f4b4006773774966b00b3140fb93d521aad837fca978d7cc0374c53dc6c435b0864d71a6de6493e376a"} 06:32:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:09 INFO - Contents: 06:32:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e028773e4d187c6b49337eb13df5f471e3456b04d6fd05a6ef7a055923ea0a974f49504bda0abd1db752df0b1723c7227a20aefd17c419f74e2c44852a6c34", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9a2ae21cabb1f07d53d6cb4d5aa81583441af7826e572361e773d7769ed3bd7bdb513b7150516cf30a8c2f0e51855ecf6e0b081c4b98a8af228a6bb74b63e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdbb5d7e6ee21a53625a358e6c1799cc409c79d697636b5ddac0e96e6c02b493ebada4a4024f5f5a067bcc5a618adaa1493f9f9c4097f5d3c850cc19d230bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1e0dd5b5d64ed4c878f0b50379779b2de19622bf8f4f4b4006773774966b00b3140fb93d521aad837fca978d7cc0374c53dc6c435b0864d71a6de6493e376a"} 06:32:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:09 INFO - Copying logs to upload dir... 06:32:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.456100 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-25 06:32:08.797552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:08.803426) ========= 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=7de08804244eb36560b44971000001c3-1500987286.376829-197251129 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/sha512/38e028773e4d187c6b49337eb13df5f471e3456b04d6fd05a6ef7a055923ea0a974f49504bda0abd1db752df0b1723c7227a20aefd17c419f74e2c44852a6c34", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9a2ae21cabb1f07d53d6cb4d5aa81583441af7826e572361e773d7769ed3bd7bdb513b7150516cf30a8c2f0e51855ecf6e0b081c4b98a8af228a6bb74b63e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdbb5d7e6ee21a53625a358e6c1799cc409c79d697636b5ddac0e96e6c02b493ebada4a4024f5f5a067bcc5a618adaa1493f9f9c4097f5d3c850cc19d230bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1e0dd5b5d64ed4c878f0b50379779b2de19622bf8f4f4b4006773774966b00b3140fb93d521aad837fca978d7cc0374c53dc6c435b0864d71a6de6493e376a"} build_url:https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e028773e4d187c6b49337eb13df5f471e3456b04d6fd05a6ef7a055923ea0a974f49504bda0abd1db752df0b1723c7227a20aefd17c419f74e2c44852a6c34", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9a2ae21cabb1f07d53d6cb4d5aa81583441af7826e572361e773d7769ed3bd7bdb513b7150516cf30a8c2f0e51855ecf6e0b081c4b98a8af228a6bb74b63e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cdbb5d7e6ee21a53625a358e6c1799cc409c79d697636b5ddac0e96e6c02b493ebada4a4024f5f5a067bcc5a618adaa1493f9f9c4097f5d3c850cc19d230bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1e0dd5b5d64ed4c878f0b50379779b2de19622bf8f4f4b4006773774966b00b3140fb93d521aad837fca978d7cc0374c53dc6c435b0864d71a6de6493e376a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:08.838631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:08.843953) ========= 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=7de08804244eb36560b44971000001c3-1500987286.376829-197251129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:08.923695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 06:32:08.926012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 06:32:08.926279) ========= ========= Total master_lag: 0.16 =========