builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1500829322.99 results: success (0) revision: 5928d905c0bc0b28f5488b236444c7d7991cf8d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:02.992480) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:02.992863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:02.993136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.009266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.009534) ========= 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=0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-23 10:02:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2017-07-23 10:02:03 (16.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104033 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.129701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.129984) ========= 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=0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014966 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.192113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.192431) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5928d905c0bc0b28f5488b236444c7d7991cf8d4 --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 5928d905c0bc0b28f5488b236444c7d7991cf8d4 --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=0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-23 10:02:03,891 truncating revision to first 12 chars 2017-07-23 10:02:03,891 Setting DEBUG logging. 2017-07-23 10:02:03,892 attempt 1/10 2017-07-23 10:02:03,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5928d905c0bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-23 10:02:04,184 unpacking tar archive at: mozilla-central-5928d905c0bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.876803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.877089) ========= script_repo_revision: 5928d905c0bc0b28f5488b236444c7d7991cf8d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.877471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.877738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 10:02:03.897008) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-23 10:02:03.897278) ========= /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=0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:02:04 INFO - MultiFileLogger online at 20170723 10:02:04 in /builds/slave/test 10:02:04 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 10:02:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:04 INFO - {'append_to_log': False, 10:02:04 INFO - 'base_work_dir': '/builds/slave/test', 10:02:04 INFO - 'blob_upload_branch': 'Firefox', 10:02:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:04 INFO - 'branch': 'Firefox', 10:02:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:04 INFO - 'code_coverage': False, 10:02:04 INFO - 'config_files': ('talos/linux_config.py',), 10:02:04 INFO - 'default_actions': ('clobber', 10:02:04 INFO - 'read-buildbot-config', 10:02:04 INFO - 'download-and-extract', 10:02:04 INFO - 'populate-webroot', 10:02:04 INFO - 'create-virtualenv', 10:02:04 INFO - 'install', 10:02:04 INFO - 'setup-mitmproxy', 10:02:04 INFO - 'run-tests'), 10:02:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:04 INFO - 'disable_ccov_upload': False, 10:02:04 INFO - 'download_minidump_stackwalk': True, 10:02:04 INFO - 'download_symbols': 'ondemand', 10:02:04 INFO - 'enable_stylo': False, 10:02:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:04 INFO - 'gecko_profile': False, 10:02:04 INFO - 'gecko_profile_interval': 0, 10:02:04 INFO - 'installer_path': 'installer.exe', 10:02:04 INFO - 'log_level': 'info', 10:02:04 INFO - 'log_name': 'talos', 10:02:04 INFO - 'log_to_console': True, 10:02:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:02:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:02:04 INFO - 'opt_config_files': (), 10:02:04 INFO - 'pip_index': False, 10:02:04 INFO - 'suite': 'dromaeojs-e10s', 10:02:04 INFO - 'system_bits': '32', 10:02:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:04 INFO - 'title': 'talos-linux64-ix-017', 10:02:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:04 INFO - 'use_talos_json': True, 10:02:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:04 INFO - 'work_dir': 'build'} 10:02:04 INFO - [mozharness: 2017-07-23 17:02:04.698714Z] Running clobber step. 10:02:04 INFO - Running pre-action listener: _resource_record_pre_action 10:02:04 INFO - Running main action method: clobber 10:02:04 INFO - rmtree: /builds/slave/test/build 10:02:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:06 INFO - Running post-action listener: _resource_record_post_action 10:02:06 INFO - [mozharness: 2017-07-23 17:02:06.266929Z] Finished clobber step (success) 10:02:06 INFO - [mozharness: 2017-07-23 17:02:06.267031Z] Running read-buildbot-config step. 10:02:06 INFO - Running pre-action listener: _resource_record_pre_action 10:02:06 INFO - Running main action method: read_buildbot_config 10:02:06 INFO - Using buildbot properties: 10:02:06 INFO - { 10:02:06 INFO - "project": "", 10:02:06 INFO - "product": "firefox", 10:02:06 INFO - "who": "ffxbld@noreply.mozilla.org", 10:02:06 INFO - "installer_path": "public/build/target.tar.bz2", 10:02:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:02:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:02:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:02:06 INFO - "stage_platform": "linux64-stylo", 10:02:06 INFO - "basedir": "/builds/slave/test", 10:02:06 INFO - "buildnumber": 43, 10:02:06 INFO - "platform": "ubuntu64_hw_stylo", 10:02:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:02:06 INFO - "slavebuilddir": "test", 10:02:06 INFO - "taskId": "SQAHzSwtTBi5tSe4b8miXQ", 10:02:06 INFO - "branch": "mozilla-central", 10:02:06 INFO - "script_repo_revision": "production", 10:02:06 INFO - "revision": "5928d905c0bc0b28f5488b236444c7d7991cf8d4", 10:02:06 INFO - "slavename": "talos-linux64-ix-017", 10:02:06 INFO - "repo_path": "mozilla-central" 10:02:06 INFO - } 10:02:06 INFO - Finding installer, test and symbols from parent task. 10:02:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SQAHzSwtTBi5tSe4b8miXQ'}, attempt #1 10:02:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SQAHzSwtTBi5tSe4b8miXQ'}, attempt #1 10:02:07 INFO - Task dependencies: AptT2c_eTyGLJWHJdRCE5g 10:02:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g'}, attempt #1 10:02:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2 10:02:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/test_packages.json 10:02:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.crashreporter-symbols.zip 10:02:07 INFO - Running post-action listener: _resource_record_post_action 10:02:07 INFO - [mozharness: 2017-07-23 17:02:07.647386Z] Finished read-buildbot-config step (success) 10:02:07 INFO - [mozharness: 2017-07-23 17:02:07.647609Z] Running download-and-extract step. 10:02:07 INFO - Running pre-action listener: _resource_record_pre_action 10:02:07 INFO - Running main action method: download_and_extract 10:02:07 INFO - mkdir: /builds/slave/test/build/tests 10:02:07 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')]} 10:02:07 INFO - trying https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.test_packages.json 10:02:07 INFO - Downloading https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:02:08 INFO - Downloaded 989 bytes. 10:02:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:02:08 INFO - Using the following test package requirements: 10:02:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:02:08 INFO - u'common': [u'target.common.tests.zip'], 10:02:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:02:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:02:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:02:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:02:08 INFO - u'mozbase': [u'target.common.tests.zip'], 10:02:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:02:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:02:08 INFO - u'web-platform': [u'target.common.tests.zip', 10:02:08 INFO - u'target.web-platform.tests.tar.gz'], 10:02:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:02:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.common.tests.zip 10:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.common.tests.zip into memory 10:02:14 INFO - Content-Length response header: 72768309 10:02:14 INFO - Bytes received: 72768309 10:02:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:02:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.common.tests.zip 10:02:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:02:25 INFO - Fetch https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.common.tests.zip into memory 10:02:27 INFO - Content-Length response header: 72768309 10:02:27 INFO - Bytes received: 72768309 10:02:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.talos.tests.zip 10:02:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:02:39 INFO - Fetch https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.talos.tests.zip into memory 10:02:40 INFO - Content-Length response header: 14498880 10:02:40 INFO - Bytes received: 14498880 10:02:40 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')]} 10:02:40 INFO - trying https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2 10:02:40 INFO - Downloading https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:02:41 INFO - Downloaded 61933449 bytes. 10:02:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2 10:02:41 INFO - mkdir: /builds/slave/test/properties 10:02:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:41 INFO - Contents: 10:02:41 INFO - build_url:https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2 10:02:41 INFO - Running post-action listener: _resource_record_post_action 10:02:41 INFO - Running post-action listener: set_extra_try_arguments 10:02:41 INFO - [mozharness: 2017-07-23 17:02:41.725520Z] Finished download-and-extract step (success) 10:02:41 INFO - [mozharness: 2017-07-23 17:02:41.725619Z] Running populate-webroot step. 10:02:41 INFO - Running pre-action listener: _resource_record_pre_action 10:02:41 INFO - Running main action method: populate_webroot 10:02:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:41 INFO - 'tests': ['damp', 'tps']}, 10:02:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:02:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:02:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:02:41 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:41 INFO - 'ts_paint', 10:02:41 INFO - 'tpaint', 10:02:41 INFO - 'sessionrestore', 10:02:41 INFO - 'sessionrestore_many_windows', 10:02:41 INFO - 'sessionrestore_no_auto_restore', 10:02:41 INFO - 'tabpaint']}, 10:02:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:02:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:02:41 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:41 INFO - 'talos_options': ['--mitmproxy', 10:02:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:41 INFO - '--firstNonBlankPaint'], 10:02:41 INFO - 'tests': ['quantum_pageload_google', 10:02:41 INFO - 'quantum_pageload_youtube', 10:02:41 INFO - 'quantum_pageload_amazon', 10:02:41 INFO - 'quantum_pageload_facebook']}, 10:02:41 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:41 INFO - 'talos_options': ['--stylo', 10:02:41 INFO - '--mitmproxy', 10:02:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:41 INFO - '--firstNonBlankPaint'], 10:02:41 INFO - 'tests': ['quantum_pageload_google', 10:02:41 INFO - 'quantum_pageload_youtube', 10:02:41 INFO - 'quantum_pageload_amazon', 10:02:41 INFO - 'quantum_pageload_facebook']}, 10:02:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:41 INFO - 'tsvgr_opacity', 10:02:41 INFO - 'tart', 10:02:41 INFO - 'tscrollx', 10:02:41 INFO - 'cart', 10:02:41 INFO - 'tsvg_static']}, 10:02:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:41 INFO - 'talos_options': ['--xperf_path', 10:02:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:41 INFO - 'tests': ['tp5n']}}} 10:02:41 INFO - Running post-action listener: _resource_record_post_action 10:02:41 INFO - [mozharness: 2017-07-23 17:02:41.732941Z] Finished populate-webroot step (success) 10:02:41 INFO - [mozharness: 2017-07-23 17:02:41.733030Z] Running create-virtualenv step. 10:02:41 INFO - Running pre-action listener: _resource_record_pre_action 10:02:41 INFO - Running main action method: create_virtualenv 10:02:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:41 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 10:02:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:02:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:41 INFO - Using real prefix '/usr' 10:02:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:44 INFO - Installing pip.................done. 10:02:44 INFO - Return code: 0 10:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:44 INFO - Reading from file tmpfile_stdout 10:02:44 INFO - Output received: 10:02:44 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) 10:02:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:02:44 INFO - Using env: {'DISPLAY': ':0', 10:02:44 INFO - 'HOME': '/home/cltbld', 10:02:44 INFO - 'LANG': 'en_US.UTF-8', 10:02:44 INFO - 'LANGUAGE': 'en_US:en', 10:02:44 INFO - 'LOGNAME': 'cltbld', 10:02:44 INFO - 'MAIL': '/var/mail/cltbld', 10:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:44 INFO - 'MOZ_NO_REMOTE': '1', 10:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:44 INFO - 'NO_EM_RESTART': '1', 10:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:44 INFO - 'PWD': '/builds/slave/test', 10:02:44 INFO - 'SHELL': '/bin/bash', 10:02:44 INFO - 'SHLVL': '1', 10:02:44 INFO - 'TERM': 'linux', 10:02:44 INFO - 'TMOUT': '86400', 10:02:44 INFO - 'USER': 'cltbld', 10:02:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:44 INFO - '_': '/tools/buildbot/bin/python'} 10:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:44 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 10:02:44 INFO - Cleaning up... 10:02:44 INFO - Return code: 0 10:02:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:02:44 INFO - Using env: {'DISPLAY': ':0', 10:02:44 INFO - 'HOME': '/home/cltbld', 10:02:44 INFO - 'LANG': 'en_US.UTF-8', 10:02:44 INFO - 'LANGUAGE': 'en_US:en', 10:02:44 INFO - 'LOGNAME': 'cltbld', 10:02:44 INFO - 'MAIL': '/var/mail/cltbld', 10:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:44 INFO - 'MOZ_NO_REMOTE': '1', 10:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:44 INFO - 'NO_EM_RESTART': '1', 10:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:44 INFO - 'PWD': '/builds/slave/test', 10:02:44 INFO - 'SHELL': '/bin/bash', 10:02:44 INFO - 'SHLVL': '1', 10:02:44 INFO - 'TERM': 'linux', 10:02:44 INFO - 'TMOUT': '86400', 10:02:44 INFO - 'USER': 'cltbld', 10:02:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:44 INFO - '_': '/tools/buildbot/bin/python'} 10:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:44 INFO - Downloading/unpacking psutil>=3.1.1 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:46 INFO - Installing collected packages: psutil 10:02:46 INFO - Running setup.py install for psutil 10:02:46 INFO - building 'psutil._psutil_linux' extension 10:02:46 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 10:02:46 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 10:02:46 INFO - building 'psutil._psutil_posix' extension 10:02:46 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 10:02:46 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 10:02:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:46 INFO - Successfully installed psutil 10:02:46 INFO - Cleaning up... 10:02:46 INFO - Return code: 0 10:02:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:02:46 INFO - Using env: {'DISPLAY': ':0', 10:02:46 INFO - 'HOME': '/home/cltbld', 10:02:46 INFO - 'LANG': 'en_US.UTF-8', 10:02:46 INFO - 'LANGUAGE': 'en_US:en', 10:02:46 INFO - 'LOGNAME': 'cltbld', 10:02:46 INFO - 'MAIL': '/var/mail/cltbld', 10:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:46 INFO - 'MOZ_NO_REMOTE': '1', 10:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:46 INFO - 'NO_EM_RESTART': '1', 10:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:46 INFO - 'PWD': '/builds/slave/test', 10:02:46 INFO - 'SHELL': '/bin/bash', 10:02:46 INFO - 'SHLVL': '1', 10:02:46 INFO - 'TERM': 'linux', 10:02:46 INFO - 'TMOUT': '86400', 10:02:46 INFO - 'USER': 'cltbld', 10:02:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:46 INFO - '_': '/tools/buildbot/bin/python'} 10:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:48 INFO - Installing collected packages: mozsystemmonitor 10:02:48 INFO - Running setup.py install for mozsystemmonitor 10:02:48 INFO - Successfully installed mozsystemmonitor 10:02:48 INFO - Cleaning up... 10:02:48 INFO - Return code: 0 10:02:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:02:48 INFO - Using env: {'DISPLAY': ':0', 10:02:48 INFO - 'HOME': '/home/cltbld', 10:02:48 INFO - 'LANG': 'en_US.UTF-8', 10:02:48 INFO - 'LANGUAGE': 'en_US:en', 10:02:48 INFO - 'LOGNAME': 'cltbld', 10:02:48 INFO - 'MAIL': '/var/mail/cltbld', 10:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:48 INFO - 'MOZ_NO_REMOTE': '1', 10:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:48 INFO - 'NO_EM_RESTART': '1', 10:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:48 INFO - 'PWD': '/builds/slave/test', 10:02:48 INFO - 'SHELL': '/bin/bash', 10:02:48 INFO - 'SHLVL': '1', 10:02:48 INFO - 'TERM': 'linux', 10:02:48 INFO - 'TMOUT': '86400', 10:02:48 INFO - 'USER': 'cltbld', 10:02:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:48 INFO - '_': '/tools/buildbot/bin/python'} 10:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:48 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:49 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:49 INFO - warning: no files found matching '*.txt' 10:02:49 INFO - no previously-included directories found matching 'build' 10:02:49 INFO - no previously-included directories found matching 'dist' 10:02:49 INFO - no previously-included directories found matching '.git*' 10:02:49 INFO - Installing collected packages: jsonschema, functools32 10:02:49 INFO - Running setup.py install for functools32 10:02:49 INFO - warning: no files found matching '*.txt' 10:02:49 INFO - no previously-included directories found matching 'build' 10:02:49 INFO - no previously-included directories found matching 'dist' 10:02:49 INFO - no previously-included directories found matching '.git*' 10:02:49 INFO - Successfully installed jsonschema functools32 10:02:49 INFO - Cleaning up... 10:02:49 INFO - Return code: 0 10:02:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02:49 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')]} 10:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:49 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')]} 10:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:49 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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:49 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 10:02:49 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 10:02:49 INFO - Using env: {'DISPLAY': ':0', 10:02:49 INFO - 'HOME': '/home/cltbld', 10:02:49 INFO - 'LANG': 'en_US.UTF-8', 10:02:49 INFO - 'LANGUAGE': 'en_US:en', 10:02:49 INFO - 'LOGNAME': 'cltbld', 10:02:49 INFO - 'MAIL': '/var/mail/cltbld', 10:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:49 INFO - 'MOZ_NO_REMOTE': '1', 10:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:49 INFO - 'NO_EM_RESTART': '1', 10:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:49 INFO - 'PWD': '/builds/slave/test', 10:02:49 INFO - 'SHELL': '/bin/bash', 10:02:49 INFO - 'SHLVL': '1', 10:02:49 INFO - 'TERM': 'linux', 10:02:49 INFO - 'TMOUT': '86400', 10:02:49 INFO - 'USER': 'cltbld', 10:02:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:49 INFO - '_': '/tools/buildbot/bin/python'} 10:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:50 INFO - Cleaning up... 10:02:50 INFO - Return code: 0 10:02:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:50 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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:50 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 10:02:50 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 10:02:50 INFO - Using env: {'DISPLAY': ':0', 10:02:50 INFO - 'HOME': '/home/cltbld', 10:02:50 INFO - 'LANG': 'en_US.UTF-8', 10:02:50 INFO - 'LANGUAGE': 'en_US:en', 10:02:50 INFO - 'LOGNAME': 'cltbld', 10:02:50 INFO - 'MAIL': '/var/mail/cltbld', 10:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:50 INFO - 'MOZ_NO_REMOTE': '1', 10:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:50 INFO - 'NO_EM_RESTART': '1', 10:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:50 INFO - 'PWD': '/builds/slave/test', 10:02:50 INFO - 'SHELL': '/bin/bash', 10:02:50 INFO - 'SHLVL': '1', 10:02:50 INFO - 'TERM': 'linux', 10:02:50 INFO - 'TMOUT': '86400', 10:02:50 INFO - 'USER': 'cltbld', 10:02:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:50 INFO - '_': '/tools/buildbot/bin/python'} 10:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:50 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 10:02:50 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 10:02:50 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 10:02:50 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 10:02:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02: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 10:02: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 10:02: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 10:02: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 10:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02: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 10:02: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 10:02: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 10:02: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 10:02:51 INFO - Downloading docopt-0.6.1.tar.gz 10:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:52 INFO - Running setup.py install for blobuploader 10:02:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:52 INFO - Running setup.py install for requests 10:02:52 INFO - Running setup.py install for docopt 10:02:52 INFO - Successfully installed blobuploader requests docopt 10:02:52 INFO - Cleaning up... 10:02:52 INFO - Return code: 0 10:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:52 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')]} 10:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:52 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')]} 10:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:52 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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:52 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 10:02:52 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 10:02:52 INFO - Using env: {'DISPLAY': ':0', 10:02:52 INFO - 'HOME': '/home/cltbld', 10:02:52 INFO - 'LANG': 'en_US.UTF-8', 10:02:52 INFO - 'LANGUAGE': 'en_US:en', 10:02:52 INFO - 'LOGNAME': 'cltbld', 10:02:52 INFO - 'MAIL': '/var/mail/cltbld', 10:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:52 INFO - 'MOZ_NO_REMOTE': '1', 10:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:52 INFO - 'NO_EM_RESTART': '1', 10:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:52 INFO - 'PWD': '/builds/slave/test', 10:02:52 INFO - 'SHELL': '/bin/bash', 10:02:52 INFO - 'SHLVL': '1', 10:02:52 INFO - 'TERM': 'linux', 10:02:52 INFO - 'TMOUT': '86400', 10:02:52 INFO - 'USER': 'cltbld', 10:02:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:52 INFO - '_': '/tools/buildbot/bin/python'} 10:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:52 INFO - Running setup.py (path:/tmp/pip-rB28eM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:52 INFO - Running setup.py (path:/tmp/pip-3ByVHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:53 INFO - Running setup.py (path:/tmp/pip-PwQqXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:53 INFO - Running setup.py (path:/tmp/pip-VZjsDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:53 INFO - Running setup.py (path:/tmp/pip-Nmf_gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:53 INFO - Running setup.py (path:/tmp/pip-CAtT2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:53 INFO - Running setup.py (path:/tmp/pip-ubTuml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:53 INFO - Running setup.py (path:/tmp/pip-IuE3Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:53 INFO - Running setup.py (path:/tmp/pip-Swvmq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:53 INFO - Running setup.py (path:/tmp/pip-rVOHPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:53 INFO - Running setup.py (path:/tmp/pip-Fsazcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:53 INFO - Running setup.py (path:/tmp/pip-sAg_a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:53 INFO - Running setup.py (path:/tmp/pip-Bw7uxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:53 INFO - Running setup.py (path:/tmp/pip-g2Uep8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:53 INFO - Running setup.py (path:/tmp/pip-a60H4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:53 INFO - Running setup.py (path:/tmp/pip-glgDsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:54 INFO - Running setup.py (path:/tmp/pip-OMpL3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:54 INFO - Running setup.py install for manifestparser 10:02:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozcrash 10:02:54 INFO - Running setup.py install for mozdebug 10:02:54 INFO - Running setup.py install for mozdevice 10:02:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozfile 10:02:54 INFO - Running setup.py install for mozhttpd 10:02:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozinfo 10:02:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozInstall 10:02:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:54 INFO - Running setup.py install for mozleak 10:02:54 INFO - Running setup.py install for mozlog 10:02:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for moznetwork 10:02:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for mozprocess 10:02:55 INFO - Running setup.py install for mozprofile 10:02:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for mozrunner 10:02:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Running setup.py install for mozscreenshot 10:02:55 INFO - Running setup.py install for moztest 10:02:55 INFO - Running setup.py install for mozversion 10:02:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:55 INFO - Cleaning up... 10:02:55 INFO - Return code: 0 10:02:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02: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')]} 10:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:55 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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:55 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 10:02:55 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 10:02:55 INFO - Using env: {'DISPLAY': ':0', 10:02:55 INFO - 'HOME': '/home/cltbld', 10:02:55 INFO - 'LANG': 'en_US.UTF-8', 10:02:55 INFO - 'LANGUAGE': 'en_US:en', 10:02:55 INFO - 'LOGNAME': 'cltbld', 10:02:55 INFO - 'MAIL': '/var/mail/cltbld', 10:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:55 INFO - 'MOZ_NO_REMOTE': '1', 10:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:55 INFO - 'NO_EM_RESTART': '1', 10:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:55 INFO - 'PWD': '/builds/slave/test', 10:02:55 INFO - 'SHELL': '/bin/bash', 10:02:55 INFO - 'SHLVL': '1', 10:02:55 INFO - 'TERM': 'linux', 10:02:55 INFO - 'TMOUT': '86400', 10:02:55 INFO - 'USER': 'cltbld', 10:02:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:55 INFO - '_': '/tools/buildbot/bin/python'} 10:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:56 INFO - Running setup.py (path:/tmp/pip-oG2Grw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:56 INFO - Running setup.py (path:/tmp/pip-8OsV58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:56 INFO - Running setup.py (path:/tmp/pip-s67DvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:56 INFO - Running setup.py (path:/tmp/pip-4H9Mjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:56 INFO - Running setup.py (path:/tmp/pip-8zN6oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:56 INFO - Running setup.py (path:/tmp/pip-YDgeQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:56 INFO - Running setup.py (path:/tmp/pip-haTf9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:56 INFO - Running setup.py (path:/tmp/pip-Nci_9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:56 INFO - Running setup.py (path:/tmp/pip-MRqvLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:56 INFO - Running setup.py (path:/tmp/pip-LwyoIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:56 INFO - Running setup.py (path:/tmp/pip-4jrsSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:56 INFO - Running setup.py (path:/tmp/pip-2nqMjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:56 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)) 10:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:56 INFO - Running setup.py (path:/tmp/pip-KUglG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:57 INFO - Running setup.py (path:/tmp/pip-1ybn_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:57 INFO - Running setup.py (path:/tmp/pip-ZNO9gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:57 INFO - Running setup.py (path:/tmp/pip-nJfA_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:57 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)) 10:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:57 INFO - Running setup.py (path:/tmp/pip-ppbzN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:57 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)) 10:02:57 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)) 10:02:57 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)) 10:02:57 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)) 10:02:57 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)) 10:02:57 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)) 10:02:57 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)) 10:02:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:58 INFO - Downloading blessings-1.6.tar.gz 10:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:58 INFO - Installing collected packages: blessings 10:02:58 INFO - Running setup.py install for blessings 10:02:58 INFO - Successfully installed blessings 10:02:58 INFO - Cleaning up... 10:02:58 INFO - Return code: 0 10:02:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:58 INFO - Reading from file tmpfile_stdout 10:02:58 INFO - Current package versions: 10:02:58 INFO - argparse == 1.2.1 10:02:58 INFO - blessings == 1.6 10:02:58 INFO - blobuploader == 1.2.4 10:02:58 INFO - docopt == 0.6.1 10:02:58 INFO - functools32 == 3.2.3-2 10:02:58 INFO - jsonschema == 2.5.1 10:02:58 INFO - manifestparser == 1.1 10:02:58 INFO - mozInstall == 1.13 10:02:58 INFO - mozcrash == 1.0 10:02:58 INFO - mozdebug == 0.1 10:02:58 INFO - mozdevice == 0.51 10:02:58 INFO - mozfile == 1.2 10:02:58 INFO - mozhttpd == 0.7 10:02:58 INFO - mozinfo == 0.10 10:02:58 INFO - mozleak == 0.1 10:02:58 INFO - mozlog == 3.5 10:02:58 INFO - moznetwork == 0.27 10:02:58 INFO - mozprocess == 0.25 10:02:58 INFO - mozprofile == 0.28 10:02:58 INFO - mozrunner == 6.13 10:02:58 INFO - mozscreenshot == 0.1 10:02:58 INFO - mozsystemmonitor == 0.3 10:02:58 INFO - moztest == 0.8 10:02:58 INFO - mozversion == 1.4 10:02:58 INFO - psutil == 3.1.1 10:02:58 INFO - requests == 1.2.3 10:02:58 INFO - wsgiref == 0.1.2 10:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:58 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')]} 10:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:58 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')]} 10:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:58 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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:02:58 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 10:02:58 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 10:02:58 INFO - Using env: {'DISPLAY': ':0', 10:02:58 INFO - 'HOME': '/home/cltbld', 10:02:58 INFO - 'LANG': 'en_US.UTF-8', 10:02:58 INFO - 'LANGUAGE': 'en_US:en', 10:02:58 INFO - 'LOGNAME': 'cltbld', 10:02:58 INFO - 'MAIL': '/var/mail/cltbld', 10:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:58 INFO - 'MOZ_NO_REMOTE': '1', 10:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:58 INFO - 'NO_EM_RESTART': '1', 10:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:58 INFO - 'PWD': '/builds/slave/test', 10:02:58 INFO - 'SHELL': '/bin/bash', 10:02:58 INFO - 'SHLVL': '1', 10:02:58 INFO - 'TERM': 'linux', 10:02:58 INFO - 'TMOUT': '86400', 10:02:58 INFO - 'USER': 'cltbld', 10:02:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:58 INFO - '_': '/tools/buildbot/bin/python'} 10:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 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)) 10:02:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:59 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 10:02:59 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 10:02:59 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 10:02:59 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 10:03:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:03:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:03:00 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 10:03:00 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 10:03:00 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 10:03:00 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 10:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:03:00 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)) 10:03:00 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)) 10:03:00 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)) 10:03:00 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)) 10:03:00 INFO - Installing collected packages: marionette-driver, simplejson 10:03:00 INFO - Running setup.py install for marionette-driver 10:03:00 INFO - Running setup.py install for simplejson 10:03:00 INFO - building 'simplejson._speedups' extension 10:03:00 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 10:03:01 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 10:03:01 INFO - Successfully installed marionette-driver simplejson 10:03:01 INFO - Cleaning up... 10:03:01 INFO - Return code: 0 10:03:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03:01 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')]} 10:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:01 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')]} 10:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:01 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 0x1e101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', '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 10:03:01 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 10:03:01 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 10:03:01 INFO - Using env: {'DISPLAY': ':0', 10:03:01 INFO - 'HOME': '/home/cltbld', 10:03:01 INFO - 'LANG': 'en_US.UTF-8', 10:03:01 INFO - 'LANGUAGE': 'en_US:en', 10:03:01 INFO - 'LOGNAME': 'cltbld', 10:03:01 INFO - 'MAIL': '/var/mail/cltbld', 10:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:01 INFO - 'MOZ_NO_REMOTE': '1', 10:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:01 INFO - 'NO_EM_RESTART': '1', 10:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:01 INFO - 'PWD': '/builds/slave/test', 10:03:01 INFO - 'SHELL': '/bin/bash', 10:03:01 INFO - 'SHLVL': '1', 10:03:01 INFO - 'TERM': 'linux', 10:03:01 INFO - 'TMOUT': '86400', 10:03:01 INFO - 'USER': 'cltbld', 10:03:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:01 INFO - '_': '/tools/buildbot/bin/python'} 10:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:03:01 INFO - Cleaning up... 10:03:01 INFO - Return code: 0 10:03:01 INFO - Running post-action listener: _resource_record_post_action 10:03:01 INFO - Running post-action listener: _start_resource_monitoring 10:03:01 INFO - Starting resource monitoring. 10:03:01 INFO - [mozharness: 2017-07-23 17:03:01.855639Z] Finished create-virtualenv step (success) 10:03:01 INFO - [mozharness: 2017-07-23 17:03:01.856116Z] Running install step. 10:03:01 INFO - Running pre-action listener: _resource_record_pre_action 10:03:01 INFO - Running main action method: install 10:03:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:02 INFO - Reading from file tmpfile_stdout 10:03:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:02 INFO - Reading from file tmpfile_stdout 10:03:02 INFO - Output received: 10:03:02 INFO - Usage: mozinstall [options] installer 10:03:02 INFO - Options: 10:03:02 INFO - -h, --help show this help message and exit 10:03:02 INFO - -d DEST, --destination=DEST 10:03:02 INFO - Directory to install application into. [default: 10:03:02 INFO - "/builds/slave/test"] 10:03:02 INFO - --app=APP Application being installed. [default: firefox] 10:03:02 INFO - mkdir: /builds/slave/test/build/application 10:03:02 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'] 10:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:03:20 INFO - Reading from file tmpfile_stdout 10:03:20 INFO - Output received: 10:03:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:03:20 INFO - Running post-action listener: _resource_record_post_action 10:03:20 INFO - [mozharness: 2017-07-23 17:03:20.136829Z] Finished install step (success) 10:03:20 INFO - [mozharness: 2017-07-23 17:03:20.136978Z] Running setup-mitmproxy step. 10:03:20 INFO - Running pre-action listener: _resource_record_pre_action 10:03:20 INFO - Running main action method: setup_mitmproxy 10:03:20 INFO - Skipping: mitmproxy is not required 10:03:20 INFO - Running post-action listener: _resource_record_post_action 10:03:20 INFO - [mozharness: 2017-07-23 17:03:20.138022Z] Finished setup-mitmproxy step (success) 10:03:20 INFO - [mozharness: 2017-07-23 17:03:20.138247Z] Running run-tests step. 10:03:20 INFO - Running pre-action listener: _resource_record_pre_action 10:03:20 INFO - Running pre-action listener: _set_gcov_prefix 10:03:20 INFO - Running main action method: run_tests 10:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:20 INFO - Python 2.7.3 10:03:20 INFO - Return code: 0 10:03:20 INFO - grabbing minidump binary from tooltool 10:03:20 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')]} 10:03:20 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 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:20 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 10:03:20 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 10:03:20 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 10:03:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:20 INFO - Return code: 0 10:03:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:03:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:20 INFO - ENV: RUST_BACKTRACE is now 1 10:03:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:03:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:20 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/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:03:20 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/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 10:03:20 INFO - Using env: {'DISPLAY': ':0', 10:03:20 INFO - 'HOME': '/home/cltbld', 10:03:20 INFO - 'LANG': 'en_US.UTF-8', 10:03:20 INFO - 'LANGUAGE': 'en_US:en', 10:03:20 INFO - 'LOGNAME': 'cltbld', 10:03:20 INFO - 'MAIL': '/var/mail/cltbld', 10:03:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:20 INFO - 'MOZ_NO_REMOTE': '1', 10:03:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:20 INFO - 'NO_EM_RESTART': '1', 10:03:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:20 INFO - 'PWD': '/builds/slave/test', 10:03:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:20 INFO - 'RUST_BACKTRACE': '1', 10:03:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:03:20 INFO - 'SHELL': '/bin/bash', 10:03:20 INFO - 'SHLVL': '1', 10:03:20 INFO - 'STYLO_FORCE_ENABLED': '1', 10:03:20 INFO - 'TERM': 'linux', 10:03:20 INFO - 'TMOUT': '86400', 10:03:20 INFO - 'USER': 'cltbld', 10:03:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392', 10:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:20 INFO - '_': '/tools/buildbot/bin/python'} 10:03:20 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/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:03:20 INFO - mozversion application_buildid: 20170723161946 10:03:20 INFO - mozversion application_changeset: 5928d905c0bc0b28f5488b236444c7d7991cf8d4 10:03:20 INFO - mozversion application_display_name: Nightly 10:03:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:20 INFO - mozversion application_name: Firefox 10:03:20 INFO - mozversion application_remotingname: firefox 10:03:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:03:20 INFO - mozversion application_vendor: Mozilla 10:03:20 INFO - mozversion application_version: 56.0a1 10:03:20 INFO - mozversion platform_buildid: 20170723161946 10:03:20 INFO - mozversion platform_changeset: 5928d905c0bc0b28f5488b236444c7d7991cf8d4 10:03:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:03:20 INFO - mozversion platform_version: 56.0a1 10:03:20 INFO - using testdate: 1500829400 10:03:20 INFO - actual date: 1500829400 10:03:20 INFO - starting webserver on 'localhost:58065' 10:03:20 INFO - SUITE-START | Running 2 tests 10:03:20 INFO - TEST-START | dromaeo_css 10:03:20 INFO - Initialising browser for dromaeo_css test... 10:03:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58065/getInfo.html -profile /tmp/tmpuPBGpR/profile 10:03:20 INFO - TEST-INFO | started process 21733 (/builds/slave/test/build/application/firefox/firefox http://localhost:58065/getInfo.html) 10:03:26 INFO - TEST-INFO | 21733: exit 0 10:03:26 INFO - Browser initialized. 10:03:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:26 INFO - TEST-INFO | started process 21960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPBGpR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:37 INFO - PID 21960 | RSS: Main: 176021504 10:03:37 INFO - PID 21960 | 10:06:37 INFO - PID 21960 | Cycle 1(1): loaded http://localhost:58065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58065/tests/dromaeo/cssquery-ext.html) 10:06:38 INFO - PID 21960 | RSS: Main: 181497856 10:06:38 INFO - PID 21960 | 10:09:40 INFO - PID 21960 | Cycle 1(1): loaded http://localhost:58065/tests/dromaeo/cssquery-ext.html (next: http://localhost:58065/tests/dromaeo/cssquery-jquery.html) 10:09:41 INFO - PID 21960 | RSS: Main: 179728384 10:09:41 INFO - PID 21960 | 10:12:42 INFO - PID 21960 | Cycle 1(1): loaded http://localhost:58065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58065/tests/dromaeo/cssquery-mootools.html) 10:12:43 INFO - PID 21960 | RSS: Main: 180740096 10:12:43 INFO - PID 21960 | 10:15:45 INFO - PID 21960 | Cycle 1(1): loaded http://localhost:58065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58065/tests/dromaeo/cssquery-prototype.html) 10:15:46 INFO - PID 21960 | RSS: Main: 179490816 10:15:46 INFO - PID 21960 | 10:18:49 INFO - PID 21960 | Cycle 1(1): loaded http://localhost:58065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58065/tests/dromaeo/cssquery-yui.html) 10:18:50 INFO - PID 21960 | RSS: Main: 181170176 10:18:50 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | Cycle 1(1): loaded http://localhost:58065/tests/dromaeo/cssquery-yui.html (next: http://localhost:58065/tests/dromaeo/cssquery-dojo.html) 10:21:52 INFO - PID 21960 | RSS: Main: 182906880 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | __start_tp_report 10:21:52 INFO - PID 21960 | _x_x_mozilla_page_load 10:21:52 INFO - PID 21960 | _x_x_mozilla_page_load_details 10:21:52 INFO - PID 21960 | |i|pagename|runs| 10:21:52 INFO - PID 21960 | |0;dojo.html;3099.752019838413;3170.841457927103;3171.555982162497;3211.4379983502895;3212.983935080326;5920.940790592087;5956.612820166686;5967.880642387155;6046.8488287792825;6060.484858787008;6017.608855424394;6060.060690592965;6103.328633850273;6256.84357891053;6263.874722505547;5624;5657.688827114507;5659.688717120557;5707.486326230638;5708.942910570903;5468.425815289397;5534.667919924817;5550.555955523549;5610.046292130348;5612.326520817508;5460.535854452376;5519.806806761764;5559.166125081229;5669;5671.914921276184;5570.275864137677;5660.5471562274915;5664.0937450007805;5666.1784041314195;5668.773249070032;5396.19057141428;5538;5544;5578.41426650204;5610.270664813589;5925.703714814242;5998.940010599926;6059.39406059395;6104.877902441971;6140.785072522485;6533.150690410216;6607.372299631527;6631.668416579152;6633.767818126343;6642.368974947372;6606.834829129262;6619.0071489276515;6691.866162676768;6695.832604184886;6703.363180497845;5889.322727886305;6064.939350606525;6082.969585152135;6087;6126.417990290915;6733.023711561894;6766.255711871789;6834.692438840165;6837.384635382839;6844.589324640538;6175.938240617626;6339.936600634027;6349.396807303298;6522.836929076716;6551.705173267214;6460.12788273577;6470.805875823733;6477.157969464034;6485;6489.091527186198;6374.84062898422;6380.776672816522;6381.489480841522;6385.744570217233;6424.357564243538;6310.652914089769;6322.873542529123;6394.808155755335;6395.968020159869;6398.936010639834;5205.531502164823;5348.251244825649;5351.598630102758;5375.059364611177;5386.676799392049;4563.612092972068;4628.097520983443;4628.74541900192;4632.444106707149;4654.208784506642;5544.750486228129;5684.63049901755;5686.289213848269;5731.455511726379;5773.336066352339;6491.318411566717;6541.771038013647;6642.236142843538;6655;6663.5002374821115;5706.28671416073;5736.741846616912;5756.30924289088;5770.2498675171955;5792.88414231713;5809.738561764731;5827.825165244964;5908.527317814564;5913.793017244376;5916.467517923322;6203.472704820141;6245.28179259391;6248.781292654735;6251.124842522141;6305.3379395163765;6499.155109835691;6501.2523559791225;6510.31641677636;6523.282438931808;6537.05212744159;6299.559030867796;6384.297727249906;6386.425221730066;6392.872142557216;6393.2328120625825;6488.026795980641;6520.510961677798;6528.053432252392;6530.967345163243;6531.11829902957;6559.7376104955265;6578.342165783383;6594.373534514213;6692.0965669635925;6693.598384096969;6167.198264225622;6239.532035097295;6285.779997700241;6312.3687631238345;6429.292777794345;6374.649394283359;6379.744810207725;6391.840203994937;6395.392437718409;6434.420902118832;6318.052292156213;6364.745410183726;6370.6814659267775;6372.55392122547;6386.105945167587;6392.424681778476;6404.487640988803;6474.158359413246;6493.253275873335;6502.869942601216;6054.666993315233;6132.6627035513475;6143.385661433821;6195;6266.216722909637 10:21:52 INFO - PID 21960 | |1;ext.html;784.6390660296263;804.1315379390259;818.0837462042514;844.9281811046061;848.6266042941107;41304.380434293475;42408.36387454191;42473.78763106184;42645.7867710661;42713;37951.4307285391;38284.617153828454;38288.617113828856;38295.808520957355;38379.80810095945;6789.355011273921;6870.965645171767;6908.17101947767;6909.067275917762;6909.447244220451;6708.329167083277;6800.387965083141;7541.886871696929;7760.961195194016;7769.456138070337;7744.961275193645;7818.648160832748;7823.335016523574;7827.6868925242925;7829.686812527492;7530.472866899319;7719.382449404035;7730.652120654584;7808.336291415237;7808.375329973617;7488.625568721543;7571.205023472511;7573.204813494559;7574.962125189339;7576.583287919162;38876.416853747214;39278;39343.40984885229;39377;39396.21207575861;3561.6082230954576;3628.219932714479;3631.6368363163474;3635.309291234657;3647.726420518445;31882.88409905642;32009.8399508001;32031;32035.199120021953;32084.358312833847;4880.951190488086;4887.315775791357;4920.458749537548;4928;4940.604751619898;206289;210297;211522;212044;212434.99999999846;50619.49380506148;50680;50757.23864142041;50778;50824.491755081974;53483.19775203375;53669.46330536723;53748.19377709337;53968.46031539634;54003.72998134984;15225.390984360502;15569.68860622804;15580.532584022498;15613;15638;12486.937565312115;12507.124501284823;12562.183458075197;12566.81149782754;12598.307093109783;14595.635109122144;14617.634559136106;14705;14819.851801481847;14983.550493485212;5748.741306641127;5749.310082790008;5936.851578710567;5941.940580594139;5991.5206783457215;972.2562239886493;979.4466126638426;989.1938070472686;1016.5527168046036;1016.6390931219458;22736.88631556865;22979.770202298096;23626.881865590563;29154.562681559793;29482.8206871727;1101.4948859166093;1113.7215696075982;1118.7426891814928;1121.170333952869;1132.6035887439496;12341.382930853422;12812.359382030862;12845.614631561068;12947.646041171289;12961.02792290563;228966;233001;234187;234276;234402;50946.49053509492;51157;58826;58834.70582647145;59424.70287648534;1505.698860227959;1529.296523599157;1534.9386024559117;1537.031670047885;1537.7385844406479;27262.72737272681;27708;28281.57577636296;28615.570766438937;28725.28186795263;54860.17709734437;55378.16932746093;55469;55486;55705;207595;210279;210737;210830;210984;35558.822205888806;37018.44472332971;37066.44400334051;37327.81336093302;37590.81204594069;46843.531564683915;46865.76567117142;46881.296780549004;47040.529594703614;47298.527014729414;31859.421734795615;33238;33612.66387336193;33754.493682595275;33851.83074084712;31428.2142946419;32240.516392254605;32503.674963250065;32676.673233267364;32866.34267314688;35849;36025.27949441049;36220;36332.09169770777;36351.27297454089;30178.396432071673;31344.686553134175;31861.522077168396;32063.35873282568;32346.191345215615;23458.648120277867;23510.882445588348;23632;24039.038438462267;24816.751832482165 10:21:52 INFO - PID 21960 | |2;jquery.html;577.7342422485655;577.8237637520555;584.6550535184243;586.2173997713053;597.8714576366082;22827.201047963303;22875.885620571873;23859.403514912137;23876.641850372216;23887.16394926178;24837.875810620968;26571.73428265717;26588.468230635375;26628.733712662866;26718.732812671868;6497.415232629074;6642.070110184578;6650.5012124090645;6650.600963942179;6653.833654158636;6168.228971378578;6433.035044743279;6471.935280647181;6535.967320163392;6564.901526477082;6429.80710578681;6438.935610643904;6450.129232553616;6456.192975878015;6457.515686323521;6353.777617783401;6374.298827129012;6387.457066149383;6405.775797847076;6418.582792118521;5956.731947062349;5974.701264936736;5984.9401505984815;5995.100734889757;6010.038393857006;28539;29023.854880725463;29651.851740741375;30193.849030754707;30495.542566861513;1864.8997091715953;1915.1286164794985;1919.9904000480049;1921.4715953112866;1925.5571218619796;18665.44003679892;19118.71321930172;19156.61686766271;19197.3280935168;19341.903290483457;2065.132644289402;2073.6163809695104;2109.673000684896;2115.365390382879;2126.1176611706123;128641.35679321544;133750;134254.32872835672;134326;134624;14334.283285835667;15174;15447.61380965485;15486.612834678997;15537.533873983799;23231.53536929252;23232.07071717146;23247.418814529432;23277.18529851481;23291.88354058219;9557.555736582384;9770;9795.657151999645;9875.358101723365;9886.456244906456;8159.184081591912;8894.28845692343;8947.910520894708;9043.050479699668;9150.35947483683;8446.957765211135;9047.954760226157;9131.223845973167;9322.95338523303;9434.245260379153;2754.256350785277;2775.3616668166433;2798.888044478239;2853.700361462058;2894.8118372306153;956.9473678947725;962.31675510387;978.1148061004802;981.7692842182081;988.7626969527262;19596.118174682175;19821.20715171377;19878;19902.303419380252;20324.288649897182;986.5215370545279;1010.2574607663362;1030.407515678488;1038.714353552764;1043.1758910460803;10470.6388169539;10511.632092876713;10604;11100.44497775108;11125.388103654377;460138;481541;487331;491597;493195;107829.46085269681;114247.42876285565;114941;115634;115825;1237.4926280225066;1244.5208594690928;1280.257450678604;1283.0569531394417;1283.4160456992047;20224.59550809005;20277.852910079393;20343.4914127148;21051.473713157295;21083.47291317668;55262.44737552573;56776.86446271134;57956.42043579679;58528.82942341214;60775.69612151911;68803;70295;70517.29482705312;70661.29338706547;71708.28291717016;14611.853881461475;15053.096814191184;15192;15204.847951520343;15223.543293701206;23568.52862942766;23791;24055.639165412882;24217.51564968726;24389.63415548804;18107.909460452614;18456.723149152505;18839;19109.331173408864;19200.135993880587;16539.83460165383;17183.656326873144;17262.741058884378;17429.825701743328;18276.268949241883;18898;18913.527161820515;19105.713414299076;19166.904165479642;19581.314653987043;14743.041702289316;14788;14793.778093328823;14926.179060151795;15102.169380684169;17234.96590204592;17238.55556443211;17319.653606928045;17327.13364331753;18349.26602935921 10:21:52 INFO - PID 21960 | |3;mootools.html;1353.465381174436;1410.506322787024;1415.5894790510752;1422.317287701903;1423.3737155651513;13385.665358366046;14165.079269847465;14178.71642567148;14194.432222711092;14250.928745356285;14054.929725351385;14491.92754036231;14555;14561.635959101028;14571.854281457183;2631.1185752772794;2664.174106027128;2665.7734092602054;2672.2384120525653;2672.6525551678255;2580.187241019082;2733.4533093381306;2736.931576710588;2738.424930764542;2741.575055866344;2667.7332266773265;2685.3555146764734;2685.4494828560196;2710.132757517595;2715.5655095184775;2609.2694045667245;2650.08572042645;2653.270350653586;2662.8801703923273;2668.106184428219;2545.7199708032103;2560.807939404552;2606.2832721001687;2609.8042646801564;2618.1883616079076;13905;13908.304584770722;13943.302834858318;13960.441582336694;13960.511382101678;7558;7845.293923546908;7847.6860925562905;7853.410994175402;7863.056433227992;4977.676451030671;5200.76596553156;5334.199870019489;5384.165454354581;5403.51403364078;1862.1620270878159;1892.1107079672531;1895.8198971097725;1936.7772706138692;1949.2690241159564;23109.422264443354;23311.76688233113;23379.4155146121;23381.41546461335;23383.53232935332;6371.776987805404;6415.166028416369;6457.2574153971955;6510.544261901716;6524.119243902012;15032.323545440482;15061.246937653294;15094.698106037818;15121.470748523749;15143.545693629208;7053.259407762111;7060.152781666233;7112.893306600405;7130.643467826588;7150.213476517579;6563.048357988065;6627.5029372797235;6627.635480048643;6641.601503909685;6720.059191713164;4918.680285781413;4928.457869634337;4941.234108713155;4982.7259500727805;4997.800087996512;1385.4042761612402;1418.560246323643;1436.6911114110517;1445.898787084894;1447.5512591096794;868.5961028121953;881.1937077573948;903.1600611431301;912.7946212102224;919.8022425178485;8572.314214862796;8729.083446238054;8833.690820821368;8861.335399845037;8946.329025323126;965.6716716316346;994.4828689081637;1012.4684540616088;1014.3913651808856;1016.872890888639;5029.597632189416;5196.064708352533;5215.869603259873;5238.188080847474;5394.163904594794;18402.723959140356;19365.903170484056;19664.60670786605;19677.21291148338;19714.40856774299;18927.337543185924;19302.903485482482;19409.708854367196;19506.804931950497;19644.410667679993;10435.94782026085;10786.676399708022;10922.071623911897;10932.398718070583;10993.560257589606;7126.608036558039;7729.9227007729205;7883.724069657764;7903.328217101381;8041.597920104088;15709.764353534478;16227.43203987902;16457.753133702765;17089.82910170932;17145.828541714924;16321.836781632031;16961.575960601083;17009.574760631083;17228.74156887673;17357.30570777205;10442.425666588411;10615.363078215332;10717.624883129365;10755.19336049815;10803.783924321628;12942.67643308887;13177.209367437985;13205.075644704779;13216.140950838164;13227.867721322664;10359.493918703844;10491.94754026225;10527.263091583822;10554.894451055392;10798.56805727762;9844.950775246078;10238.744031399274;10385.169186464913;10602.098821599942;10688.305260158066;9191.126842949909;9303.627854885728;9314.906850931404;9317.673881414388;9328.39365441244;7012.474064445289;7181.62092918169;7281.781546553612;7299.05112335393;7355.227701091522;6867.622280774405;7024.894626580503;7081.752138675121;7092.503524753218;7177.820554485971 10:21:52 INFO - PID 21960 | |4;prototype.html;495.27397021380483;502.34444050514065;514.1311184098874;524.2974414284859;530.7293280426981;6074.908876366847;6163.506919446445;6168.5373596980235;6172.5185955370725;6191.62850228986;5835.737391817368;5989.161517387569;6030.366811484797;6056.212692349999;6119.326874043852;4899.191633380506;4905.632077594177;4928.9507104929025;4950.653454258203;4993.176125939234;4962.503749625044;4970.950290497085;4981.850544483671;4999.175136102557;5023.547880690737;4726.172919739049;4825.300331451937;4831.251156070797;4880.633952453581;4926.2364333528185;4851.078295123933;4862.951370486286;4874.439439464454;4898.436679781799;4937.234728617034;4365.301551751736;4416.580424859633;4419.690621656486;4435.379046933432;4451.399061126739;5948.256467941507;5971;6014.248218972629;6050.909236361458;6067.666278354689;5545.973994810933;5618.6628802272;5630.15547667849;5651.9152212716845;5712.8000519982015;6323.683815809237;6351.904721429182;6410.935890641081;6431.549791514596;6477.578957367756;4777.80888764449;4791.4250289965075;4818.108649899745;4847.636427267969;4859.5383438573635;6663.566868153554;6751.324867513307;6765.323467653245;6831.726730930757;6885.345892140239;4913.803447862117;4933.186024306021;4964.131277026506;4972.90054198914;4984.975075124601;4983.401991761012;5033.1695270280725;5043.621728370314;5051.343325367752;5062.139436295838;5627.7900251446135;5639.661620302795;5641.774329026875;5670.659760414388;5684.8294551163535;6313.065718224854;6406.775762848278;6414.486841052704;6428.164338636041;6451.3548645135115;1657.709900767361;1715.519654496743;1726.205945265192;1745.7119575270192;1771.0170855175243;1166.976660466786;1205.3069485046133;1208.7280361918674;1221.157401393036;1231.7967535356565;5594.356648985418;5596.496315331639;5609.691466969274;5614;5640.520555752725;6305.274893387319;6451;6491.253505846794;6498.415142637091;6641.800745977628;5628.324601047819;5646.463585959327;5657.2928383952;5702;5748.223989761329;3448;3488.686018258369;3490.2844916791996;3505.5618047744033;3540.274243780019;6321.683915804191;6377.717947821392;6383.96808015957;6425.859312550035;6447.2907980122145;6652.06871038055;6669.566478178903;6696.1629796275465;6743.325667433218;6796.25241223465;6234.844128896814;6288.371162883675;6374.968125159345;6381.170447841843;6394.71223794921;6555.70499327541;6573.441257492976;6573.769918052845;6598.637074960923;6604.867902642017;6492.156019717407;6494.253160886369;6513.599576091163;6568.573042752206;6589.24223714279;6268.404501572343;6296.5592408530965;6333;6343.9849624059925;6348.365163483615;4815.590674792682;4935.827246046371;4969.403671559436;4973.403191617029;4975.477574854733;6502;6641.369069938348;6644.4020038196795;6657.966710166612;6674.399304062657;6269.68651567429;6410.551261411656;6454.257760357619;6464.965605503097;6495.123158373559;6267.059941008885;6304.968475157595;6382.87234255303;6402.775902843378;6424.678766061772;6057.454829065406;6130.172426722335;6135.386461353829;6155.938440615716;6312.431881130537;6302.306746257999;6391.744330226739;6403.487720982217;6439.710213040331;6449.387997860874;6153.753849845956;6189.752409903554;6199.380061993765;6226.59527130735;6322.968385158045 10:21:52 INFO - PID 21960 | |5;yui.html;888.5468411110336;918.8070505193909;924.2282693950551;925.8888933328;935.7800916784554;17121.31514739412;17878.284868605257;18967.810321896777;18996.14517346721;19025.429237122873;16281.592960175973;20292.492687682814;21047.05288262028;21115.15539378427;21245;977.1352353167426;1003.7152444870559;1011.9241056920723;1051.7791263834604;1067.0396643021304;1086.0605576176629;1086.6359769477194;1090.0353187429102;1090.6346373964732;1092.6831218946495;1062.3254233561706;1103.8840921703227;1106.3804269609004;1113.4377139544558;1113.8106521891257;1096.8957948994873;1098.8406681031286;1099.1426687183969;1099.3843447669292;1099.5821587796586;801.2948605227363;801.7634797734682;803.714681288146;805.2028491793142;805.6374631415828;19077.332293369804;19355.90322048395;19483.025848707508;19538.218471261134;20715.8964205178;20399.796002039937;20536.486587835276;20934.057967391505;20955.37133885986;21198.470038249012;16062.116583587898;16105;16152.676946461004;16199.35202591895;16283.511494655178;3464.826758662082;3482.407990641597;3489.5289135966827;3516.191276006533;3517.8065206413635;121606;123597;125570.37214813959;127585;130286;15290.235488225544;15676.92161539185;15854.92072539653;15910.920445397698;15976.680466390608;27145.86427067852;30449.543256851164;30569.235769105504;30571.8471407646;30714.078577642707;8305.335573154132;8312.8337433251;8392.4544904581;8395.286400656012;8404.621792019374;3632.1101330173747;3659.121810765397;3762.755420897633;3801.733878628525;3867.9226415471535;5087.3386459759995;5156.767945442464;5201.115810312181;5215.608829337815;5248.947510524846;1032.2516175772655;1067.69570672358;1073.0503504398507;1085.8696956365286;1086.2939089591828;663.2869665110026;666.6433458099893;691.6334342798325;701.7438634898225;710.1868360726938;11120.165987550967;11754.647360579196;12171.513139474499;13113.868861311455;14180.361883715257;671.2683175338807;682.494953734233;682.5631595778706;702.8734827731057;706.5125063706026;5128.153854613947;5186.299849520342;5189.818356357509;5276.736163191825;5458.590605704588;92358.53820730853;100718;103910.48044759728;104725.47637261765;105660.47169764101;89915;93289;93434;93616;93890.53054734683;75034;78198.6090069546;78726.6063669678;82780;83038.58480707557;11203.775924481302;11971.580994665144;12226.205296656044;12323.940176777453;12989.220646761225;33833.49249761206;38110.856674299815;38235.61764382321;38342.616573833904;38391.42412863753;59675.1048734278;65060.34939650732;66307;68961;69590.65204673944;19221.711674325175;19594.90202548978;19624.41126766199;19629.901850490656;19945.401637950883;21006.159753610296;21404.7859521409;21482;21659.458513537287;21735;17695.203715833075;18513.81486185121;18762.906185468986;18877.71683424722;19296.903515482332;19232.519187020436;19404.417867464;19936.90031549833;20033.899830500755;20226.89886550558;17890.91054544719;18267.995260260814;18529.9073504637;18641.72037419467;18742.062896855376;13790.448382064606;13815.930920345736;14101;14129.222892740998;14359.712805744035;13494.460221591418;14627.122372657675;14636.633064616926;14780.113193208443;14971.32629031718 10:21:52 INFO - PID 21960 | __end_tp_report 10:21:52 INFO - PID 21960 | __start_cc_report 10:21:52 INFO - PID 21960 | _x_x_mozilla_cycle_collect,376 10:21:52 INFO - PID 21960 | __end_cc_report 10:21:52 INFO - PID 21960 | __startTimestamp1500830512768__endTimestamp 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | ------- Summary: start ------- 10:21:52 INFO - PID 21960 | Number of tests: 6 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | [#0] dojo.html Cycles:165 Average:6026.62 Median:6248.78 stddev:690.87 (11.1%) stddev-sans-first:653.72 10:21:52 INFO - PID 21960 | Values: 3099.8 3170.8 3171.6 3211.4 3213.0 5920.9 5956.6 5967.9 6046.8 6060.5 6017.6 6060.1 6103.3 6256.8 6263.9 5624.0 5657.7 5659.7 5707.5 5708.9 5468.4 5534.7 5550.6 5610.0 5612.3 5460.5 5519.8 5559.2 5669.0 5671.9 5570.3 5660.5 5664.1 5666.2 5668.8 5396.2 5538.0 5544.0 5578.4 5610.3 5925.7 5998.9 6059.4 6104.9 6140.8 6533.2 6607.4 6631.7 6633.8 6642.4 6606.8 6619.0 6691.9 6695.8 6703.4 5889.3 6064.9 6083.0 6087.0 6126.4 6733.0 6766.3 6834.7 6837.4 6844.6 6175.9 6339.9 6349.4 6522.8 6551.7 6460.1 6470.8 6477.2 6485.0 6489.1 6374.8 6380.8 6381.5 6385.7 6424.4 6310.7 6322.9 6394.8 6396.0 6398.9 5205.5 5348.3 5351.6 5375.1 5386.7 4563.6 4628.1 4628.7 4632.4 4654.2 5544.8 5684.6 5686.3 5731.5 5773.3 6491.3 6541.8 6642.2 6655.0 6663.5 5706.3 5736.7 5756.3 5770.2 5792.9 5809.7 5827.8 5908.5 5913.8 5916.5 6203.5 6245.3 6248.8 6251.1 6305.3 6499.2 6501.3 6510.3 6523.3 6537.1 6299.6 6384.3 6386.4 6392.9 6393.2 6488.0 6520.5 6528.1 6531.0 6531.1 6559.7 6578.3 6594.4 6692.1 6693.6 6167.2 6239.5 6285.8 6312.4 6429.3 6374.6 6379.7 6391.8 6395.4 6434.4 6318.1 6364.7 6370.7 6372.6 6386.1 6392.4 6404.5 6474.2 6493.3 6502.9 6054.7 6132.7 6143.4 6195.0 6266.2 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | [#1] ext.html Cycles:180 Average:39657.55 Median:19993.29 stddev:56625.95 (283.2%) stddev-sans-first:56709.57 10:21:52 INFO - PID 21960 | Values: 784.6 804.1 818.1 844.9 848.6 41304.4 42408.4 42473.8 42645.8 42713.0 37951.4 38284.6 38288.6 38295.8 38379.8 6789.4 6871.0 6908.2 6909.1 6909.4 6708.3 6800.4 7541.9 7761.0 7769.5 7745.0 7818.6 7823.3 7827.7 7829.7 7530.5 7719.4 7730.7 7808.3 7808.4 7488.6 7571.2 7573.2 7575.0 7576.6 38876.4 39278.0 39343.4 39377.0 39396.2 3561.6 3628.2 3631.6 3635.3 3647.7 31882.9 32009.8 32031.0 32035.2 32084.4 4881.0 4887.3 4920.5 4928.0 4940.6 206289.0 210297.0 211522.0 212044.0 212435.0 50619.5 50680.0 50757.2 50778.0 50824.5 53483.2 53669.5 53748.2 53968.5 54003.7 15225.4 15569.7 15580.5 15613.0 15638.0 12486.9 12507.1 12562.2 12566.8 12598.3 14595.6 14617.6 14705.0 14819.9 14983.6 5748.7 5749.3 5936.9 5941.9 5991.5 972.3 979.4 989.2 1016.6 1016.6 22736.9 22979.8 23626.9 29154.6 29482.8 1101.5 1113.7 1118.7 1121.2 1132.6 12341.4 12812.4 12845.6 12947.6 12961.0 228966.0 233001.0 234187.0 234276.0 234402.0 50946.5 51157.0 58826.0 58834.7 59424.7 1505.7 1529.3 1534.9 1537.0 1537.7 27262.7 27708.0 28281.6 28615.6 28725.3 54860.2 55378.2 55469.0 55486.0 55705.0 207595.0 210279.0 210737.0 210830.0 210984.0 35558.8 37018.4 37066.4 37327.8 37590.8 46843.5 46865.8 46881.3 47040.5 47298.5 31859.4 33238.0 33612.7 33754.5 33851.8 31428.2 32240.5 32503.7 32676.7 32866.3 35849.0 36025.3 36220.0 36332.1 36351.3 30178.4 31344.7 31861.5 32063.4 32346.2 23458.6 23510.9 23632.0 24039.0 24816.8 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | [#2] jquery.html Cycles:180 Average:34523.12 Median:23430.21 stddev:81240.96 (346.7%) stddev-sans-first:81428.88 10:21:52 INFO - PID 21960 | Values: 577.7 577.8 584.7 586.2 597.9 22827.2 22875.9 23859.4 23876.6 23887.2 24837.9 26571.7 26588.5 26628.7 26718.7 6497.4 6642.1 6650.5 6650.6 6653.8 6168.2 6433.0 6471.9 6536.0 6564.9 6429.8 6438.9 6450.1 6456.2 6457.5 6353.8 6374.3 6387.5 6405.8 6418.6 5956.7 5974.7 5984.9 5995.1 6010.0 28539.0 29023.9 29651.9 30193.8 30495.5 1864.9 1915.1 1920.0 1921.5 1925.6 18665.4 19118.7 19156.6 19197.3 19341.9 2065.1 2073.6 2109.7 2115.4 2126.1 128641.4 133750.0 134254.3 134326.0 134624.0 14334.3 15174.0 15447.6 15486.6 15537.5 23231.5 23232.1 23247.4 23277.2 23291.9 9557.6 9770.0 9795.7 9875.4 9886.5 8159.2 8894.3 8947.9 9043.1 9150.4 8447.0 9048.0 9131.2 9323.0 9434.2 2754.3 2775.4 2798.9 2853.7 2894.8 956.9 962.3 978.1 981.8 988.8 19596.1 19821.2 19878.0 19902.3 20324.3 986.5 1010.3 1030.4 1038.7 1043.2 10470.6 10511.6 10604.0 11100.4 11125.4 460138.0 481541.0 487331.0 491597.0 493195.0 107829.5 114247.4 114941.0 115634.0 115825.0 1237.5 1244.5 1280.3 1283.1 1283.4 20224.6 20277.9 20343.5 21051.5 21083.5 55262.4 56776.9 57956.4 58528.8 60775.7 68803.0 70295.0 70517.3 70661.3 71708.3 14611.9 15053.1 15192.0 15204.8 15223.5 23568.5 23791.0 24055.6 24217.5 24389.6 18107.9 18456.7 18839.0 19109.3 19200.1 16539.8 17183.7 17262.7 17429.8 18276.3 18898.0 18913.5 19105.7 19166.9 19581.3 14743.0 14788.0 14793.8 14926.2 15102.2 17235.0 17238.6 17319.7 17327.1 18349.3 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | [#3] mootools.html Cycles:180 Average:8667.24 Median:2607.78 stddev:5903.46 (226.4%) stddev-sans-first:5894.44 10:21:52 INFO - PID 21960 | Values: 1353.5 1410.5 1415.6 1422.3 1423.4 13385.7 14165.1 14178.7 14194.4 14250.9 14054.9 14491.9 14555.0 14561.6 14571.9 2631.1 2664.2 2665.8 2672.2 2672.7 2580.2 2733.5 2736.9 2738.4 2741.6 2667.7 2685.4 2685.4 2710.1 2715.6 2609.3 2650.1 2653.3 2662.9 2668.1 2545.7 2560.8 2606.3 2609.8 2618.2 13905.0 13908.3 13943.3 13960.4 13960.5 7558.0 7845.3 7847.7 7853.4 7863.1 4977.7 5200.8 5334.2 5384.2 5403.5 1862.2 1892.1 1895.8 1936.8 1949.3 23109.4 23311.8 23379.4 23381.4 23383.5 6371.8 6415.2 6457.3 6510.5 6524.1 15032.3 15061.2 15094.7 15121.5 15143.5 7053.3 7060.2 7112.9 7130.6 7150.2 6563.0 6627.5 6627.6 6641.6 6720.1 4918.7 4928.5 4941.2 4982.7 4997.8 1385.4 1418.6 1436.7 1445.9 1447.6 868.6 881.2 903.2 912.8 919.8 8572.3 8729.1 8833.7 8861.3 8946.3 965.7 994.5 1012.5 1014.4 1016.9 5029.6 5196.1 5215.9 5238.2 5394.2 18402.7 19365.9 19664.6 19677.2 19714.4 18927.3 19302.9 19409.7 19506.8 19644.4 10435.9 10786.7 10922.1 10932.4 10993.6 7126.6 7729.9 7883.7 7903.3 8041.6 15709.8 16227.4 16457.8 17089.8 17145.8 16321.8 16961.6 17009.6 17228.7 17357.3 10442.4 10615.4 10717.6 10755.2 10803.8 12942.7 13177.2 13205.1 13216.1 13227.9 10359.5 10491.9 10527.3 10554.9 10798.6 9845.0 10238.7 10385.2 10602.1 10688.3 9191.1 9303.6 9314.9 9317.7 9328.4 7012.5 7181.6 7281.8 7299.1 7355.2 6867.6 7024.9 7081.8 7092.5 7177.8 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | [#4] prototype.html Cycles:180 Average:5405.19 Median:6040.64 stddev:1503.51 (24.9%) stddev-sans-first:1461.87 10:21:52 INFO - PID 21960 | Values: 495.3 502.3 514.1 524.3 530.7 6074.9 6163.5 6168.5 6172.5 6191.6 5835.7 5989.2 6030.4 6056.2 6119.3 4899.2 4905.6 4929.0 4950.7 4993.2 4962.5 4971.0 4981.9 4999.2 5023.5 4726.2 4825.3 4831.3 4880.6 4926.2 4851.1 4863.0 4874.4 4898.4 4937.2 4365.3 4416.6 4419.7 4435.4 4451.4 5948.3 5971.0 6014.2 6050.9 6067.7 5546.0 5618.7 5630.2 5651.9 5712.8 6323.7 6351.9 6410.9 6431.5 6477.6 4777.8 4791.4 4818.1 4847.6 4859.5 6663.6 6751.3 6765.3 6831.7 6885.3 4913.8 4933.2 4964.1 4972.9 4985.0 4983.4 5033.2 5043.6 5051.3 5062.1 5627.8 5639.7 5641.8 5670.7 5684.8 6313.1 6406.8 6414.5 6428.2 6451.4 1657.7 1715.5 1726.2 1745.7 1771.0 1167.0 1205.3 1208.7 1221.2 1231.8 5594.4 5596.5 5609.7 5614.0 5640.5 6305.3 6451.0 6491.3 6498.4 6641.8 5628.3 5646.5 5657.3 5702.0 5748.2 3448.0 3488.7 3490.3 3505.6 3540.3 6321.7 6377.7 6384.0 6425.9 6447.3 6652.1 6669.6 6696.2 6743.3 6796.3 6234.8 6288.4 6375.0 6381.2 6394.7 6555.7 6573.4 6573.8 6598.6 6604.9 6492.2 6494.3 6513.6 6568.6 6589.2 6268.4 6296.6 6333.0 6344.0 6348.4 4815.6 4935.8 4969.4 4973.4 4975.5 6502.0 6641.4 6644.4 6658.0 6674.4 6269.7 6410.6 6454.3 6465.0 6495.1 6267.1 6305.0 6382.9 6402.8 6424.7 6057.5 6130.2 6135.4 6155.9 6312.4 6302.3 6391.7 6403.5 6439.7 6449.4 6153.8 6189.8 6199.4 6226.6 6323.0 10:21:52 INFO - PID 21960 | 10:21:52 INFO - PID 21960 | [#5] yui.html Cycles:180 Average:23029.08 Median:19989.65 stddev:30599.26 (153.1%) stddev-sans-first:30639.93 10:21:52 INFO - PID 21960 | Values: 888.5 918.8 924.2 925.9 935.8 17121.3 17878.3 18967.8 18996.1 19025.4 16281.6 20292.5 21047.1 21115.2 21245.0 977.1 1003.7 1011.9 1051.8 1067.0 1086.1 1086.6 1090.0 1090.6 1092.7 1062.3 1103.9 1106.4 1113.4 1113.8 1096.9 1098.8 1099.1 1099.4 1099.6 801.3 801.8 803.7 805.2 805.6 19077.3 19355.9 19483.0 19538.2 20715.9 20399.8 20536.5 20934.1 20955.4 21198.5 16062.1 16105.0 16152.7 16199.4 16283.5 3464.8 3482.4 3489.5 3516.2 3517.8 121606.0 123597.0 125570.4 127585.0 130286.0 15290.2 15676.9 15854.9 15910.9 15976.7 27145.9 30449.5 30569.2 30571.8 30714.1 8305.3 8312.8 8392.5 8395.3 8404.6 3632.1 3659.1 3762.8 3801.7 3867.9 5087.3 5156.8 5201.1 5215.6 5248.9 1032.3 1067.7 1073.1 1085.9 1086.3 663.3 666.6 691.6 701.7 710.2 11120.2 11754.6 12171.5 13113.9 14180.4 671.3 682.5 682.6 702.9 706.5 5128.2 5186.3 5189.8 5276.7 5458.6 92358.5 100718.0 103910.5 104725.5 105660.5 89915.0 93289.0 93434.0 93616.0 93890.5 75034.0 78198.6 78726.6 82780.0 83038.6 11203.8 11971.6 12226.2 12323.9 12989.2 33833.5 38110.9 38235.6 38342.6 38391.4 59675.1 65060.3 66307.0 68961.0 69590.7 19221.7 19594.9 19624.4 19629.9 19945.4 21006.2 21404.8 21482.0 21659.5 21735.0 17695.2 18513.8 18762.9 18877.7 19296.9 19232.5 19404.4 19936.9 20033.9 20226.9 17890.9 18268.0 18529.9 18641.7 18742.1 13790.4 13815.9 14101.0 14129.2 14359.7 13494.5 14627.1 14636.6 14780.1 14971.3 10:21:52 INFO - PID 21960 | -------- Summary: end -------- 10:21:52 INFO - PID 21960 | 10:21:53 INFO - TEST-INFO | 21960: exit 0 10:21:53 INFO - TEST-OK | dromaeo_css | took 1113017ms 10:21:53 INFO - TEST-START | kraken 10:21:53 INFO - Initialising browser for kraken test... 10:21:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58065/getInfo.html -profile /tmp/tmpPKne5y/profile 10:21:53 INFO - TEST-INFO | started process 22332 (/builds/slave/test/build/application/firefox/firefox http://localhost:58065/getInfo.html) 10:21:59 INFO - TEST-INFO | 22332: exit 0 10:21:59 INFO - Browser initialized. 10:21:59 INFO - Running cycle 1/1 for kraken test... 10:21:59 INFO - TEST-INFO | started process 22560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKne5y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:10 INFO - PID 22560 | RSS: Main: 176271360 10:22:10 INFO - PID 22560 | 10:22:13 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58065/tests/kraken/driver.html?testName=audio-beat-detection) 10:22:14 INFO - PID 22560 | RSS: Main: 179884032 10:22:14 INFO - PID 22560 | 10:22:17 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58065/tests/kraken/driver.html?testName=audio-dft) 10:22:17 INFO - PID 22560 | RSS: Main: 180748288 10:22:17 INFO - PID 22560 | 10:22:20 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58065/tests/kraken/driver.html?testName=audio-fft) 10:22:21 INFO - PID 22560 | RSS: Main: 174985216 10:22:21 INFO - PID 22560 | 10:22:23 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58065/tests/kraken/driver.html?testName=audio-oscillator) 10:22:24 INFO - PID 22560 | RSS: Main: 175312896 10:22:24 INFO - PID 22560 | 10:22:26 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:26 INFO - PID 22560 | RSS: Main: 174776320 10:22:26 INFO - PID 22560 | 10:22:30 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58065/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:30 INFO - PID 22560 | RSS: Main: 177098752 10:22:30 INFO - PID 22560 | 10:22:34 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58065/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:34 INFO - PID 22560 | RSS: Main: 177823744 10:22:34 INFO - PID 22560 | 10:22:37 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58065/tests/kraken/driver.html?testName=json-parse-financial) 10:22:38 INFO - PID 22560 | RSS: Main: 178421760 10:22:38 INFO - PID 22560 | 10:22:39 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:40 INFO - PID 22560 | RSS: Main: 178352128 10:22:40 INFO - PID 22560 | 10:22:42 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:43 INFO - PID 22560 | RSS: Main: 178319360 10:22:43 INFO - PID 22560 | 10:22:45 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:45 INFO - PID 22560 | RSS: Main: 178667520 10:22:45 INFO - PID 22560 | 10:22:48 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:49 INFO - PID 22560 | RSS: Main: 178827264 10:22:49 INFO - PID 22560 | 10:22:52 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:52 INFO - PID 22560 | RSS: Main: 179548160 10:22:52 INFO - PID 22560 | 10:22:54 INFO - PID 22560 | Cycle 1(1): loaded http://localhost:58065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58065/tests/kraken/driver.html?testName=ai-astar) 10:22:55 INFO - PID 22560 | RSS: Main: 180817920 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | __start_tp_report 10:22:55 INFO - PID 22560 | _x_x_mozilla_page_load 10:22:55 INFO - PID 22560 | _x_x_mozilla_page_load_details 10:22:55 INFO - PID 22560 | |i|pagename|runs| 10:22:55 INFO - PID 22560 | |0;ai-astar;105;112;98;109;112;122;118;109;110;110 10:22:55 INFO - PID 22560 | |1;audio-beat-detection;149;118;149;183;117;148;151;117;173;118 10:22:55 INFO - PID 22560 | |2;audio-dft;163;162;164;162;162;164;176;167;164;166 10:22:55 INFO - PID 22560 | |3;audio-fft;75;74;75;123;77;77;75;90;113;77 10:22:55 INFO - PID 22560 | |4;audio-oscillator;82;82;137;81;81;82;132;81;81;139 10:22:55 INFO - PID 22560 | |5;imaging-gaussian-blur;114;114;115;114;114;114;114;117;114;114 10:22:55 INFO - PID 22560 | |6;imaging-darkroom;152;151;151;152;153;153;151;151;152;152 10:22:55 INFO - PID 22560 | |7;imaging-desaturate;94;94;95;94;94;99;94;94;94;94 10:22:55 INFO - PID 22560 | |8;json-parse-financial;54;53;54;59;52;52;55;55;53;55 10:22:55 INFO - PID 22560 | |9;json-stringify-tinderbox;53;54;56;54;61;54;55;54;55;54 10:22:55 INFO - PID 22560 | |10;stanford-crypto-aes;83;77;86;78;77;78;78;77;77;77 10:22:55 INFO - PID 22560 | |11;stanford-crypto-ccm;133;129;128;127;128;129;128;126;127;161 10:22:55 INFO - PID 22560 | |12;stanford-crypto-pbkdf2;180;185;175;180;172;177;185;178;177;178 10:22:55 INFO - PID 22560 | |13;stanford-crypto-sha256-iterative;68;70;74;68;72;67;69;66;66;69 10:22:55 INFO - PID 22560 | __end_tp_report 10:22:55 INFO - PID 22560 | __start_cc_report 10:22:55 INFO - PID 22560 | _x_x_mozilla_cycle_collect,983 10:22:55 INFO - PID 22560 | __end_cc_report 10:22:55 INFO - PID 22560 | __startTimestamp1500830575041__endTimestamp 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | ------- Summary: start ------- 10:22:55 INFO - PID 22560 | Number of tests: 14 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:6.54 (5.8%) stddev-sans-first:6.62 10:22:55 INFO - PID 22560 | Values: 105.0 112.0 98.0 109.0 112.0 122.0 118.0 109.0 110.0 110.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.00 stddev:24.17 (16.2%) stddev-sans-first:25.52 10:22:55 INFO - PID 22560 | Values: 149.0 118.0 149.0 183.0 117.0 148.0 151.0 117.0 173.0 118.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.22 (2.6%) stddev-sans-first:4.41 10:22:55 INFO - PID 22560 | Values: 163.0 162.0 164.0 162.0 162.0 164.0 176.0 167.0 164.0 166.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#3] audio-fft Cycles:10 Average:85.60 Median:76.00 stddev:17.83 (23.5%) stddev-sans-first:18.50 10:22:55 INFO - PID 22560 | Values: 75.0 74.0 75.0 123.0 77.0 77.0 75.0 90.0 113.0 77.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:81.00 stddev:26.42 (32.6%) stddev-sans-first:27.40 10:22:55 INFO - PID 22560 | Values: 82.0 82.0 137.0 81.0 81.0 82.0 132.0 81.0 81.0 139.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 10:22:55 INFO - PID 22560 | Values: 114.0 114.0 115.0 114.0 114.0 114.0 114.0 117.0 114.0 114.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:152.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:22:55 INFO - PID 22560 | Values: 152.0 151.0 151.0 152.0 153.0 153.0 151.0 151.0 152.0 152.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.58 (1.7%) stddev-sans-first:1.66 10:22:55 INFO - PID 22560 | Values: 94.0 94.0 95.0 94.0 94.0 99.0 94.0 94.0 94.0 94.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:2.04 (3.8%) stddev-sans-first:2.17 10:22:55 INFO - PID 22560 | Values: 54.0 53.0 54.0 59.0 52.0 52.0 55.0 55.0 53.0 55.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:54.50 stddev:2.26 (4.1%) stddev-sans-first:2.28 10:22:55 INFO - PID 22560 | Values: 53.0 54.0 56.0 54.0 61.0 54.0 55.0 54.0 55.0 54.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.12 (4.0%) stddev-sans-first:2.92 10:22:55 INFO - PID 22560 | Values: 83.0 77.0 86.0 78.0 77.0 78.0 78.0 77.0 77.0 77.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:128.50 stddev:10.50 (8.2%) stddev-sans-first:11.13 10:22:55 INFO - PID 22560 | Values: 133.0 129.0 128.0 127.0 128.0 129.0 128.0 126.0 127.0 161.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.00 stddev:4.06 (2.3%) stddev-sans-first:4.28 10:22:55 INFO - PID 22560 | Values: 180.0 185.0 175.0 180.0 172.0 177.0 185.0 178.0 177.0 178.0 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.56 (3.7%) stddev-sans-first:2.69 10:22:55 INFO - PID 22560 | Values: 68.0 70.0 74.0 68.0 72.0 67.0 69.0 66.0 66.0 69.0 10:22:55 INFO - PID 22560 | -------- Summary: end -------- 10:22:55 INFO - PID 22560 | 10:22:55 INFO - PID 22560 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:22:55 INFO - TEST-INFO | 22560: exit 0 10:22:55 INFO - TEST-OK | kraken | took 62312ms 10:22:55 INFO - SUITE-END | took 1175s 10:22:56 INFO - Completed test suite (00:19:35) 10:22:56 INFO - javascript benchmark 10:22:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8448.141621254837, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.752019838413, 3170.841457927103, 3171.555982162497, 3211.4379983502895, 3212.983935080326, 5920.940790592087, 5956.612820166686, 5967.880642387155, 6046.8488287792825, 6060.484858787008, 6017.608855424394, 6060.060690592965, 6103.328633850273, 6256.84357891053, 6263.874722505547, 5624.0, 5657.688827114507, 5659.688717120557, 5707.486326230638, 5708.942910570903, 5468.425815289397, 5534.667919924817, 5550.555955523549, 5610.046292130348, 5612.326520817508, 5460.535854452376, 5519.806806761764, 5559.166125081229, 5669.0, 5671.914921276184, 5570.275864137677, 5660.5471562274915, 5664.0937450007805, 5666.1784041314195, 5668.773249070032, 5396.19057141428, 5538.0, 5544.0, 5578.41426650204, 5610.270664813589, 5925.703714814242, 5998.940010599926, 6059.39406059395, 6104.877902441971, 6140.785072522485, 6533.150690410216, 6607.372299631527, 6631.668416579152, 6633.767818126343, 6642.368974947372, 6606.834829129262, 6619.0071489276515, 6691.866162676768, 6695.832604184886, 6703.363180497845, 5889.322727886305, 6064.939350606525, 6082.969585152135, 6087.0, 6126.417990290915, 6733.023711561894, 6766.255711871789, 6834.692438840165, 6837.384635382839, 6844.589324640538, 6175.938240617626, 6339.936600634027, 6349.396807303298, 6522.836929076716, 6551.705173267214, 6460.12788273577, 6470.805875823733, 6477.157969464034, 6485.0, 6489.091527186198, 6374.84062898422, 6380.776672816522, 6381.489480841522, 6385.744570217233, 6424.357564243538, 6310.652914089769, 6322.873542529123, 6394.808155755335, 6395.968020159869, 6398.936010639834, 5205.531502164823, 5348.251244825649, 5351.598630102758, 5375.059364611177, 5386.676799392049, 4563.612092972068, 4628.097520983443, 4628.74541900192, 4632.444106707149, 4654.208784506642, 5544.750486228129, 5684.63049901755, 5686.289213848269, 5731.455511726379, 5773.336066352339, 6491.318411566717, 6541.771038013647, 6642.236142843538, 6655.0, 6663.5002374821115, 5706.28671416073, 5736.741846616912, 5756.30924289088, 5770.2498675171955, 5792.88414231713, 5809.738561764731, 5827.825165244964, 5908.527317814564, 5913.793017244376, 5916.467517923322, 6203.472704820141, 6245.28179259391, 6248.781292654735, 6251.124842522141, 6305.3379395163765, 6499.155109835691, 6501.2523559791225, 6510.31641677636, 6523.282438931808, 6537.05212744159, 6299.559030867796, 6384.297727249906, 6386.425221730066, 6392.872142557216, 6393.2328120625825, 6488.026795980641, 6520.510961677798, 6528.053432252392, 6530.967345163243, 6531.11829902957, 6559.7376104955265, 6578.342165783383, 6594.373534514213, 6692.0965669635925, 6693.598384096969, 6167.198264225622, 6239.532035097295, 6285.779997700241, 6312.3687631238345, 6429.292777794345, 6374.649394283359, 6379.744810207725, 6391.840203994937, 6395.392437718409, 6434.420902118832, 6318.052292156213, 6364.745410183726, 6370.6814659267775, 6372.55392122547, 6386.105945167587, 6392.424681778476, 6404.487640988803, 6474.158359413246, 6493.253275873335, 6502.869942601216, 6054.666993315233, 6132.6627035513475, 6143.385661433821, 6195.0, 6266.216722909637], "value": 5976.904495617542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6390660296263, 804.1315379390259, 818.0837462042514, 844.9281811046061, 848.6266042941107, 41304.380434293475, 42408.36387454191, 42473.78763106184, 42645.7867710661, 42713.0, 37951.4307285391, 38284.617153828454, 38288.617113828856, 38295.808520957355, 38379.80810095945, 6789.355011273921, 6870.965645171767, 6908.17101947767, 6909.067275917762, 6909.447244220451, 6708.329167083277, 6800.387965083141, 7541.886871696929, 7760.961195194016, 7769.456138070337, 7744.961275193645, 7818.648160832748, 7823.335016523574, 7827.6868925242925, 7829.686812527492, 7530.472866899319, 7719.382449404035, 7730.652120654584, 7808.336291415237, 7808.375329973617, 7488.625568721543, 7571.205023472511, 7573.204813494559, 7574.962125189339, 7576.583287919162, 38876.416853747214, 39278.0, 39343.40984885229, 39377.0, 39396.21207575861, 3561.6082230954576, 3628.219932714479, 3631.6368363163474, 3635.309291234657, 3647.726420518445, 31882.88409905642, 32009.8399508001, 32031.0, 32035.199120021953, 32084.358312833847, 4880.951190488086, 4887.315775791357, 4920.458749537548, 4928.0, 4940.604751619898, 206289.0, 210297.0, 211522.0, 212044.0, 212434.99999999846, 50619.49380506148, 50680.0, 50757.23864142041, 50778.0, 50824.491755081974, 53483.19775203375, 53669.46330536723, 53748.19377709337, 53968.46031539634, 54003.72998134984, 15225.390984360502, 15569.68860622804, 15580.532584022498, 15613.0, 15638.0, 12486.937565312115, 12507.124501284823, 12562.183458075197, 12566.81149782754, 12598.307093109783, 14595.635109122144, 14617.634559136106, 14705.0, 14819.851801481847, 14983.550493485212, 5748.741306641127, 5749.310082790008, 5936.851578710567, 5941.940580594139, 5991.5206783457215, 972.2562239886493, 979.4466126638426, 989.1938070472686, 1016.5527168046036, 1016.6390931219458, 22736.88631556865, 22979.770202298096, 23626.881865590563, 29154.562681559793, 29482.8206871727, 1101.4948859166093, 1113.7215696075982, 1118.7426891814928, 1121.170333952869, 1132.6035887439496, 12341.382930853422, 12812.359382030862, 12845.614631561068, 12947.646041171289, 12961.02792290563, 228966.0, 233001.0, 234187.0, 234276.0, 234402.0, 50946.49053509492, 51157.0, 58826.0, 58834.70582647145, 59424.70287648534, 1505.698860227959, 1529.296523599157, 1534.9386024559117, 1537.031670047885, 1537.7385844406479, 27262.72737272681, 27708.0, 28281.57577636296, 28615.570766438937, 28725.28186795263, 54860.17709734437, 55378.16932746093, 55469.0, 55486.0, 55705.0, 207595.0, 210279.0, 210737.0, 210830.0, 210984.0, 35558.822205888806, 37018.44472332971, 37066.44400334051, 37327.81336093302, 37590.81204594069, 46843.531564683915, 46865.76567117142, 46881.296780549004, 47040.529594703614, 47298.527014729414, 31859.421734795615, 33238.0, 33612.66387336193, 33754.493682595275, 33851.83074084712, 31428.2142946419, 32240.516392254605, 32503.674963250065, 32676.673233267364, 32866.34267314688, 35849.0, 36025.27949441049, 36220.0, 36332.09169770777, 36351.27297454089, 30178.396432071673, 31344.686553134175, 31861.522077168396, 32063.35873282568, 32346.191345215615, 23458.648120277867, 23510.882445588348, 23632.0, 24039.038438462267, 24816.751832482165], "value": 17670.089645243508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.7342422485655, 577.8237637520555, 584.6550535184243, 586.2173997713053, 597.8714576366082, 22827.201047963303, 22875.885620571873, 23859.403514912137, 23876.641850372216, 23887.16394926178, 24837.875810620968, 26571.73428265717, 26588.468230635375, 26628.733712662866, 26718.732812671868, 6497.415232629074, 6642.070110184578, 6650.5012124090645, 6650.600963942179, 6653.833654158636, 6168.228971378578, 6433.035044743279, 6471.935280647181, 6535.967320163392, 6564.901526477082, 6429.80710578681, 6438.935610643904, 6450.129232553616, 6456.192975878015, 6457.515686323521, 6353.777617783401, 6374.298827129012, 6387.457066149383, 6405.775797847076, 6418.582792118521, 5956.731947062349, 5974.701264936736, 5984.9401505984815, 5995.100734889757, 6010.038393857006, 28539.0, 29023.854880725463, 29651.851740741375, 30193.849030754707, 30495.542566861513, 1864.8997091715953, 1915.1286164794985, 1919.9904000480049, 1921.4715953112866, 1925.5571218619796, 18665.44003679892, 19118.71321930172, 19156.61686766271, 19197.3280935168, 19341.903290483457, 2065.132644289402, 2073.6163809695104, 2109.673000684896, 2115.365390382879, 2126.1176611706123, 128641.35679321544, 133750.0, 134254.32872835672, 134326.0, 134624.0, 14334.283285835667, 15174.0, 15447.61380965485, 15486.612834678997, 15537.533873983799, 23231.53536929252, 23232.07071717146, 23247.418814529432, 23277.18529851481, 23291.88354058219, 9557.555736582384, 9770.0, 9795.657151999645, 9875.358101723365, 9886.456244906456, 8159.184081591912, 8894.28845692343, 8947.910520894708, 9043.050479699668, 9150.35947483683, 8446.957765211135, 9047.954760226157, 9131.223845973167, 9322.95338523303, 9434.245260379153, 2754.256350785277, 2775.3616668166433, 2798.888044478239, 2853.700361462058, 2894.8118372306153, 956.9473678947725, 962.31675510387, 978.1148061004802, 981.7692842182081, 988.7626969527262, 19596.118174682175, 19821.20715171377, 19878.0, 19902.303419380252, 20324.288649897182, 986.5215370545279, 1010.2574607663362, 1030.407515678488, 1038.714353552764, 1043.1758910460803, 10470.6388169539, 10511.632092876713, 10604.0, 11100.44497775108, 11125.388103654377, 460138.0, 481541.0, 487331.0, 491597.0, 493195.0, 107829.46085269681, 114247.42876285565, 114941.0, 115634.0, 115825.0, 1237.4926280225066, 1244.5208594690928, 1280.257450678604, 1283.0569531394417, 1283.4160456992047, 20224.59550809005, 20277.852910079393, 20343.4914127148, 21051.473713157295, 21083.47291317668, 55262.44737552573, 56776.86446271134, 57956.42043579679, 58528.82942341214, 60775.69612151911, 68803.0, 70295.0, 70517.29482705312, 70661.29338706547, 71708.28291717016, 14611.853881461475, 15053.096814191184, 15192.0, 15204.847951520343, 15223.543293701206, 23568.52862942766, 23791.0, 24055.639165412882, 24217.51564968726, 24389.63415548804, 18107.909460452614, 18456.723149152505, 18839.0, 19109.331173408864, 19200.135993880587, 16539.83460165383, 17183.656326873144, 17262.741058884378, 17429.825701743328, 18276.268949241883, 18898.0, 18913.527161820515, 19105.713414299076, 19166.904165479642, 19581.314653987043, 14743.041702289316, 14788.0, 14793.778093328823, 14926.179060151795, 15102.169380684169, 17234.96590204592, 17238.55556443211, 17319.653606928045, 17327.13364331753, 18349.26602935921], "value": 11970.70910368004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.465381174436, 1410.506322787024, 1415.5894790510752, 1422.317287701903, 1423.3737155651513, 13385.665358366046, 14165.079269847465, 14178.71642567148, 14194.432222711092, 14250.928745356285, 14054.929725351385, 14491.92754036231, 14555.0, 14561.635959101028, 14571.854281457183, 2631.1185752772794, 2664.174106027128, 2665.7734092602054, 2672.2384120525653, 2672.6525551678255, 2580.187241019082, 2733.4533093381306, 2736.931576710588, 2738.424930764542, 2741.575055866344, 2667.7332266773265, 2685.3555146764734, 2685.4494828560196, 2710.132757517595, 2715.5655095184775, 2609.2694045667245, 2650.08572042645, 2653.270350653586, 2662.8801703923273, 2668.106184428219, 2545.7199708032103, 2560.807939404552, 2606.2832721001687, 2609.8042646801564, 2618.1883616079076, 13905.0, 13908.304584770722, 13943.302834858318, 13960.441582336694, 13960.511382101678, 7558.0, 7845.293923546908, 7847.6860925562905, 7853.410994175402, 7863.056433227992, 4977.676451030671, 5200.76596553156, 5334.199870019489, 5384.165454354581, 5403.51403364078, 1862.1620270878159, 1892.1107079672531, 1895.8198971097725, 1936.7772706138692, 1949.2690241159564, 23109.422264443354, 23311.76688233113, 23379.4155146121, 23381.41546461335, 23383.53232935332, 6371.776987805404, 6415.166028416369, 6457.2574153971955, 6510.544261901716, 6524.119243902012, 15032.323545440482, 15061.246937653294, 15094.698106037818, 15121.470748523749, 15143.545693629208, 7053.259407762111, 7060.152781666233, 7112.893306600405, 7130.643467826588, 7150.213476517579, 6563.048357988065, 6627.5029372797235, 6627.635480048643, 6641.601503909685, 6720.059191713164, 4918.680285781413, 4928.457869634337, 4941.234108713155, 4982.7259500727805, 4997.800087996512, 1385.4042761612402, 1418.560246323643, 1436.6911114110517, 1445.898787084894, 1447.5512591096794, 868.5961028121953, 881.1937077573948, 903.1600611431301, 912.7946212102224, 919.8022425178485, 8572.314214862796, 8729.083446238054, 8833.690820821368, 8861.335399845037, 8946.329025323126, 965.6716716316346, 994.4828689081637, 1012.4684540616088, 1014.3913651808856, 1016.872890888639, 5029.597632189416, 5196.064708352533, 5215.869603259873, 5238.188080847474, 5394.163904594794, 18402.723959140356, 19365.903170484056, 19664.60670786605, 19677.21291148338, 19714.40856774299, 18927.337543185924, 19302.903485482482, 19409.708854367196, 19506.804931950497, 19644.410667679993, 10435.94782026085, 10786.676399708022, 10922.071623911897, 10932.398718070583, 10993.560257589606, 7126.608036558039, 7729.9227007729205, 7883.724069657764, 7903.328217101381, 8041.597920104088, 15709.764353534478, 16227.43203987902, 16457.753133702765, 17089.82910170932, 17145.828541714924, 16321.836781632031, 16961.575960601083, 17009.574760631083, 17228.74156887673, 17357.30570777205, 10442.425666588411, 10615.363078215332, 10717.624883129365, 10755.19336049815, 10803.783924321628, 12942.67643308887, 13177.209367437985, 13205.075644704779, 13216.140950838164, 13227.867721322664, 10359.493918703844, 10491.94754026225, 10527.263091583822, 10554.894451055392, 10798.56805727762, 9844.950775246078, 10238.744031399274, 10385.169186464913, 10602.098821599942, 10688.305260158066, 9191.126842949909, 9303.627854885728, 9314.906850931404, 9317.673881414388, 9328.39365441244, 7012.474064445289, 7181.62092918169, 7281.781546553612, 7299.05112335393, 7355.227701091522, 6867.622280774405, 7024.894626580503, 7081.752138675121, 7092.503524753218, 7177.820554485971], "value": 6356.082104628432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.27397021380483, 502.34444050514065, 514.1311184098874, 524.2974414284859, 530.7293280426981, 6074.908876366847, 6163.506919446445, 6168.5373596980235, 6172.5185955370725, 6191.62850228986, 5835.737391817368, 5989.161517387569, 6030.366811484797, 6056.212692349999, 6119.326874043852, 4899.191633380506, 4905.632077594177, 4928.9507104929025, 4950.653454258203, 4993.176125939234, 4962.503749625044, 4970.950290497085, 4981.850544483671, 4999.175136102557, 5023.547880690737, 4726.172919739049, 4825.300331451937, 4831.251156070797, 4880.633952453581, 4926.2364333528185, 4851.078295123933, 4862.951370486286, 4874.439439464454, 4898.436679781799, 4937.234728617034, 4365.301551751736, 4416.580424859633, 4419.690621656486, 4435.379046933432, 4451.399061126739, 5948.256467941507, 5971.0, 6014.248218972629, 6050.909236361458, 6067.666278354689, 5545.973994810933, 5618.6628802272, 5630.15547667849, 5651.9152212716845, 5712.8000519982015, 6323.683815809237, 6351.904721429182, 6410.935890641081, 6431.549791514596, 6477.578957367756, 4777.80888764449, 4791.4250289965075, 4818.108649899745, 4847.636427267969, 4859.5383438573635, 6663.566868153554, 6751.324867513307, 6765.323467653245, 6831.726730930757, 6885.345892140239, 4913.803447862117, 4933.186024306021, 4964.131277026506, 4972.90054198914, 4984.975075124601, 4983.401991761012, 5033.1695270280725, 5043.621728370314, 5051.343325367752, 5062.139436295838, 5627.7900251446135, 5639.661620302795, 5641.774329026875, 5670.659760414388, 5684.8294551163535, 6313.065718224854, 6406.775762848278, 6414.486841052704, 6428.164338636041, 6451.3548645135115, 1657.709900767361, 1715.519654496743, 1726.205945265192, 1745.7119575270192, 1771.0170855175243, 1166.976660466786, 1205.3069485046133, 1208.7280361918674, 1221.157401393036, 1231.7967535356565, 5594.356648985418, 5596.496315331639, 5609.691466969274, 5614.0, 5640.520555752725, 6305.274893387319, 6451.0, 6491.253505846794, 6498.415142637091, 6641.800745977628, 5628.324601047819, 5646.463585959327, 5657.2928383952, 5702.0, 5748.223989761329, 3448.0, 3488.686018258369, 3490.2844916791996, 3505.5618047744033, 3540.274243780019, 6321.683915804191, 6377.717947821392, 6383.96808015957, 6425.859312550035, 6447.2907980122145, 6652.06871038055, 6669.566478178903, 6696.1629796275465, 6743.325667433218, 6796.25241223465, 6234.844128896814, 6288.371162883675, 6374.968125159345, 6381.170447841843, 6394.71223794921, 6555.70499327541, 6573.441257492976, 6573.769918052845, 6598.637074960923, 6604.867902642017, 6492.156019717407, 6494.253160886369, 6513.599576091163, 6568.573042752206, 6589.24223714279, 6268.404501572343, 6296.5592408530965, 6333.0, 6343.9849624059925, 6348.365163483615, 4815.590674792682, 4935.827246046371, 4969.403671559436, 4973.403191617029, 4975.477574854733, 6502.0, 6641.369069938348, 6644.4020038196795, 6657.966710166612, 6674.399304062657, 6269.68651567429, 6410.551261411656, 6454.257760357619, 6464.965605503097, 6495.123158373559, 6267.059941008885, 6304.968475157595, 6382.87234255303, 6402.775902843378, 6424.678766061772, 6057.454829065406, 6130.172426722335, 6135.386461353829, 6155.938440615716, 6312.431881130537, 6302.306746257999, 6391.744330226739, 6403.487720982217, 6439.710213040331, 6449.387997860874, 6153.753849845956, 6189.752409903554, 6199.380061993765, 6226.59527130735, 6322.968385158045], "value": 4964.787063545217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.5468411110336, 918.8070505193909, 924.2282693950551, 925.8888933328, 935.7800916784554, 17121.31514739412, 17878.284868605257, 18967.810321896777, 18996.14517346721, 19025.429237122873, 16281.592960175973, 20292.492687682814, 21047.05288262028, 21115.15539378427, 21245.0, 977.1352353167426, 1003.7152444870559, 1011.9241056920723, 1051.7791263834604, 1067.0396643021304, 1086.0605576176629, 1086.6359769477194, 1090.0353187429102, 1090.6346373964732, 1092.6831218946495, 1062.3254233561706, 1103.8840921703227, 1106.3804269609004, 1113.4377139544558, 1113.8106521891257, 1096.8957948994873, 1098.8406681031286, 1099.1426687183969, 1099.3843447669292, 1099.5821587796586, 801.2948605227363, 801.7634797734682, 803.714681288146, 805.2028491793142, 805.6374631415828, 19077.332293369804, 19355.90322048395, 19483.025848707508, 19538.218471261134, 20715.8964205178, 20399.796002039937, 20536.486587835276, 20934.057967391505, 20955.37133885986, 21198.470038249012, 16062.116583587898, 16105.0, 16152.676946461004, 16199.35202591895, 16283.511494655178, 3464.826758662082, 3482.407990641597, 3489.5289135966827, 3516.191276006533, 3517.8065206413635, 121606.0, 123597.0, 125570.37214813959, 127585.0, 130286.0, 15290.235488225544, 15676.92161539185, 15854.92072539653, 15910.920445397698, 15976.680466390608, 27145.86427067852, 30449.543256851164, 30569.235769105504, 30571.8471407646, 30714.078577642707, 8305.335573154132, 8312.8337433251, 8392.4544904581, 8395.286400656012, 8404.621792019374, 3632.1101330173747, 3659.121810765397, 3762.755420897633, 3801.733878628525, 3867.9226415471535, 5087.3386459759995, 5156.767945442464, 5201.115810312181, 5215.608829337815, 5248.947510524846, 1032.2516175772655, 1067.69570672358, 1073.0503504398507, 1085.8696956365286, 1086.2939089591828, 663.2869665110026, 666.6433458099893, 691.6334342798325, 701.7438634898225, 710.1868360726938, 11120.165987550967, 11754.647360579196, 12171.513139474499, 13113.868861311455, 14180.361883715257, 671.2683175338807, 682.494953734233, 682.5631595778706, 702.8734827731057, 706.5125063706026, 5128.153854613947, 5186.299849520342, 5189.818356357509, 5276.736163191825, 5458.590605704588, 92358.53820730853, 100718.0, 103910.48044759728, 104725.47637261765, 105660.47169764101, 89915.0, 93289.0, 93434.0, 93616.0, 93890.53054734683, 75034.0, 78198.6090069546, 78726.6063669678, 82780.0, 83038.58480707557, 11203.775924481302, 11971.580994665144, 12226.205296656044, 12323.940176777453, 12989.220646761225, 33833.49249761206, 38110.856674299815, 38235.61764382321, 38342.616573833904, 38391.42412863753, 59675.1048734278, 65060.34939650732, 66307.0, 68961.0, 69590.65204673944, 19221.711674325175, 19594.90202548978, 19624.41126766199, 19629.901850490656, 19945.401637950883, 21006.159753610296, 21404.7859521409, 21482.0, 21659.458513537287, 21735.0, 17695.203715833075, 18513.81486185121, 18762.906185468986, 18877.71683424722, 19296.903515482332, 19232.519187020436, 19404.417867464, 19936.90031549833, 20033.899830500755, 20226.89886550558, 17890.91054544719, 18267.995260260814, 18529.9073504637, 18641.72037419467, 18742.062896855376, 13790.448382064606, 13815.930920345736, 14101.0, 14129.222892740998, 14359.712805744035, 13494.460221591418, 14627.122372657675, 14636.633064616926, 14780.113193208443, 14971.32629031718], "value": 9111.995726175674, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 98.0, 109.0, 112.0, 122.0, 118.0, 109.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 149.0, 183.0, 117.0, 148.0, 151.0, 117.0, 173.0, 118.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 162.0, 164.0, 176.0, 167.0, 164.0, 166.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 123.0, 77.0, 77.0, 75.0, 90.0, 113.0, 77.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 137.0, 81.0, 81.0, 82.0, 132.0, 81.0, 81.0, 139.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 152.0, 153.0, 153.0, 151.0, 151.0, 152.0, 152.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 99.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 59.0, 52.0, 52.0, 55.0, 55.0, 53.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 56.0, 54.0, 61.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 86.0, 78.0, 77.0, 78.0, 78.0, 77.0, 77.0, 77.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 128.0, 127.0, 128.0, 129.0, 128.0, 126.0, 127.0, 161.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 185.0, 175.0, 180.0, 172.0, 177.0, 185.0, 178.0, 177.0, 178.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 74.0, 68.0, 72.0, 67.0, 69.0, 66.0, 66.0, 69.0], "value": 68.9, "unit": "score"}]}]} 10:22:56 INFO - Return code: 0 10:22:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:56 INFO - # TBPL SUCCESS # 10:22:56 INFO - Running post-action listener: _package_coverage_data 10:22:56 INFO - Running post-action listener: _resource_record_post_action 10:22:56 INFO - [mozharness: 2017-07-23 17:22:56.329724Z] Finished run-tests step (success) 10:22:56 INFO - Running post-run listener: _resource_record_post_run 10:22:56 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 440074240; Read time: 16; Write time: 285508 10:22:56 INFO - TinderboxPrint: CPU usage
13.2% 10:22:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:22:56 INFO - TinderboxPrint: I/O write bytes / time
440,074,240 / 285,508 10:22:56 INFO - TinderboxPrint: CPU idle
8,266.0 (86.8%) 10:22:56 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 10:22:56 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108417024; Read time: 0; Write time: 96584 10:22:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:22:56 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 331046912; Read time: 0; Write time: 188920 10:22:56 INFO - Running post-run listener: _upload_blobber_files 10:22:56 INFO - Blob upload gear active. 10:22:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:56 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 10:22:56 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'] 10:22:56 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 10:22:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:58 INFO - (blobuploader) - INFO - Done attempting. 10:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:58 INFO - (blobuploader) - INFO - Done attempting. 10:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:22:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:59 INFO - (blobuploader) - INFO - Done attempting. 10:22:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:06 INFO - (blobuploader) - INFO - Done attempting. 10:23:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:06 INFO - Return code: 0 10:23:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/458cd98252403e1684ac7e9bfb9b38b37e70f0f96f5d0fd77b60c730a3844341513bd68ca9786ed019bcc0433a84f4dbf03a47be95b1e04e86d5f8f5df682a33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc266c969f75f1b67a7e936f904a88b1824f6a84e25adcc4c3542d883664047eb9afa0e0077ad65bb5f3a3d1b738ae2bc6e33cec60b49f161dbfeb5d3971ecb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de5e8c2dc438fd691538f0df5e4975538c286b294c6c066e507af5b658f3c2b0122c2df31d3f07ac3d6831d5988a0fa70bc0a15d1da8538b281c2469db153480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769423a200b8628d7e32a9094f52e2fc5901e04563d24841ef8e694503d951b1cfb42da41bbb9439332d77bbbd598e7453f2d720aaa2343a8c472a42aeca72f6"} 10:23:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:06 INFO - Contents: 10:23:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/458cd98252403e1684ac7e9bfb9b38b37e70f0f96f5d0fd77b60c730a3844341513bd68ca9786ed019bcc0433a84f4dbf03a47be95b1e04e86d5f8f5df682a33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc266c969f75f1b67a7e936f904a88b1824f6a84e25adcc4c3542d883664047eb9afa0e0077ad65bb5f3a3d1b738ae2bc6e33cec60b49f161dbfeb5d3971ecb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de5e8c2dc438fd691538f0df5e4975538c286b294c6c066e507af5b658f3c2b0122c2df31d3f07ac3d6831d5988a0fa70bc0a15d1da8538b281c2469db153480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769423a200b8628d7e32a9094f52e2fc5901e04563d24841ef8e694503d951b1cfb42da41bbb9439332d77bbbd598e7453f2d720aaa2343a8c472a42aeca72f6"} 10:23:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:06 INFO - Copying logs to upload dir... 10:23:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.014663 ========= master_lag: 1.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-23 10:23:07.415777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 10:23:07.419818) ========= 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=0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/458cd98252403e1684ac7e9bfb9b38b37e70f0f96f5d0fd77b60c730a3844341513bd68ca9786ed019bcc0433a84f4dbf03a47be95b1e04e86d5f8f5df682a33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc266c969f75f1b67a7e936f904a88b1824f6a84e25adcc4c3542d883664047eb9afa0e0077ad65bb5f3a3d1b738ae2bc6e33cec60b49f161dbfeb5d3971ecb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de5e8c2dc438fd691538f0df5e4975538c286b294c6c066e507af5b658f3c2b0122c2df31d3f07ac3d6831d5988a0fa70bc0a15d1da8538b281c2469db153480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769423a200b8628d7e32a9094f52e2fc5901e04563d24841ef8e694503d951b1cfb42da41bbb9439332d77bbbd598e7453f2d720aaa2343a8c472a42aeca72f6"} build_url:https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/AptT2c_eTyGLJWHJdRCE5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/458cd98252403e1684ac7e9bfb9b38b37e70f0f96f5d0fd77b60c730a3844341513bd68ca9786ed019bcc0433a84f4dbf03a47be95b1e04e86d5f8f5df682a33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efc266c969f75f1b67a7e936f904a88b1824f6a84e25adcc4c3542d883664047eb9afa0e0077ad65bb5f3a3d1b738ae2bc6e33cec60b49f161dbfeb5d3971ecb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de5e8c2dc438fd691538f0df5e4975538c286b294c6c066e507af5b658f3c2b0122c2df31d3f07ac3d6831d5988a0fa70bc0a15d1da8538b281c2469db153480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/769423a200b8628d7e32a9094f52e2fc5901e04563d24841ef8e694503d951b1cfb42da41bbb9439332d77bbbd598e7453f2d720aaa2343a8c472a42aeca72f6"}' ========= master_lag: 0.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 10:23:07.793462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-07-23 10:23:07.793791) ========= 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=0333a256a5e4f052382dd180000001b1-1500825612.243408-657597392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 2.41 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-07-23 10:23:10.207555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 10:23:10.207867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 10:23:10.266293) ========= ========= Total master_lag: 4.36 =========