builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1500935637.21 results: success (0) revision: bf4634a50775537b4e791b6d294a275b83737472 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.213230) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.213671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.213954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.334735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.335035) ========= 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=337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 15:33:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.0M=0s 2017-07-24 15:33:57 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128650 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.510079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.510423) ========= 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=337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020980 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.570093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.570407) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf4634a50775537b4e791b6d294a275b83737472 --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 bf4634a50775537b4e791b6d294a275b83737472 --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=337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 15:33:57,737 truncating revision to first 12 chars 2017-07-24 15:33:57,737 Setting DEBUG logging. 2017-07-24 15:33:57,737 attempt 1/10 2017-07-24 15:33:57,737 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf4634a50775?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 15:33:58,226 unpacking tar archive at: mozilla-central-bf4634a50775/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.380811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.384140) ========= script_repo_revision: bf4634a50775537b4e791b6d294a275b83737472 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.384537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.384832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.440587) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-24 15:33:58.440846) ========= /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=337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:33:58 INFO - MultiFileLogger online at 20170724 15:33:58 in /builds/slave/test 15:33:58 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 15:33:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:58 INFO - {'append_to_log': False, 15:33:58 INFO - 'base_work_dir': '/builds/slave/test', 15:33:58 INFO - 'blob_upload_branch': 'Firefox', 15:33:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:58 INFO - 'branch': 'Firefox', 15:33:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:58 INFO - 'code_coverage': False, 15:33:58 INFO - 'config_files': ('talos/linux_config.py',), 15:33:58 INFO - 'default_actions': ('clobber', 15:33:58 INFO - 'read-buildbot-config', 15:33:58 INFO - 'download-and-extract', 15:33:58 INFO - 'populate-webroot', 15:33:58 INFO - 'create-virtualenv', 15:33:58 INFO - 'install', 15:33:58 INFO - 'setup-mitmproxy', 15:33:58 INFO - 'run-tests'), 15:33:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:58 INFO - 'disable_ccov_upload': False, 15:33:58 INFO - 'download_minidump_stackwalk': True, 15:33:58 INFO - 'download_symbols': 'ondemand', 15:33:58 INFO - 'enable_stylo': False, 15:33:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:58 INFO - 'gecko_profile': False, 15:33:58 INFO - 'gecko_profile_interval': 0, 15:33:58 INFO - 'installer_path': 'installer.exe', 15:33:58 INFO - 'log_level': 'info', 15:33:58 INFO - 'log_name': 'talos', 15:33:58 INFO - 'log_to_console': True, 15:33:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:33:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:33:58 INFO - 'opt_config_files': (), 15:33:58 INFO - 'pip_index': False, 15:33:58 INFO - 'suite': 'dromaeojs-e10s', 15:33:58 INFO - 'system_bits': '32', 15:33:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:58 INFO - 'title': 'talos-linux64-ix-060', 15:33:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:58 INFO - 'use_talos_json': True, 15:33:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:58 INFO - 'work_dir': 'build'} 15:33:58 INFO - [mozharness: 2017-07-24 22:33:58.714144Z] Running clobber step. 15:33:58 INFO - Running pre-action listener: _resource_record_pre_action 15:33:58 INFO - Running main action method: clobber 15:33:58 INFO - rmtree: /builds/slave/test/build 15:33:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:00 INFO - Running post-action listener: _resource_record_post_action 15:34:00 INFO - [mozharness: 2017-07-24 22:34:00.271337Z] Finished clobber step (success) 15:34:00 INFO - [mozharness: 2017-07-24 22:34:00.271439Z] Running read-buildbot-config step. 15:34:00 INFO - Running pre-action listener: _resource_record_pre_action 15:34:00 INFO - Running main action method: read_buildbot_config 15:34:00 INFO - Using buildbot properties: 15:34:00 INFO - { 15:34:00 INFO - "project": "", 15:34:00 INFO - "product": "firefox", 15:34:00 INFO - "who": "kwierso@gmail.com", 15:34:00 INFO - "installer_path": "public/build/target.tar.bz2", 15:34:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:34:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:34:00 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:34:00 INFO - "stage_platform": "linux64-stylosequential", 15:34:00 INFO - "basedir": "/builds/slave/test", 15:34:00 INFO - "buildnumber": 122, 15:34:00 INFO - "platform": "ubuntu64_hw_styloseq", 15:34:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:34:00 INFO - "slavebuilddir": "test", 15:34:00 INFO - "taskId": "ER6mfWLuR3G5dNocYNwNQg", 15:34:00 INFO - "branch": "mozilla-central", 15:34:00 INFO - "script_repo_revision": "production", 15:34:00 INFO - "revision": "bf4634a50775537b4e791b6d294a275b83737472", 15:34:00 INFO - "slavename": "talos-linux64-ix-060", 15:34:00 INFO - "repo_path": "mozilla-central" 15:34:00 INFO - } 15:34:00 INFO - Finding installer, test and symbols from parent task. 15:34:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ER6mfWLuR3G5dNocYNwNQg'}, attempt #1 15:34:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ER6mfWLuR3G5dNocYNwNQg'}, attempt #1 15:34:01 INFO - Task dependencies: S1EjXnT4TFqOlI6-AEiL3g 15:34:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g'}, attempt #1 15:34:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/test_packages.json 15:34:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip 15:34:01 INFO - Running post-action listener: _resource_record_post_action 15:34:01 INFO - [mozharness: 2017-07-24 22:34:01.878081Z] Finished read-buildbot-config step (success) 15:34:01 INFO - [mozharness: 2017-07-24 22:34:01.878300Z] Running download-and-extract step. 15:34:01 INFO - Running pre-action listener: _resource_record_pre_action 15:34:01 INFO - Running main action method: download_and_extract 15:34:01 INFO - mkdir: /builds/slave/test/build/tests 15:34: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')]} 15:34:01 INFO - trying https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.test_packages.json 15:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:34:02 INFO - Downloaded 989 bytes. 15:34:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:34:02 INFO - Using the following test package requirements: 15:34:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:34:02 INFO - u'common': [u'target.common.tests.zip'], 15:34:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:34:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:34:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:34:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:34:02 INFO - u'mozbase': [u'target.common.tests.zip'], 15:34:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:34:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:34:02 INFO - u'web-platform': [u'target.common.tests.zip', 15:34:02 INFO - u'target.web-platform.tests.tar.gz'], 15:34:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:34:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip 15:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip into memory 15:34:06 INFO - Content-Length response header: 72761346 15:34:06 INFO - Bytes received: 72761346 15:34:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip 15:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip into memory 15:34:21 INFO - Content-Length response header: 72761346 15:34:21 INFO - Bytes received: 72761346 15:34:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.talos.tests.zip 15:34:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:34:33 INFO - Fetch https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.talos.tests.zip into memory 15:34:34 INFO - Content-Length response header: 14498976 15:34:34 INFO - Bytes received: 14498976 15:34:34 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')]} 15:34:34 INFO - trying https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:34 INFO - Downloading https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:34:38 INFO - Downloaded 62039933 bytes. 15:34:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:38 INFO - mkdir: /builds/slave/test/properties 15:34:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:38 INFO - Contents: 15:34:38 INFO - build_url:https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:38 INFO - Running post-action listener: _resource_record_post_action 15:34:38 INFO - Running post-action listener: set_extra_try_arguments 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.475877Z] Finished download-and-extract step (success) 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.476105Z] Running populate-webroot step. 15:34:38 INFO - Running pre-action listener: _resource_record_pre_action 15:34:38 INFO - Running main action method: populate_webroot 15:34:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'tests': ['damp', 'tps']}, 15:34:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:34:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:34:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:38 INFO - 'ts_paint', 15:34:38 INFO - 'tpaint', 15:34:38 INFO - 'sessionrestore', 15:34:38 INFO - 'sessionrestore_many_windows', 15:34:38 INFO - 'sessionrestore_no_auto_restore', 15:34:38 INFO - 'tabpaint']}, 15:34:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:34:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:34:38 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:38 INFO - 'talos_options': ['--mitmproxy', 15:34:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:38 INFO - '--firstNonBlankPaint'], 15:34:38 INFO - 'tests': ['quantum_pageload_google', 15:34:38 INFO - 'quantum_pageload_youtube', 15:34:38 INFO - 'quantum_pageload_amazon', 15:34:38 INFO - 'quantum_pageload_facebook']}, 15:34:38 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:38 INFO - 'talos_options': ['--stylo', 15:34:38 INFO - '--mitmproxy', 15:34:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:38 INFO - '--firstNonBlankPaint'], 15:34:38 INFO - 'tests': ['quantum_pageload_google', 15:34:38 INFO - 'quantum_pageload_youtube', 15:34:38 INFO - 'quantum_pageload_amazon', 15:34:38 INFO - 'quantum_pageload_facebook']}, 15:34:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:38 INFO - 'tsvgr_opacity', 15:34:38 INFO - 'tart', 15:34:38 INFO - 'tscrollx', 15:34:38 INFO - 'cart', 15:34:38 INFO - 'tsvg_static']}, 15:34:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:34:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'talos_options': ['--xperf_path', 15:34:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:38 INFO - 'tests': ['tp5n']}}} 15:34:38 INFO - Running post-action listener: _resource_record_post_action 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.484192Z] Finished populate-webroot step (success) 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.484281Z] Running create-virtualenv step. 15:34:38 INFO - Running pre-action listener: _resource_record_pre_action 15:34:38 INFO - Running main action method: create_virtualenv 15:34:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:34:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:34:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:38 INFO - Using real prefix '/usr' 15:34:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:41 INFO - Installing pip.................done. 15:34:41 INFO - Return code: 0 15:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:34:41 INFO - Reading from file tmpfile_stdout 15:34:41 INFO - Output received: 15:34:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:34:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:41 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')]} 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:41 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')]} 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:41 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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:41 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 15:34:41 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 15:34:41 INFO - Using env: {'DISPLAY': ':0', 15:34:41 INFO - 'HOME': '/home/cltbld', 15:34:41 INFO - 'LANG': 'en_US.UTF-8', 15:34:41 INFO - 'LANGUAGE': 'en_US:en', 15:34:41 INFO - 'LOGNAME': 'cltbld', 15:34:41 INFO - 'MAIL': '/var/mail/cltbld', 15:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:41 INFO - 'MOZ_NO_REMOTE': '1', 15:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:41 INFO - 'NO_EM_RESTART': '1', 15:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:41 INFO - 'PWD': '/builds/slave/test', 15:34:41 INFO - 'SHELL': '/bin/bash', 15:34:41 INFO - 'SHLVL': '1', 15:34:41 INFO - 'TERM': 'linux', 15:34:41 INFO - 'TMOUT': '86400', 15:34:41 INFO - 'USER': 'cltbld', 15:34:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:41 INFO - '_': '/tools/buildbot/bin/python'} 15:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:34:41 INFO - Cleaning up... 15:34:41 INFO - Return code: 0 15:34:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34:41 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')]} 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:41 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')]} 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:41 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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:41 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 15:34:41 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 15:34:41 INFO - Using env: {'DISPLAY': ':0', 15:34:41 INFO - 'HOME': '/home/cltbld', 15:34:41 INFO - 'LANG': 'en_US.UTF-8', 15:34:41 INFO - 'LANGUAGE': 'en_US:en', 15:34:41 INFO - 'LOGNAME': 'cltbld', 15:34:41 INFO - 'MAIL': '/var/mail/cltbld', 15:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:41 INFO - 'MOZ_NO_REMOTE': '1', 15:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:41 INFO - 'NO_EM_RESTART': '1', 15:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:41 INFO - 'PWD': '/builds/slave/test', 15:34:41 INFO - 'SHELL': '/bin/bash', 15:34:41 INFO - 'SHLVL': '1', 15:34:41 INFO - 'TERM': 'linux', 15:34:41 INFO - 'TMOUT': '86400', 15:34:41 INFO - 'USER': 'cltbld', 15:34:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:41 INFO - '_': '/tools/buildbot/bin/python'} 15:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:41 INFO - Downloading/unpacking psutil>=3.1.1 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:42 INFO - Installing collected packages: psutil 15:34:42 INFO - Running setup.py install for psutil 15:34:42 INFO - building 'psutil._psutil_linux' extension 15:34:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:34:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:34:43 INFO - building 'psutil._psutil_posix' extension 15:34:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:34:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:43 INFO - Successfully installed psutil 15:34:43 INFO - Cleaning up... 15:34:43 INFO - Return code: 0 15:34:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:34:43 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')]} 15:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:43 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')]} 15:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:43 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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:43 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 15:34:43 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 15:34:43 INFO - Using env: {'DISPLAY': ':0', 15:34:43 INFO - 'HOME': '/home/cltbld', 15:34:43 INFO - 'LANG': 'en_US.UTF-8', 15:34:43 INFO - 'LANGUAGE': 'en_US:en', 15:34:43 INFO - 'LOGNAME': 'cltbld', 15:34:43 INFO - 'MAIL': '/var/mail/cltbld', 15:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:43 INFO - 'MOZ_NO_REMOTE': '1', 15:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:43 INFO - 'NO_EM_RESTART': '1', 15:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:43 INFO - 'PWD': '/builds/slave/test', 15:34:43 INFO - 'SHELL': '/bin/bash', 15:34:43 INFO - 'SHLVL': '1', 15:34:43 INFO - 'TERM': 'linux', 15:34:43 INFO - 'TMOUT': '86400', 15:34:43 INFO - 'USER': 'cltbld', 15:34:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:43 INFO - '_': '/tools/buildbot/bin/python'} 15:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:34:44 INFO - Installing collected packages: mozsystemmonitor 15:34:44 INFO - Running setup.py install for mozsystemmonitor 15:34:44 INFO - Successfully installed mozsystemmonitor 15:34:44 INFO - Cleaning up... 15:34:44 INFO - Return code: 0 15:34:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34: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', '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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:34: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 jsonschema==2.5.1 15:34:44 INFO - Using env: {'DISPLAY': ':0', 15:34:44 INFO - 'HOME': '/home/cltbld', 15:34:44 INFO - 'LANG': 'en_US.UTF-8', 15:34:44 INFO - 'LANGUAGE': 'en_US:en', 15:34:44 INFO - 'LOGNAME': 'cltbld', 15:34:44 INFO - 'MAIL': '/var/mail/cltbld', 15:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:44 INFO - 'MOZ_NO_REMOTE': '1', 15:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:44 INFO - 'NO_EM_RESTART': '1', 15:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:44 INFO - 'PWD': '/builds/slave/test', 15:34:44 INFO - 'SHELL': '/bin/bash', 15:34:44 INFO - 'SHLVL': '1', 15:34:44 INFO - 'TERM': 'linux', 15:34:44 INFO - 'TMOUT': '86400', 15:34:44 INFO - 'USER': 'cltbld', 15:34:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:44 INFO - '_': '/tools/buildbot/bin/python'} 15:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:45 INFO - Downloading/unpacking jsonschema==2.5.1 15:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:34:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:34: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 15:34: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 15:34: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 15:34: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 15:34:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:34:46 INFO - warning: no files found matching '*.txt' 15:34:46 INFO - no previously-included directories found matching 'build' 15:34:46 INFO - no previously-included directories found matching 'dist' 15:34:46 INFO - no previously-included directories found matching '.git*' 15:34:46 INFO - Installing collected packages: jsonschema, functools32 15:34:46 INFO - Running setup.py install for functools32 15:34:46 INFO - warning: no files found matching '*.txt' 15:34:46 INFO - no previously-included directories found matching 'build' 15:34:46 INFO - no previously-included directories found matching 'dist' 15:34:46 INFO - no previously-included directories found matching '.git*' 15:34:46 INFO - Successfully installed jsonschema functools32 15:34:46 INFO - Cleaning up... 15:34:46 INFO - Return code: 0 15:34:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34: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', '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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:34: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 functools32==3.2.3-2 15:34:46 INFO - Using env: {'DISPLAY': ':0', 15:34:46 INFO - 'HOME': '/home/cltbld', 15:34:46 INFO - 'LANG': 'en_US.UTF-8', 15:34:46 INFO - 'LANGUAGE': 'en_US:en', 15:34:46 INFO - 'LOGNAME': 'cltbld', 15:34:46 INFO - 'MAIL': '/var/mail/cltbld', 15:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:46 INFO - 'MOZ_NO_REMOTE': '1', 15:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:46 INFO - 'NO_EM_RESTART': '1', 15:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:46 INFO - 'PWD': '/builds/slave/test', 15:34:46 INFO - 'SHELL': '/bin/bash', 15:34:46 INFO - 'SHLVL': '1', 15:34:46 INFO - 'TERM': 'linux', 15:34:46 INFO - 'TMOUT': '86400', 15:34:46 INFO - 'USER': 'cltbld', 15:34:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:46 INFO - '_': '/tools/buildbot/bin/python'} 15:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:34:46 INFO - Cleaning up... 15:34:46 INFO - Return code: 0 15:34:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34: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', '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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:34: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 blobuploader==1.2.4 15:34:46 INFO - Using env: {'DISPLAY': ':0', 15:34:46 INFO - 'HOME': '/home/cltbld', 15:34:46 INFO - 'LANG': 'en_US.UTF-8', 15:34:46 INFO - 'LANGUAGE': 'en_US:en', 15:34:46 INFO - 'LOGNAME': 'cltbld', 15:34:46 INFO - 'MAIL': '/var/mail/cltbld', 15:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:46 INFO - 'MOZ_NO_REMOTE': '1', 15:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:46 INFO - 'NO_EM_RESTART': '1', 15:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:46 INFO - 'PWD': '/builds/slave/test', 15:34:46 INFO - 'SHELL': '/bin/bash', 15:34:46 INFO - 'SHLVL': '1', 15:34:46 INFO - 'TERM': 'linux', 15:34:46 INFO - 'TMOUT': '86400', 15:34:46 INFO - 'USER': 'cltbld', 15:34:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:46 INFO - '_': '/tools/buildbot/bin/python'} 15:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:34: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 15:34: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 15:34: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 15:34: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 15:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34:48 INFO - Downloading docopt-0.6.1.tar.gz 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:48 INFO - Running setup.py install for blobuploader 15:34:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:48 INFO - Running setup.py install for requests 15:34:49 INFO - Running setup.py install for docopt 15:34:49 INFO - Successfully installed blobuploader requests docopt 15:34:49 INFO - Cleaning up... 15:34:49 INFO - Return code: 0 15:34:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:49 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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:49 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 15:34:49 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 15:34:49 INFO - Using env: {'DISPLAY': ':0', 15:34:49 INFO - 'HOME': '/home/cltbld', 15:34:49 INFO - 'LANG': 'en_US.UTF-8', 15:34:49 INFO - 'LANGUAGE': 'en_US:en', 15:34:49 INFO - 'LOGNAME': 'cltbld', 15:34:49 INFO - 'MAIL': '/var/mail/cltbld', 15:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:49 INFO - 'MOZ_NO_REMOTE': '1', 15:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:49 INFO - 'NO_EM_RESTART': '1', 15:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:49 INFO - 'PWD': '/builds/slave/test', 15:34:49 INFO - 'SHELL': '/bin/bash', 15:34:49 INFO - 'SHLVL': '1', 15:34:49 INFO - 'TERM': 'linux', 15:34:49 INFO - 'TMOUT': '86400', 15:34:49 INFO - 'USER': 'cltbld', 15:34:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:49 INFO - '_': '/tools/buildbot/bin/python'} 15:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:49 INFO - Running setup.py (path:/tmp/pip-a167ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:49 INFO - Running setup.py (path:/tmp/pip-E577V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:49 INFO - Running setup.py (path:/tmp/pip-kf_awM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:49 INFO - Running setup.py (path:/tmp/pip-HGGECo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:49 INFO - Running setup.py (path:/tmp/pip-eqbGR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:49 INFO - Running setup.py (path:/tmp/pip-l7EdeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:49 INFO - Running setup.py (path:/tmp/pip-dyD2nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:49 INFO - Running setup.py (path:/tmp/pip-uZGXE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:50 INFO - Running setup.py (path:/tmp/pip-9XjwYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:50 INFO - Running setup.py (path:/tmp/pip-Dr8szH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:50 INFO - Running setup.py (path:/tmp/pip-JrRID1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:50 INFO - Running setup.py (path:/tmp/pip-bi0F_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:50 INFO - Running setup.py (path:/tmp/pip-inLtMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:50 INFO - Running setup.py (path:/tmp/pip-qyzDPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:50 INFO - Running setup.py (path:/tmp/pip-PF5t5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:50 INFO - Running setup.py (path:/tmp/pip-wyyA7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:50 INFO - Running setup.py (path:/tmp/pip-Dx8MYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:50 INFO - Running setup.py install for manifestparser 15:34:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:50 INFO - Running setup.py install for mozcrash 15:34:50 INFO - Running setup.py install for mozdebug 15:34:51 INFO - Running setup.py install for mozdevice 15:34:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozfile 15:34:51 INFO - Running setup.py install for mozhttpd 15:34:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozinfo 15:34:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozInstall 15:34:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozleak 15:34:51 INFO - Running setup.py install for mozlog 15:34:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for moznetwork 15:34:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozprocess 15:34:51 INFO - Running setup.py install for mozprofile 15:34:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozrunner 15:34:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozscreenshot 15:34:52 INFO - Running setup.py install for moztest 15:34:52 INFO - Running setup.py install for mozversion 15:34:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:52 INFO - Cleaning up... 15:34:52 INFO - Return code: 0 15:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:34:52 INFO - Using env: {'DISPLAY': ':0', 15:34:52 INFO - 'HOME': '/home/cltbld', 15:34:52 INFO - 'LANG': 'en_US.UTF-8', 15:34:52 INFO - 'LANGUAGE': 'en_US:en', 15:34:52 INFO - 'LOGNAME': 'cltbld', 15:34:52 INFO - 'MAIL': '/var/mail/cltbld', 15:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:52 INFO - 'MOZ_NO_REMOTE': '1', 15:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:52 INFO - 'NO_EM_RESTART': '1', 15:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:52 INFO - 'PWD': '/builds/slave/test', 15:34:52 INFO - 'SHELL': '/bin/bash', 15:34:52 INFO - 'SHLVL': '1', 15:34:52 INFO - 'TERM': 'linux', 15:34:52 INFO - 'TMOUT': '86400', 15:34:52 INFO - 'USER': 'cltbld', 15:34:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:52 INFO - '_': '/tools/buildbot/bin/python'} 15:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:52 INFO - Running setup.py (path:/tmp/pip-r7ttsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:52 INFO - Running setup.py (path:/tmp/pip-FKeKix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:52 INFO - Running setup.py (path:/tmp/pip-ozhJrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:52 INFO - Running setup.py (path:/tmp/pip-IqWEdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:52 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)) 15:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:52 INFO - Running setup.py (path:/tmp/pip-2Jidmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:53 INFO - Running setup.py (path:/tmp/pip-IVuAqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:53 INFO - Running setup.py (path:/tmp/pip-pTaO1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:53 INFO - Running setup.py (path:/tmp/pip-taeZ5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:53 INFO - Running setup.py (path:/tmp/pip-OGeXaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:53 INFO - Running setup.py (path:/tmp/pip-8b3oQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:53 INFO - Running setup.py (path:/tmp/pip-oDa5xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:53 INFO - Running setup.py (path:/tmp/pip-V4CvOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:53 INFO - Running setup.py (path:/tmp/pip-MuLD81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:53 INFO - Running setup.py (path:/tmp/pip-dwvG3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:53 INFO - Running setup.py (path:/tmp/pip-MgNhTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:53 INFO - Running setup.py (path:/tmp/pip-NUfMwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:53 INFO - Running setup.py (path:/tmp/pip-tuRpR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:53 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)) 15:34:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:55 INFO - Downloading blessings-1.6.tar.gz 15:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:55 INFO - Installing collected packages: blessings 15:34:55 INFO - Running setup.py install for blessings 15:34:55 INFO - Successfully installed blessings 15:34:55 INFO - Cleaning up... 15:34:55 INFO - Return code: 0 15:34:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:55 INFO - Reading from file tmpfile_stdout 15:34:55 INFO - Current package versions: 15:34:55 INFO - argparse == 1.2.1 15:34:55 INFO - blessings == 1.6 15:34:55 INFO - blobuploader == 1.2.4 15:34:55 INFO - docopt == 0.6.1 15:34:55 INFO - functools32 == 3.2.3-2 15:34:55 INFO - jsonschema == 2.5.1 15:34:55 INFO - manifestparser == 1.1 15:34:55 INFO - mozInstall == 1.13 15:34:55 INFO - mozcrash == 1.0 15:34:55 INFO - mozdebug == 0.1 15:34:55 INFO - mozdevice == 0.51 15:34:55 INFO - mozfile == 1.2 15:34:55 INFO - mozhttpd == 0.7 15:34:55 INFO - mozinfo == 0.10 15:34:55 INFO - mozleak == 0.1 15:34:55 INFO - mozlog == 3.5 15:34:55 INFO - moznetwork == 0.27 15:34:55 INFO - mozprocess == 0.25 15:34:55 INFO - mozprofile == 0.28 15:34:55 INFO - mozrunner == 6.13 15:34:55 INFO - mozscreenshot == 0.1 15:34:55 INFO - mozsystemmonitor == 0.3 15:34:55 INFO - moztest == 0.8 15:34:55 INFO - mozversion == 1.4 15:34:55 INFO - psutil == 3.1.1 15:34:55 INFO - requests == 1.2.3 15:34:55 INFO - wsgiref == 0.1.2 15:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:55 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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:55 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 15:34:55 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 15:34:55 INFO - Using env: {'DISPLAY': ':0', 15:34:55 INFO - 'HOME': '/home/cltbld', 15:34:55 INFO - 'LANG': 'en_US.UTF-8', 15:34:55 INFO - 'LANGUAGE': 'en_US:en', 15:34:55 INFO - 'LOGNAME': 'cltbld', 15:34:55 INFO - 'MAIL': '/var/mail/cltbld', 15:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:55 INFO - 'MOZ_NO_REMOTE': '1', 15:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:55 INFO - 'NO_EM_RESTART': '1', 15:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:55 INFO - 'PWD': '/builds/slave/test', 15:34:55 INFO - 'SHELL': '/bin/bash', 15:34:55 INFO - 'SHLVL': '1', 15:34:55 INFO - 'TERM': 'linux', 15:34:55 INFO - 'TMOUT': '86400', 15:34:55 INFO - 'USER': 'cltbld', 15:34:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:55 INFO - '_': '/tools/buildbot/bin/python'} 15:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:34:55 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:56 INFO - Downloading marionette_driver-1.4.0.tar.gz 15:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 15:34:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:34:57 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)) 15:34:57 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)) 15:34:57 INFO - Installing collected packages: marionette-driver, simplejson 15:34:57 INFO - Running setup.py install for marionette-driver 15:34:57 INFO - Running setup.py install for simplejson 15:34:57 INFO - building 'simplejson._speedups' extension 15:34:57 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 15:34:58 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 15:34:58 INFO - Successfully installed marionette-driver simplejson 15:34:58 INFO - Cleaning up... 15:34:58 INFO - Return code: 0 15:34:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:58 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 0x18a31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c12d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, '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': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:34:58 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 15:34:58 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 15:34:58 INFO - Using env: {'DISPLAY': ':0', 15:34:58 INFO - 'HOME': '/home/cltbld', 15:34:58 INFO - 'LANG': 'en_US.UTF-8', 15:34:58 INFO - 'LANGUAGE': 'en_US:en', 15:34:58 INFO - 'LOGNAME': 'cltbld', 15:34:58 INFO - 'MAIL': '/var/mail/cltbld', 15:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:58 INFO - 'MOZ_NO_REMOTE': '1', 15:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:58 INFO - 'NO_EM_RESTART': '1', 15:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:58 INFO - 'PWD': '/builds/slave/test', 15:34:58 INFO - 'SHELL': '/bin/bash', 15:34:58 INFO - 'SHLVL': '1', 15:34:58 INFO - 'TERM': 'linux', 15:34:58 INFO - 'TMOUT': '86400', 15:34:58 INFO - 'USER': 'cltbld', 15:34:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:58 INFO - '_': '/tools/buildbot/bin/python'} 15:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:58 INFO - Cleaning up... 15:34:58 INFO - Return code: 0 15:34:58 INFO - Running post-action listener: _resource_record_post_action 15:34:58 INFO - Running post-action listener: _start_resource_monitoring 15:34:58 INFO - Starting resource monitoring. 15:34:58 INFO - [mozharness: 2017-07-24 22:34:58.493603Z] Finished create-virtualenv step (success) 15:34:58 INFO - [mozharness: 2017-07-24 22:34:58.494118Z] Running install step. 15:34:58 INFO - Running pre-action listener: _resource_record_pre_action 15:34:58 INFO - Running main action method: install 15:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:58 INFO - Reading from file tmpfile_stdout 15:34:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:58 INFO - Reading from file tmpfile_stdout 15:34:58 INFO - Output received: 15:34:58 INFO - Usage: mozinstall [options] installer 15:34:58 INFO - Options: 15:34:58 INFO - -h, --help show this help message and exit 15:34:58 INFO - -d DEST, --destination=DEST 15:34:58 INFO - Directory to install application into. [default: 15:34:58 INFO - "/builds/slave/test"] 15:34:58 INFO - --app=APP Application being installed. [default: firefox] 15:34:58 INFO - mkdir: /builds/slave/test/build/application 15:34:58 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'] 15:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:35:16 INFO - Reading from file tmpfile_stdout 15:35:16 INFO - Output received: 15:35:16 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:16 INFO - Running post-action listener: _resource_record_post_action 15:35:16 INFO - [mozharness: 2017-07-24 22:35:16.792288Z] Finished install step (success) 15:35:16 INFO - [mozharness: 2017-07-24 22:35:16.792514Z] Running setup-mitmproxy step. 15:35:16 INFO - Running pre-action listener: _resource_record_pre_action 15:35:16 INFO - Running main action method: setup_mitmproxy 15:35:16 INFO - Skipping: mitmproxy is not required 15:35:16 INFO - Running post-action listener: _resource_record_post_action 15:35:16 INFO - [mozharness: 2017-07-24 22:35:16.793048Z] Finished setup-mitmproxy step (success) 15:35:16 INFO - [mozharness: 2017-07-24 22:35:16.793153Z] Running run-tests step. 15:35:16 INFO - Running pre-action listener: _resource_record_pre_action 15:35:16 INFO - Running pre-action listener: _set_gcov_prefix 15:35:16 INFO - Running main action method: run_tests 15:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:16 INFO - Python 2.7.3 15:35:16 INFO - Return code: 0 15:35:16 INFO - grabbing minidump binary from tooltool 15:35:16 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')]} 15:35:16 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 0x1c0feb0>, '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 0x1c10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c11240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:35:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:35:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:35:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:16 INFO - Return code: 0 15:35:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:16 INFO - ENV: RUST_BACKTRACE is now 1 15:35:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:16 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/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:35:16 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/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:35:16 INFO - Using env: {'DISPLAY': ':0', 15:35:16 INFO - 'HOME': '/home/cltbld', 15:35:16 INFO - 'LANG': 'en_US.UTF-8', 15:35:16 INFO - 'LANGUAGE': 'en_US:en', 15:35:16 INFO - 'LOGNAME': 'cltbld', 15:35:16 INFO - 'MAIL': '/var/mail/cltbld', 15:35:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:16 INFO - 'MOZ_NO_REMOTE': '1', 15:35:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:16 INFO - 'NO_EM_RESTART': '1', 15:35:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:16 INFO - 'PWD': '/builds/slave/test', 15:35:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:16 INFO - 'RUST_BACKTRACE': '1', 15:35:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:35:16 INFO - 'SHELL': '/bin/bash', 15:35:16 INFO - 'SHLVL': '1', 15:35:16 INFO - 'STYLO_FORCE_ENABLED': '1', 15:35:16 INFO - 'TERM': 'linux', 15:35:16 INFO - 'TMOUT': '86400', 15:35:16 INFO - 'USER': 'cltbld', 15:35:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585', 15:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:16 INFO - '_': '/tools/buildbot/bin/python'} 15:35:16 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/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:35:17 INFO - mozversion application_buildid: 20170724215058 15:35:17 INFO - mozversion application_changeset: bf4634a50775537b4e791b6d294a275b83737472 15:35:17 INFO - mozversion application_display_name: Nightly 15:35:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:17 INFO - mozversion application_name: Firefox 15:35:17 INFO - mozversion application_remotingname: firefox 15:35:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:35:17 INFO - mozversion application_vendor: Mozilla 15:35:17 INFO - mozversion application_version: 56.0a1 15:35:17 INFO - mozversion platform_buildid: 20170724215058 15:35:17 INFO - mozversion platform_changeset: bf4634a50775537b4e791b6d294a275b83737472 15:35:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:35:17 INFO - mozversion platform_version: 56.0a1 15:35:17 INFO - using testdate: 1500935717 15:35:17 INFO - actual date: 1500935717 15:35:17 INFO - starting webserver on 'localhost:56656' 15:35:17 INFO - SUITE-START | Running 2 tests 15:35:17 INFO - TEST-START | dromaeo_css 15:35:17 INFO - Initialising browser for dromaeo_css test... 15:35:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56656/getInfo.html -profile /tmp/tmpeTaWlz/profile 15:35:17 INFO - TEST-INFO | started process 7552 (/builds/slave/test/build/application/firefox/firefox http://localhost:56656/getInfo.html) 15:35:23 INFO - TEST-INFO | 7552: exit 0 15:35:23 INFO - Browser initialized. 15:35:23 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:23 INFO - TEST-INFO | started process 7777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTaWlz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:34 INFO - PID 7777 | RSS: Main: 179101696 15:35:34 INFO - PID 7777 | 15:38:34 INFO - PID 7777 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56656/tests/dromaeo/cssquery-ext.html) 15:38:35 INFO - PID 7777 | RSS: Main: 181907456 15:38:35 INFO - PID 7777 | 15:41:37 INFO - PID 7777 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-ext.html (next: http://localhost:56656/tests/dromaeo/cssquery-jquery.html) 15:41:37 INFO - PID 7777 | RSS: Main: 179367936 15:41:37 INFO - PID 7777 | 15:44:39 INFO - PID 7777 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56656/tests/dromaeo/cssquery-mootools.html) 15:44:40 INFO - PID 7777 | RSS: Main: 181092352 15:44:40 INFO - PID 7777 | 15:47:42 INFO - PID 7777 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56656/tests/dromaeo/cssquery-prototype.html) 15:47:42 INFO - PID 7777 | RSS: Main: 179695616 15:47:42 INFO - PID 7777 | 15:50:46 INFO - PID 7777 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56656/tests/dromaeo/cssquery-yui.html) 15:50:47 INFO - PID 7777 | RSS: Main: 180940800 15:50:47 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-yui.html (next: http://localhost:56656/tests/dromaeo/cssquery-dojo.html) 15:53:49 INFO - PID 7777 | RSS: Main: 183275520 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | __start_tp_report 15:53:49 INFO - PID 7777 | _x_x_mozilla_page_load 15:53:49 INFO - PID 7777 | _x_x_mozilla_page_load_details 15:53:49 INFO - PID 7777 | |i|pagename|runs| 15:53:49 INFO - PID 7777 | |0;dojo.html;3093.6596974332833;3112.2530592657754;3124.4844600640895;3148.637906640736;3180.4593219152744;6040.154378387018;6090.969545152279;6135.601185922912;6151.692415379235;6219.595726277788;6030.185924900137;6091.208142941423;6149;6169.321374648796;6170.506359491241;5476.972615136939;5535.640183388067;5608.803691870775;5622.297212848394;5624.015797235488;5631.239782629334;5633.746481408326;5686.431356864301;5702.686352250625;5713.885722285552;5496.615236933416;5572.7770889164585;5580.720963951786;5666.121751128581;5685.829425117253;5423.945760542383;5590;5675.035244008487;5679.517241034517;5685.4883060524335;5543.029969755317;5544.334679838405;5578.665280083208;5606.103023516259;5619.381867994517;5939.584229103964;5962.910556341659;6009.459148676597;6080.422359875804;6109.14471973924;6554.606723596552;6597.736090556372;6650.301718319555;6650.567713098681;6658.9001164982565;6622.801315960481;6627.039079333518;6632.1046658701425;6728.360805723449;6729.5625784323865;6115.785947491817;6225.875482490324;6226.346233645492;6240.7503699852405;6241.9375806241815;6722.596644201363;6759.831004224835;6783.864322713518;6822.590644561342;6854;6286.5599408041;6446.871062578723;6452.225732911987;6532.902006469907;6533.118029066015;6483.675816209171;6488;6568.441682457044;6586.538942274091;6620.668966551653;6333.936660633335;6343.555951083472;6428.5178611604315;6430.099786029959;6433.646149461731;6351.841203969938;6363.681815909186;6404.231492220963;6483.902741458882;6511.958086706104;5246.527812496894;5323.680579165262;5324.92012619811;5335.9466405336225;5344.038073146871;4588.678792484561;4608.6082682971655;4632.328312394684;4633.6524760642415;4638.466576343696;5662.235598194274;5690.886182276331;5761.711914404263;5772.134179872969;5777.480026797609;6403.423691867754;6439.227292724903;6439.774607888701;6440.581362211535;6458.61248325102;5685.857853553694;5686.857828554319;5696.914546281809;5717.342505611825;5732.914006289909;5717.828465146053;5720.856978575569;5801.245838041112;5809.302883653989;5826.329972053183;6193.256809182837;6232.971559692691;6280.717367718555;6293.685315734287;6379.71291291893;6603.141591593062;6655.800325990228;6663.333666633298;6671.432928200963;6676.031975363642;6319.24169099711;6353.96823015882;6397.424231819158;6409.391107844747;6457.903131452938;6305.4009869062365;6367.07677386767;6437.098806167234;6541.443977261986;6550.181227346582;6428.100065990859;6536.738530458919;6542.051402546509;6609.834754131185;6631.104800851823;6288.465480434032;6293.433590976834;6360.204974378203;6386.361363863576;6402.647854367868;6233.812985610439;6259.78090766821;6354.809355719336;6362.45919096882;6370.77702280418;6164.568480206342;6172.753089876354;6185.84535386619;6191.380861913953;6209.782657606962;6306.716197771019;6427.967860160669;6449.774257900951;6506.41442270198;6550.672466376567;6125.387461254018;6220.782272620437;6233.158523599437;6241.095041218907;6326.55714100027 15:53:49 INFO - PID 7777 | |1;ext.html;839.7858546070751;867.4448353054046;876.912308769123;897.0267260022879;1154.5670373609896;31989;32162.839185804067;42369.78815105924;43131.56868431315;43218.783906080505;42240.57759422405;43120.353194702024;43191;43276;43364.56635433645;7576.545407275581;7581.128170260408;7720.884186737176;7758.224177582253;7769.223077692242;7489.325960663539;7688.769336919873;7689;7691.153973062958;7695.192004839495;7673.079230492349;7688.807779805494;7707.653155608011;7724.884126738103;7729.343005844482;7625.618719064052;7626.08486981563;7637.274458926393;7657.770266892002;7686.5772382518935;7585.924140758577;7598.924010759933;7616.124145723202;7618.428617853683;7620.390368770541;38522;38656.61343386558;38832;38948.221035579416;39015.41476877849;3505.5267538882435;3509.491123787062;3540.76984995977;3549.982250088733;3557.7865328080397;31905.202369940704;31925.52111718326;32021.359572808647;32052.83973580117;32135.83932080348;4875.926861097087;4959.603231741452;4972.055309491221;4972.477889821553;5009.373828271466;186308;187593;188058;189042;189587;48231.27653085207;48563.5143648559;48820.26769598459;48821.26768098481;49165.50834491681;50221.49778502241;50340.244896326585;50865.23702144471;50899;51297.743511282206;16439.753403698953;16453.506394808173;16759;16824.57938551546;16833.41083062087;11009.669709908716;11169.44152792357;13707.588772336845;13814.37835297394;13880.305984700724;14858.5542433725;14918.850811491746;14939;14965.92517037408;15102.773458398133;5871.735771890275;5986.49114825236;6021.187139736167;6127.693615319216;6147.538934579924;979.5689896445541;993.9850902236473;1019.8215312320463;1030.685640879524;1044.9111825494765;22677.773222267897;22710.31869043931;22772.658410123862;23454.882725586605;28221.71778282232;1069.2515239332342;1088.2773496786483;1093.557109370706;1094.6606551968914;1110.7556337605713;12515.436805343781;15835.123736770898;16306.429274975319;16437.342506299854;16766.32934682599;234918;237428;237544;237883;238118;57984.13023804646;58230.70884645634;58307;58308.12537811936;58396;1470.8087948566617;1487.0854424528836;1508.6120768892645;1509.8112735908012;1524.4207201263448;26521;27568.44863102767;27596.31009224705;27613.86193069022;27735.58396624012;36044.819775902004;36191;36212.09469763277;36261;36291.45562816507;201848;203405;204020;204806;205100;34694.13264668403;34827.299147088466;35800.8209958959;35830;35831.82084089563;41811.37282940819;43243.56756432395;43758;43951;43974;31099.84450077735;31479;32056.679433206304;32273.51589726203;32597.511037333985;31019.379612408076;31191.220219494695;32004.51993220057;32126;32382.35235295328;35504;35685.46471802873;35867.64132358643;35888.46167307545;36006.279874401844;28992.710072899;29634.851825740734;30645.846770766002;30696;31229.219269517536;21356.633295366282;23106.653400199346;23210.1876434324;23284.417889552897;23579.882100589388 15:53:49 INFO - PID 7777 | |2;jquery.html;568.1165787200904;570.4181734630674;572.5619900775905;572.8281515545336;601.4016054026243;21955.780442195573;22620.88689556554;23030.539389212205;23034.769652303494;23047.654285185734;24837.13070042549;25254;25322.113726019546;25344;25532.87233563834;6637.170353705799;6795.966020169917;6801.6599170041545;6812.284710105442;6819;6074.969625151868;6574.737010519573;6655.534112612119;6716.126903502538;6718.664066796665;6516.413522782948;6519.445847103002;6530.477561795069;6547.9017814732815;6548.410643042125;6549.312322206171;6554.147960765118;6564.081028655992;6565.638889861103;6582.308857569958;6094.055421409645;6115.235595550556;6120.112583675342;6131.233595800525;6140.385961403824;27868.721312786816;28889;29380.26549336262;29548.70451295481;29874.253143671365;1871.4853415310763;1915.6551820672273;1915.817997290255;1916.9424917252366;1920.6446807340687;18800.153993070344;19022.52443688905;19284.517887052796;19286.939218342985;19998.200071997104;2352.541254455382;2375.9881200593886;2393.0786647140976;2426.6047022961866;2434.9513009739885;132288.33855830756;134385.328073359;134507;138536.30731846378;138718;14543.20012399307;14582.41670333196;15086.849131508763;15153.621159471102;15615.531534053769;23264.883675581852;23315.300540983797;23345;23349.88325058364;23387;9730.562124704264;9783.510824458748;9852.408855468551;9926.751831204134;10034.598616055422;8809.603567839462;8811.33914956368;8818.77953051166;8920.197182253629;8949.552522373855;8824.470531768115;9287.349885507949;9491.857622135674;9501.477418742035;9650.179734722627;2649.3906401527756;2700.046397693082;2709.891604335844;2755.5728862026417;2830.589564513134;951.8905325887473;966.9129778319844;992.0426788149471;996.6362277768707;1000.1848493477938;19480.44156467479;19510.90244548768;19532.12105455258;19643;20148.899255503628;975.3952549419264;1038.8182068138046;1050.3487837540622;1058.878229003659;1067.2849191042021;10379.221558383151;10404.231280682303;10530.884970858753;10555.261131720707;10996.450177491093;487819;493300;494987;504357;505869;106653.4667326674;109090;109266.45366773116;110385;111926;1219.634109767084;1241.4413513918591;1278.054239862495;1285.5179307759404;1296.7471343088196;16510.504684859472;17195.312187512358;17441.912790436476;17567.209475573374;17702.734458982868;54286;56146.71926640341;57466.13800793075;58644;59532.40467595268;63469.682651586445;64086;64459.355406445335;64465.67767161134;64693.353066468735;14807.777883331973;14960.775588366401;15060.924695376452;15137.621559461102;15214.315355809236;23336.533269334177;23424.297271081894;23680.05279788858;24137.63793543063;24156.87921560381;18483.260669573065;19208.519787005436;19451.416457506297;19617.117229724983;19637.70543441821;15119.395224190908;15457.768133477783;15942.282597283382;17616.383426580007;17780.644387112443;19333.873273939575;19983.500412489804;19987.900060499604;20016.89991550033;20022.69965950541;14784.260786960824;15052.247387630794;15077.095374277578;15077.924610376878;15104.924475377553;17487.475375738748;18338.81661183371;18987.620247594696;19046.619067618292;19214 15:53:49 INFO - PID 7777 | |3;mootools.html;1310.1287643716928;1380.1029330934891;1402.586237060067;1409.5489443378117;1414.2221778022085;13575.932120339408;14086.929565352159;14147.434102635894;14157.362918668672;14187.290635468236;13970.37133329;14427.783583246233;14449.060811047275;14454.132752034886;14471.92764036181;2577.639130521724;2646.4310173312733;2647.245535022519;2648.986755066222;2649.072824511415;2549.3244290263096;2568.9871550642315;2595.7274486178962;2637.287932258289;2664.2673264852224;2652.5225459417297;2708.0251109600526;2709.509769626707;2709.7425744554234;2714.267147870074;2538.7715105640486;2587.2884956636885;2591.6371707960902;2595.3511622094475;2607.661004069468;2446.376174075617;2449.5713250181325;2478.9836167171375;2534.3664083979006;2543.885525151373;13391.933040334834;13416.329183540882;13496.662583435493;13513.594592162252;13515.324233788271;7327.2306407826945;7504.474686771928;7549.886751698729;7583.241675832428;7603.0876294844975;4760.880977975544;4875.463698993108;4955.801767929279;5018.5232402921665;5022.497750224985;1867.4322806141556;1868.290049781088;1894.0529735132434;1933.1204302042536;1934.864559480837;22385.664215036788;22716.318510444715;22868.542629147323;22992.195273165526;23030.309090727304;6146.262448506208;6374.266959299647;6392.9360706392345;6634.303398143222;6642.236142843635;17710.38013669541;17929.910350448165;17930.103494825205;17940.55148621295;17968.1015949202;7333.816654583571;7546.056742907137;7556;7561.697532098655;7565.130010048915;6696.933030669631;6748.223954245226;6878.174619045646;6935.722571097201;6942.618156001367;5209.426963034063;5385.7576409061685;5387.622866399314;5488.4785945335125;5505.834824955257;1543.9150846703315;1561.2974161627312;1628.6905487957488;1670.8329167083436;1739.4259894234872;876.1501343696605;879.8517934095938;895.1540793949786;924.7872989212384;938.3619138985555;7199.568025918462;8278.751637450887;8520.360972927056;8564.657413703382;8654.567271636393;931.5575101826713;950.273041123541;961.2118063188119;996.476849653923;1024.2267088348399;4959.404871415453;4986.32684587576;5053.191489361684;5078.720670363092;5086.796528138907;18321.3587524436;19208.90395548041;19473.707894381594;19536;19536.413907582795;18634.720479192823;18988.905055474912;19002.42992710221;19008.239670413306;19008.714869276973;10228.335158214692;10689.358638481715;10721.303115297636;10748.623798167027;10882.836757448644;7313.488055836253;7757.1079325878245;7807.843843123219;7860.410469214946;7924.088729796147;15708.92145539265;16135.193240337701;16275.104869232306;16301.266443009856;16591.25339359756;15896.523104306889;16656.666866662355;16667.74998375001;16817.243224055193;17171.570710732332;10207;10396.480175991019;10449.21630877672;10470.214733894836;10483.842742358718;12454.190477618926;12735.172213806072;12766.361681916052;12807.551735689207;12863;10143.239257055602;10504.842427363443;10704.357738535713;10712.678619641423;11082.22424430282;9890.77551339429;10401.167906567305;10454.32046916948;10515.421651809223;10623.734406639896;9132.863007055032;9277.211437027929;9280.58237379306;9302.581383837609;9321.487318197564;6089.421504957022;6314.1160237565855;6505.967470162808;6600.075989361397;6713.227978782307;6884.5180837342905;6967.407770339578;7040.155181378267;7070.646467676698;7102.928970710227 15:53:49 INFO - PID 7777 | |4;prototype.html;491.67303743010876;498.97505124743753;522.5897670328793;525.9868503287418;533.5411546070379;6058.424809549521;6105.664188469644;6132.724027418772;6175.289841668204;6194.442500174983;5804.448577385152;5915.792947246847;6022.578419510636;6031.607945483541;6034.577579569432;4877.146499362615;4879.39007624047;4886.364772579577;4899.191633380506;4937.210046392578;4867.221244600864;4870.220764677652;4899.975500122495;4908.239222920435;4925.138100832358;4702.365180700596;4791.4250289965075;4834.395700537433;4859.489753575876;4879.560839524442;4880.145974454456;4888.902221955576;4908.846421091041;4910.361652985125;4912.287718280847;4340.696151269412;4343.9348409773875;4350.390945267665;4390.956090439118;4413.227685155085;5878.736686375776;5881.85295367615;5906.320773111104;5925.259342582177;5946.286445626509;5586.608937374385;5590.664560126405;5617.831465056055;5626.099824028177;5634.661920284796;6301.590396624205;6359.523035772289;6410.487161027153;6423.903641445382;6426.710798014101;4732.503087175832;4750.691205071659;4759.833405830814;4765.904681906377;4791.305260737208;6683.398494135503;6753.3246675332075;6765.8646827063185;6782.864342713167;6787.389134977876;4919.434265059493;4922.90154196914;4934.445649620358;4939.456659767423;4940.555350018516;4965.75856035991;5007.198848184273;5012.849614511498;5035.255785596859;5044.445111037783;5485.945140548543;5563.276774019351;5602.411746766612;5629.971850140805;5640.915386269209;6353.174087368612;6356.745730170742;6379.489640828722;6459.644719540471;6461.838454038687;1644.7697322374877;1714.2285971312958;1737.1314342828587;1748.239515810601;1748.8688348373669;1138.5502726423183;1167.1246565076192;1175.6825657072543;1213.2780995307778;1220.1337050693928;5581.962583657018;5606.411326810708;5609.971950140305;5614.07015089439;5759.1937128802;6386.029062826272;6435.356464353621;6437.485001199892;6527.314631963671;6535.856225160578;5503.862403439946;5596.188552659842;5637.830865074055;5695.430456954271;5730.512906402919;3443.4146195146886;3448.8792892248653;3518.612952575215;3521.5245941798044;3534.7879127252445;6272.686365681789;6375.234971803413;6383.234011918599;6436.292007879129;6440.227172739301;6680.730661174459;6715.731370745116;6770.69531871067;6771.984202369684;6802.65986700663;6353.396427339396;6368.872622547523;6442.9355706443275;6458.451031662267;6486.383793539606;6409.198850143732;6546.24718157418;6574.572652777554;6578.506612004023;6605.735770569124;6457.741690332334;6483.351664833479;6487.935120648733;6556.377144171296;6585.267114147575;6262.530310226843;6282.717277722605;6299.653519056313;6318.873622527615;6348.809535713936;4892.192788189909;4926.975365123295;4928.852134435972;4938.185199442052;4954.677945933503;6526.24948130971;6578.967105164444;6674.43267322283;6677.899831502628;6698.698558564974;6264.436200741955;6279.152314437492;6382.808515744535;6400.167978162809;6414.166158399565;6348.206474190726;6351.777687780906;6352.237731472253;6352.36476352361;6368.694417644279;6083;6208.813735587759;6212.81361559154;6241.656708881055;6329.6518691470565;6235;6347.71435285404;6355.237371515448;6374.991877558554;6376.776812811715;6165.660888651168;6201.286852012076;6289.465395441439;6312.400321969406;6318.273398559225 15:53:49 INFO - PID 7777 | |5;yui.html;892.4422236102432;920.3695468604006;922.2806211155302;922.8523436250201;934.5327336331832;18035.09824508774;19016.04919754012;19025;19169.1373888175;19202.807971920276;19973.90013049933;21546;21556.8922155389;21655.67516487254;21732.3480295591;1000.3097862474888;1027.691692492253;1029.2229366828035;1029.8661174047363;1031.587365053977;989.4805227255677;990.9900900991006;993.0317940008506;1003.9949800250988;1029.0995379043336;1071.196602548089;1072.587053984214;1073.7584043590168;1073.7798751256014;1074.7581794096343;1060.5280650110703;1065.9093977011964;1065.9200559957994;1068.5351871935734;1068.615298492542;785.9764207073797;786.2923368967918;786.6656670914838;787.4291138924291;787.9716969354989;17614.383496577557;17839.108044597717;17902.373416930346;17936.820631793646;18124.728129078074;20425.69361459579;20609.793902060937;21123.788762112337;21262.468438289012;21346.146154153816;15874.682506349809;16039.35842566296;16078.43725469603;16078.5980350491;16149.111798851058;3496.9650303497147;3520.348735483918;3533.3993221152464;3533.7349698772696;3540.539729835105;120968;124375;125367.3731631336;126144;129046;16000.679986400206;16568.502944911674;16573.83426165747;16607.83392166087;16644.83355166457;28711;30351.848240759096;30408.54387184194;30607;30610.69389306123;7400.851982960311;7544.094708634889;7550.056242969629;7571.886421703679;7582.734604288823;3877.495925529663;3927.253821773854;3941.428492868518;3943.507061617298;3953.7627742335553;4994.70031798086;5164.974175129176;5643.181738647955;5795.971020144872;5814.883702325929;1060.9416482093404;1086.581666058573;1100.6367898593444;1106.2201148190507;1109.8945600168133;622.9781957631461;623.4762799248653;623.5011990407655;646.0632083478974;651.5211319680031;11424.42877856104;12006.936277929502;12115.575954841539;12561.309127997865;13026.41381137851;653.7254353171679;666.6600033982606;682.9419499342612;709.5387997801367;723.10335184371;5320.547753440924;5373.838784836461;5526.778928842801;5701.4298570142655;5709.714514274269;95183;99327.00672993321;100078.49960750295;101801;103389;85727.57136214279;88217.55891220503;88503;88563;88743;73750;76885;78442.2155778435;80613.59693201614;81151.99999999882;10106.845508790717;11027.283226590245;11165.762183119388;11402.94298528502;11523.711907202052;36129.45805812862;36928.26143477062;36940.81529592335;37447.25105497929;37581;61101.38898610957;63197.684011581485;65973.67013164904;66317.33682663305;66931;18201.45395638133;18656.067196640386;18673.253069877595;19060.428187154408;19099.90450047741;19869.900650496656;20581.279655211994;20965;21250.14999400007;21357.893210533846;18321.083945802922;18657;19041.619167616846;19046.333378331692;19237.711434328216;17871.463856084338;17957.820421795615;18317.816821832144;19076.90461547739;19332;18307.176177071797;18640.533986650444;18699.626007480045;18757.249710011445;18877.244910203986;13157.473701051851;13307.26810025458;13779.655508612364;14490.782638260645;14504.564863054125;13104.737905242033;13318.067735258439;13736.313184340943;13973.860261397256;14565.344559494637 15:53:49 INFO - PID 7777 | __end_tp_report 15:53:49 INFO - PID 7777 | __start_cc_report 15:53:49 INFO - PID 7777 | _x_x_mozilla_cycle_collect,363 15:53:49 INFO - PID 7777 | __end_cc_report 15:53:49 INFO - PID 7777 | __startTimestamp1500936829616__endTimestamp 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | ------- Summary: start ------- 15:53:49 INFO - PID 7777 | Number of tests: 6 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | [#0] dojo.html Cycles:165 Average:6029.11 Median:6233.16 stddev:695.76 (11.2%) stddev-sans-first:658.69 15:53:49 INFO - PID 7777 | Values: 3093.7 3112.3 3124.5 3148.6 3180.5 6040.2 6091.0 6135.6 6151.7 6219.6 6030.2 6091.2 6149.0 6169.3 6170.5 5477.0 5535.6 5608.8 5622.3 5624.0 5631.2 5633.7 5686.4 5702.7 5713.9 5496.6 5572.8 5580.7 5666.1 5685.8 5423.9 5590.0 5675.0 5679.5 5685.5 5543.0 5544.3 5578.7 5606.1 5619.4 5939.6 5962.9 6009.5 6080.4 6109.1 6554.6 6597.7 6650.3 6650.6 6658.9 6622.8 6627.0 6632.1 6728.4 6729.6 6115.8 6225.9 6226.3 6240.8 6241.9 6722.6 6759.8 6783.9 6822.6 6854.0 6286.6 6446.9 6452.2 6532.9 6533.1 6483.7 6488.0 6568.4 6586.5 6620.7 6333.9 6343.6 6428.5 6430.1 6433.6 6351.8 6363.7 6404.2 6483.9 6512.0 5246.5 5323.7 5324.9 5335.9 5344.0 4588.7 4608.6 4632.3 4633.7 4638.5 5662.2 5690.9 5761.7 5772.1 5777.5 6403.4 6439.2 6439.8 6440.6 6458.6 5685.9 5686.9 5696.9 5717.3 5732.9 5717.8 5720.9 5801.2 5809.3 5826.3 6193.3 6233.0 6280.7 6293.7 6379.7 6603.1 6655.8 6663.3 6671.4 6676.0 6319.2 6354.0 6397.4 6409.4 6457.9 6305.4 6367.1 6437.1 6541.4 6550.2 6428.1 6536.7 6542.1 6609.8 6631.1 6288.5 6293.4 6360.2 6386.4 6402.6 6233.8 6259.8 6354.8 6362.5 6370.8 6164.6 6172.8 6185.8 6191.4 6209.8 6306.7 6428.0 6449.8 6506.4 6550.7 6125.4 6220.8 6233.2 6241.1 6326.6 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | [#1] ext.html Cycles:180 Average:38205.36 Median:3545.38 stddev:54590.43 (1539.8%) stddev-sans-first:54671.47 15:53:49 INFO - PID 7777 | Values: 839.8 867.4 876.9 897.0 1154.6 31989.0 32162.8 42369.8 43131.6 43218.8 42240.6 43120.4 43191.0 43276.0 43364.6 7576.5 7581.1 7720.9 7758.2 7769.2 7489.3 7688.8 7689.0 7691.2 7695.2 7673.1 7688.8 7707.7 7724.9 7729.3 7625.6 7626.1 7637.3 7657.8 7686.6 7585.9 7598.9 7616.1 7618.4 7620.4 38522.0 38656.6 38832.0 38948.2 39015.4 3505.5 3509.5 3540.8 3550.0 3557.8 31905.2 31925.5 32021.4 32052.8 32135.8 4875.9 4959.6 4972.1 4972.5 5009.4 186308.0 187593.0 188058.0 189042.0 189587.0 48231.3 48563.5 48820.3 48821.3 49165.5 50221.5 50340.2 50865.2 50899.0 51297.7 16439.8 16453.5 16759.0 16824.6 16833.4 11009.7 11169.4 13707.6 13814.4 13880.3 14858.6 14918.9 14939.0 14965.9 15102.8 5871.7 5986.5 6021.2 6127.7 6147.5 979.6 994.0 1019.8 1030.7 1044.9 22677.8 22710.3 22772.7 23454.9 28221.7 1069.3 1088.3 1093.6 1094.7 1110.8 12515.4 15835.1 16306.4 16437.3 16766.3 234918.0 237428.0 237544.0 237883.0 238118.0 57984.1 58230.7 58307.0 58308.1 58396.0 1470.8 1487.1 1508.6 1509.8 1524.4 26521.0 27568.4 27596.3 27613.9 27735.6 36044.8 36191.0 36212.1 36261.0 36291.5 201848.0 203405.0 204020.0 204806.0 205100.0 34694.1 34827.3 35800.8 35830.0 35831.8 41811.4 43243.6 43758.0 43951.0 43974.0 31099.8 31479.0 32056.7 32273.5 32597.5 31019.4 31191.2 32004.5 32126.0 32382.4 35504.0 35685.5 35867.6 35888.5 36006.3 28992.7 29634.9 30645.8 30696.0 31229.2 21356.6 23106.7 23210.2 23284.4 23579.9 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | [#2] jquery.html Cycles:180 Average:34598.96 Median:23368.44 stddev:83376.52 (356.8%) stddev-sans-first:83571.26 15:53:49 INFO - PID 7777 | Values: 568.1 570.4 572.6 572.8 601.4 21955.8 22620.9 23030.5 23034.8 23047.7 24837.1 25254.0 25322.1 25344.0 25532.9 6637.2 6796.0 6801.7 6812.3 6819.0 6075.0 6574.7 6655.5 6716.1 6718.7 6516.4 6519.4 6530.5 6547.9 6548.4 6549.3 6554.1 6564.1 6565.6 6582.3 6094.1 6115.2 6120.1 6131.2 6140.4 27868.7 28889.0 29380.3 29548.7 29874.3 1871.5 1915.7 1915.8 1916.9 1920.6 18800.2 19022.5 19284.5 19286.9 19998.2 2352.5 2376.0 2393.1 2426.6 2435.0 132288.3 134385.3 134507.0 138536.3 138718.0 14543.2 14582.4 15086.8 15153.6 15615.5 23264.9 23315.3 23345.0 23349.9 23387.0 9730.6 9783.5 9852.4 9926.8 10034.6 8809.6 8811.3 8818.8 8920.2 8949.6 8824.5 9287.3 9491.9 9501.5 9650.2 2649.4 2700.0 2709.9 2755.6 2830.6 951.9 966.9 992.0 996.6 1000.2 19480.4 19510.9 19532.1 19643.0 20148.9 975.4 1038.8 1050.3 1058.9 1067.3 10379.2 10404.2 10530.9 10555.3 10996.5 487819.0 493300.0 494987.0 504357.0 505869.0 106653.5 109090.0 109266.5 110385.0 111926.0 1219.6 1241.4 1278.1 1285.5 1296.7 16510.5 17195.3 17441.9 17567.2 17702.7 54286.0 56146.7 57466.1 58644.0 59532.4 63469.7 64086.0 64459.4 64465.7 64693.4 14807.8 14960.8 15060.9 15137.6 15214.3 23336.5 23424.3 23680.1 24137.6 24156.9 18483.3 19208.5 19451.4 19617.1 19637.7 15119.4 15457.8 15942.3 17616.4 17780.6 19333.9 19983.5 19987.9 20016.9 20022.7 14784.3 15052.2 15077.1 15077.9 15104.9 17487.5 18338.8 18987.6 19046.6 19214.0 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | [#3] mootools.html Cycles:180 Average:8624.34 Median:2546.60 stddev:5902.50 (231.8%) stddev-sans-first:5893.48 15:53:49 INFO - PID 7777 | Values: 1310.1 1380.1 1402.6 1409.5 1414.2 13575.9 14086.9 14147.4 14157.4 14187.3 13970.4 14427.8 14449.1 14454.1 14471.9 2577.6 2646.4 2647.2 2649.0 2649.1 2549.3 2569.0 2595.7 2637.3 2664.3 2652.5 2708.0 2709.5 2709.7 2714.3 2538.8 2587.3 2591.6 2595.4 2607.7 2446.4 2449.6 2479.0 2534.4 2543.9 13391.9 13416.3 13496.7 13513.6 13515.3 7327.2 7504.5 7549.9 7583.2 7603.1 4760.9 4875.5 4955.8 5018.5 5022.5 1867.4 1868.3 1894.1 1933.1 1934.9 22385.7 22716.3 22868.5 22992.2 23030.3 6146.3 6374.3 6392.9 6634.3 6642.2 17710.4 17929.9 17930.1 17940.6 17968.1 7333.8 7546.1 7556.0 7561.7 7565.1 6696.9 6748.2 6878.2 6935.7 6942.6 5209.4 5385.8 5387.6 5488.5 5505.8 1543.9 1561.3 1628.7 1670.8 1739.4 876.2 879.9 895.2 924.8 938.4 7199.6 8278.8 8520.4 8564.7 8654.6 931.6 950.3 961.2 996.5 1024.2 4959.4 4986.3 5053.2 5078.7 5086.8 18321.4 19208.9 19473.7 19536.0 19536.4 18634.7 18988.9 19002.4 19008.2 19008.7 10228.3 10689.4 10721.3 10748.6 10882.8 7313.5 7757.1 7807.8 7860.4 7924.1 15708.9 16135.2 16275.1 16301.3 16591.3 15896.5 16656.7 16667.7 16817.2 17171.6 10207.0 10396.5 10449.2 10470.2 10483.8 12454.2 12735.2 12766.4 12807.6 12863.0 10143.2 10504.8 10704.4 10712.7 11082.2 9890.8 10401.2 10454.3 10515.4 10623.7 9132.9 9277.2 9280.6 9302.6 9321.5 6089.4 6314.1 6506.0 6600.1 6713.2 6884.5 6967.4 7040.2 7070.6 7102.9 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | [#4] prototype.html Cycles:180 Average:5387.25 Median:5935.77 stddev:1505.31 (25.4%) stddev-sans-first:1464.00 15:53:49 INFO - PID 7777 | Values: 491.7 499.0 522.6 526.0 533.5 6058.4 6105.7 6132.7 6175.3 6194.4 5804.4 5915.8 6022.6 6031.6 6034.6 4877.1 4879.4 4886.4 4899.2 4937.2 4867.2 4870.2 4900.0 4908.2 4925.1 4702.4 4791.4 4834.4 4859.5 4879.6 4880.1 4888.9 4908.8 4910.4 4912.3 4340.7 4343.9 4350.4 4391.0 4413.2 5878.7 5881.9 5906.3 5925.3 5946.3 5586.6 5590.7 5617.8 5626.1 5634.7 6301.6 6359.5 6410.5 6423.9 6426.7 4732.5 4750.7 4759.8 4765.9 4791.3 6683.4 6753.3 6765.9 6782.9 6787.4 4919.4 4922.9 4934.4 4939.5 4940.6 4965.8 5007.2 5012.8 5035.3 5044.4 5485.9 5563.3 5602.4 5630.0 5640.9 6353.2 6356.7 6379.5 6459.6 6461.8 1644.8 1714.2 1737.1 1748.2 1748.9 1138.6 1167.1 1175.7 1213.3 1220.1 5582.0 5606.4 5610.0 5614.1 5759.2 6386.0 6435.4 6437.5 6527.3 6535.9 5503.9 5596.2 5637.8 5695.4 5730.5 3443.4 3448.9 3518.6 3521.5 3534.8 6272.7 6375.2 6383.2 6436.3 6440.2 6680.7 6715.7 6770.7 6772.0 6802.7 6353.4 6368.9 6442.9 6458.5 6486.4 6409.2 6546.2 6574.6 6578.5 6605.7 6457.7 6483.4 6487.9 6556.4 6585.3 6262.5 6282.7 6299.7 6318.9 6348.8 4892.2 4927.0 4928.9 4938.2 4954.7 6526.2 6579.0 6674.4 6677.9 6698.7 6264.4 6279.2 6382.8 6400.2 6414.2 6348.2 6351.8 6352.2 6352.4 6368.7 6083.0 6208.8 6212.8 6241.7 6329.7 6235.0 6347.7 6355.2 6375.0 6376.8 6165.7 6201.3 6289.5 6312.4 6318.3 15:53:49 INFO - PID 7777 | 15:53:49 INFO - PID 7777 | [#5] yui.html Cycles:180 Average:22648.68 Median:19921.90 stddev:30023.17 (150.7%) stddev-sans-first:30062.94 15:53:49 INFO - PID 7777 | Values: 892.4 920.4 922.3 922.9 934.5 18035.1 19016.0 19025.0 19169.1 19202.8 19973.9 21546.0 21556.9 21655.7 21732.3 1000.3 1027.7 1029.2 1029.9 1031.6 989.5 991.0 993.0 1004.0 1029.1 1071.2 1072.6 1073.8 1073.8 1074.8 1060.5 1065.9 1065.9 1068.5 1068.6 786.0 786.3 786.7 787.4 788.0 17614.4 17839.1 17902.4 17936.8 18124.7 20425.7 20609.8 21123.8 21262.5 21346.1 15874.7 16039.4 16078.4 16078.6 16149.1 3497.0 3520.3 3533.4 3533.7 3540.5 120968.0 124375.0 125367.4 126144.0 129046.0 16000.7 16568.5 16573.8 16607.8 16644.8 28711.0 30351.8 30408.5 30607.0 30610.7 7400.9 7544.1 7550.1 7571.9 7582.7 3877.5 3927.3 3941.4 3943.5 3953.8 4994.7 5165.0 5643.2 5796.0 5814.9 1060.9 1086.6 1100.6 1106.2 1109.9 623.0 623.5 623.5 646.1 651.5 11424.4 12006.9 12115.6 12561.3 13026.4 653.7 666.7 682.9 709.5 723.1 5320.5 5373.8 5526.8 5701.4 5709.7 95183.0 99327.0 100078.5 101801.0 103389.0 85727.6 88217.6 88503.0 88563.0 88743.0 73750.0 76885.0 78442.2 80613.6 81152.0 10106.8 11027.3 11165.8 11402.9 11523.7 36129.5 36928.3 36940.8 37447.3 37581.0 61101.4 63197.7 65973.7 66317.3 66931.0 18201.5 18656.1 18673.3 19060.4 19099.9 19869.9 20581.3 20965.0 21250.1 21357.9 18321.1 18657.0 19041.6 19046.3 19237.7 17871.5 17957.8 18317.8 19076.9 19332.0 18307.2 18640.5 18699.6 18757.2 18877.2 13157.5 13307.3 13779.7 14490.8 14504.6 13104.7 13318.1 13736.3 13973.9 14565.3 15:53:49 INFO - PID 7777 | -------- Summary: end -------- 15:53:49 INFO - PID 7777 | 15:53:50 INFO - TEST-INFO | 7777: exit 0 15:53:50 INFO - TEST-OK | dromaeo_css | took 1113218ms 15:53:50 INFO - TEST-START | kraken 15:53:50 INFO - Initialising browser for kraken test... 15:53:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56656/getInfo.html -profile /tmp/tmpGerYGv/profile 15:53:50 INFO - TEST-INFO | started process 8150 (/builds/slave/test/build/application/firefox/firefox http://localhost:56656/getInfo.html) 15:53:56 INFO - TEST-INFO | 8150: exit 0 15:53:56 INFO - Browser initialized. 15:53:56 INFO - Running cycle 1/1 for kraken test... 15:53:56 INFO - TEST-INFO | started process 8378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGerYGv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:07 INFO - PID 8378 | RSS: Main: 177082368 15:54:07 INFO - PID 8378 | 15:54:10 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:11 INFO - PID 8378 | RSS: Main: 182591488 15:54:11 INFO - PID 8378 | 15:54:13 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-dft) 15:54:14 INFO - PID 8378 | RSS: Main: 184164352 15:54:14 INFO - PID 8378 | 15:54:17 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-fft) 15:54:18 INFO - PID 8378 | RSS: Main: 177975296 15:54:18 INFO - PID 8378 | 15:54:20 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-oscillator) 15:54:21 INFO - PID 8378 | RSS: Main: 178610176 15:54:21 INFO - PID 8378 | 15:54:23 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:23 INFO - PID 8378 | RSS: Main: 179187712 15:54:23 INFO - PID 8378 | 15:54:26 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56656/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:27 INFO - PID 8378 | RSS: Main: 181264384 15:54:27 INFO - PID 8378 | 15:54:31 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56656/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:31 INFO - PID 8378 | RSS: Main: 180760576 15:54:31 INFO - PID 8378 | 15:54:34 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56656/tests/kraken/driver.html?testName=json-parse-financial) 15:54:35 INFO - PID 8378 | RSS: Main: 182583296 15:54:35 INFO - PID 8378 | 15:54:36 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:37 INFO - PID 8378 | RSS: Main: 181760000 15:54:37 INFO - PID 8378 | 15:54:39 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:39 INFO - PID 8378 | RSS: Main: 179576832 15:54:39 INFO - PID 8378 | 15:54:42 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:42 INFO - PID 8378 | RSS: Main: 178982912 15:54:42 INFO - PID 8378 | 15:54:45 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:46 INFO - PID 8378 | RSS: Main: 179466240 15:54:46 INFO - PID 8378 | 15:54:49 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:49 INFO - PID 8378 | RSS: Main: 179138560 15:54:49 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56656/tests/kraken/driver.html?testName=ai-astar) 15:54:51 INFO - PID 8378 | RSS: Main: 181514240 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | __start_tp_report 15:54:51 INFO - PID 8378 | _x_x_mozilla_page_load 15:54:51 INFO - PID 8378 | _x_x_mozilla_page_load_details 15:54:51 INFO - PID 8378 | |i|pagename|runs| 15:54:51 INFO - PID 8378 | |0;ai-astar;106;112;103;110;109;112;111;104;112;113 15:54:51 INFO - PID 8378 | |1;audio-beat-detection;149;122;156;182;121;149;145;120;173;119 15:54:51 INFO - PID 8378 | |2;audio-dft;164;161;162;163;164;162;166;165;168;164 15:54:51 INFO - PID 8378 | |3;audio-fft;78;74;74;174;79;77;76;76;158;77 15:54:51 INFO - PID 8378 | |4;audio-oscillator;82;80;140;80;81;81;126;82;82;131 15:54:51 INFO - PID 8378 | |5;imaging-gaussian-blur;114;115;115;114;114;114;115;114;114;116 15:54:51 INFO - PID 8378 | |6;imaging-darkroom;150;150;151;150;150;150;151;152;151;151 15:54:51 INFO - PID 8378 | |7;imaging-desaturate;95;94;95;95;95;99;95;94;95;95 15:54:51 INFO - PID 8378 | |8;json-parse-financial;56;58;57;57;56;56;63;58;61;56 15:54:51 INFO - PID 8378 | |9;json-stringify-tinderbox;60;55;56;55;54;63;59;54;55;55 15:54:51 INFO - PID 8378 | |10;stanford-crypto-aes;78;78;80;79;77;77;78;77;78;78 15:54:51 INFO - PID 8378 | |11;stanford-crypto-ccm;128;127;127;136;135;124;124;124;129;164 15:54:51 INFO - PID 8378 | |12;stanford-crypto-pbkdf2;184;200;176;177;182;181;192;175;181;184 15:54:51 INFO - PID 8378 | |13;stanford-crypto-sha256-iterative;67;70;67;69;68;69;74;70;72;69 15:54:51 INFO - PID 8378 | __end_tp_report 15:54:51 INFO - PID 8378 | __start_cc_report 15:54:51 INFO - PID 8378 | _x_x_mozilla_cycle_collect,1016 15:54:51 INFO - PID 8378 | __end_cc_report 15:54:51 INFO - PID 8378 | __startTimestamp1500936891952__endTimestamp 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | ------- Summary: start ------- 15:54:51 INFO - PID 8378 | Number of tests: 14 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.50 stddev:3.61 (3.2%) stddev-sans-first:3.64 15:54:51 INFO - PID 8378 | Values: 106.0 112.0 103.0 110.0 109.0 112.0 111.0 104.0 112.0 113.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.00 stddev:22.83 (15.3%) stddev-sans-first:24.14 15:54:51 INFO - PID 8378 | Values: 149.0 122.0 156.0 182.0 121.0 149.0 145.0 120.0 173.0 119.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.08 (1.3%) stddev-sans-first:2.20 15:54:51 INFO - PID 8378 | Values: 164.0 161.0 162.0 163.0 164.0 162.0 166.0 165.0 168.0 164.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:38.01 (49.7%) stddev-sans-first:39.85 15:54:51 INFO - PID 8378 | Values: 78.0 74.0 74.0 174.0 79.0 77.0 76.0 76.0 158.0 77.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:81.00 stddev:24.96 (30.8%) stddev-sans-first:25.92 15:54:51 INFO - PID 8378 | Values: 82.0 80.0 140.0 80.0 81.0 81.0 126.0 82.0 82.0 131.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 15:54:51 INFO - PID 8378 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 116.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 15:54:51 INFO - PID 8378 | Values: 150.0 150.0 151.0 150.0 150.0 150.0 151.0 152.0 151.0 151.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 15:54:51 INFO - PID 8378 | Values: 95.0 94.0 95.0 95.0 95.0 99.0 95.0 94.0 95.0 95.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:2.39 (4.2%) stddev-sans-first:2.45 15:54:51 INFO - PID 8378 | Values: 56.0 58.0 57.0 57.0 56.0 56.0 63.0 58.0 61.0 56.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:55.50 stddev:3.03 (5.5%) stddev-sans-first:2.95 15:54:51 INFO - PID 8378 | Values: 60.0 55.0 56.0 55.0 54.0 63.0 59.0 54.0 55.0 55.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:0.94 (1.2%) stddev-sans-first:1.00 15:54:51 INFO - PID 8378 | Values: 78.0 78.0 80.0 79.0 77.0 77.0 78.0 77.0 78.0 78.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:128.50 stddev:12.09 (9.4%) stddev-sans-first:12.75 15:54:51 INFO - PID 8378 | Values: 128.0 127.0 127.0 136.0 135.0 124.0 124.0 124.0 129.0 164.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:183.00 stddev:7.67 (4.2%) stddev-sans-first:8.13 15:54:51 INFO - PID 8378 | Values: 184.0 200.0 176.0 177.0 182.0 181.0 192.0 175.0 181.0 184.0 15:54:51 INFO - PID 8378 | 15:54:51 INFO - PID 8378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:2.17 (3.1%) stddev-sans-first:2.11 15:54:51 INFO - PID 8378 | Values: 67.0 70.0 67.0 69.0 68.0 69.0 74.0 70.0 72.0 69.0 15:54:51 INFO - PID 8378 | -------- Summary: end -------- 15:54:51 INFO - PID 8378 | 15:54:52 INFO - PID 8378 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:54:52 INFO - TEST-INFO | 8378: exit 0 15:54:52 INFO - TEST-OK | kraken | took 62323ms 15:54:52 INFO - SUITE-END | took 1175s 15:54:53 INFO - Completed test suite (00:19:35) 15:54:53 INFO - javascript benchmark 15:54:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8396.138959730526, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.6596974332833, 3112.2530592657754, 3124.4844600640895, 3148.637906640736, 3180.4593219152744, 6040.154378387018, 6090.969545152279, 6135.601185922912, 6151.692415379235, 6219.595726277788, 6030.185924900137, 6091.208142941423, 6149.0, 6169.321374648796, 6170.506359491241, 5476.972615136939, 5535.640183388067, 5608.803691870775, 5622.297212848394, 5624.015797235488, 5631.239782629334, 5633.746481408326, 5686.431356864301, 5702.686352250625, 5713.885722285552, 5496.615236933416, 5572.7770889164585, 5580.720963951786, 5666.121751128581, 5685.829425117253, 5423.945760542383, 5590.0, 5675.035244008487, 5679.517241034517, 5685.4883060524335, 5543.029969755317, 5544.334679838405, 5578.665280083208, 5606.103023516259, 5619.381867994517, 5939.584229103964, 5962.910556341659, 6009.459148676597, 6080.422359875804, 6109.14471973924, 6554.606723596552, 6597.736090556372, 6650.301718319555, 6650.567713098681, 6658.9001164982565, 6622.801315960481, 6627.039079333518, 6632.1046658701425, 6728.360805723449, 6729.5625784323865, 6115.785947491817, 6225.875482490324, 6226.346233645492, 6240.7503699852405, 6241.9375806241815, 6722.596644201363, 6759.831004224835, 6783.864322713518, 6822.590644561342, 6854.0, 6286.5599408041, 6446.871062578723, 6452.225732911987, 6532.902006469907, 6533.118029066015, 6483.675816209171, 6488.0, 6568.441682457044, 6586.538942274091, 6620.668966551653, 6333.936660633335, 6343.555951083472, 6428.5178611604315, 6430.099786029959, 6433.646149461731, 6351.841203969938, 6363.681815909186, 6404.231492220963, 6483.902741458882, 6511.958086706104, 5246.527812496894, 5323.680579165262, 5324.92012619811, 5335.9466405336225, 5344.038073146871, 4588.678792484561, 4608.6082682971655, 4632.328312394684, 4633.6524760642415, 4638.466576343696, 5662.235598194274, 5690.886182276331, 5761.711914404263, 5772.134179872969, 5777.480026797609, 6403.423691867754, 6439.227292724903, 6439.774607888701, 6440.581362211535, 6458.61248325102, 5685.857853553694, 5686.857828554319, 5696.914546281809, 5717.342505611825, 5732.914006289909, 5717.828465146053, 5720.856978575569, 5801.245838041112, 5809.302883653989, 5826.329972053183, 6193.256809182837, 6232.971559692691, 6280.717367718555, 6293.685315734287, 6379.71291291893, 6603.141591593062, 6655.800325990228, 6663.333666633298, 6671.432928200963, 6676.031975363642, 6319.24169099711, 6353.96823015882, 6397.424231819158, 6409.391107844747, 6457.903131452938, 6305.4009869062365, 6367.07677386767, 6437.098806167234, 6541.443977261986, 6550.181227346582, 6428.100065990859, 6536.738530458919, 6542.051402546509, 6609.834754131185, 6631.104800851823, 6288.465480434032, 6293.433590976834, 6360.204974378203, 6386.361363863576, 6402.647854367868, 6233.812985610439, 6259.78090766821, 6354.809355719336, 6362.45919096882, 6370.77702280418, 6164.568480206342, 6172.753089876354, 6185.84535386619, 6191.380861913953, 6209.782657606962, 6306.716197771019, 6427.967860160669, 6449.774257900951, 6506.41442270198, 6550.672466376567, 6125.387461254018, 6220.782272620437, 6233.158523599437, 6241.095041218907, 6326.55714100027], "value": 5978.240595732159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.7858546070751, 867.4448353054046, 876.912308769123, 897.0267260022879, 1154.5670373609896, 31989.0, 32162.839185804067, 42369.78815105924, 43131.56868431315, 43218.783906080505, 42240.57759422405, 43120.353194702024, 43191.0, 43276.0, 43364.56635433645, 7576.545407275581, 7581.128170260408, 7720.884186737176, 7758.224177582253, 7769.223077692242, 7489.325960663539, 7688.769336919873, 7689.0, 7691.153973062958, 7695.192004839495, 7673.079230492349, 7688.807779805494, 7707.653155608011, 7724.884126738103, 7729.343005844482, 7625.618719064052, 7626.08486981563, 7637.274458926393, 7657.770266892002, 7686.5772382518935, 7585.924140758577, 7598.924010759933, 7616.124145723202, 7618.428617853683, 7620.390368770541, 38522.0, 38656.61343386558, 38832.0, 38948.221035579416, 39015.41476877849, 3505.5267538882435, 3509.491123787062, 3540.76984995977, 3549.982250088733, 3557.7865328080397, 31905.202369940704, 31925.52111718326, 32021.359572808647, 32052.83973580117, 32135.83932080348, 4875.926861097087, 4959.603231741452, 4972.055309491221, 4972.477889821553, 5009.373828271466, 186308.0, 187593.0, 188058.0, 189042.0, 189587.0, 48231.27653085207, 48563.5143648559, 48820.26769598459, 48821.26768098481, 49165.50834491681, 50221.49778502241, 50340.244896326585, 50865.23702144471, 50899.0, 51297.743511282206, 16439.753403698953, 16453.506394808173, 16759.0, 16824.57938551546, 16833.41083062087, 11009.669709908716, 11169.44152792357, 13707.588772336845, 13814.37835297394, 13880.305984700724, 14858.5542433725, 14918.850811491746, 14939.0, 14965.92517037408, 15102.773458398133, 5871.735771890275, 5986.49114825236, 6021.187139736167, 6127.693615319216, 6147.538934579924, 979.5689896445541, 993.9850902236473, 1019.8215312320463, 1030.685640879524, 1044.9111825494765, 22677.773222267897, 22710.31869043931, 22772.658410123862, 23454.882725586605, 28221.71778282232, 1069.2515239332342, 1088.2773496786483, 1093.557109370706, 1094.6606551968914, 1110.7556337605713, 12515.436805343781, 15835.123736770898, 16306.429274975319, 16437.342506299854, 16766.32934682599, 234918.0, 237428.0, 237544.0, 237883.0, 238118.0, 57984.13023804646, 58230.70884645634, 58307.0, 58308.12537811936, 58396.0, 1470.8087948566617, 1487.0854424528836, 1508.6120768892645, 1509.8112735908012, 1524.4207201263448, 26521.0, 27568.44863102767, 27596.31009224705, 27613.86193069022, 27735.58396624012, 36044.819775902004, 36191.0, 36212.09469763277, 36261.0, 36291.45562816507, 201848.0, 203405.0, 204020.0, 204806.0, 205100.0, 34694.13264668403, 34827.299147088466, 35800.8209958959, 35830.0, 35831.82084089563, 41811.37282940819, 43243.56756432395, 43758.0, 43951.0, 43974.0, 31099.84450077735, 31479.0, 32056.679433206304, 32273.51589726203, 32597.511037333985, 31019.379612408076, 31191.220219494695, 32004.51993220057, 32126.0, 32382.35235295328, 35504.0, 35685.46471802873, 35867.64132358643, 35888.46167307545, 36006.279874401844, 28992.710072899, 29634.851825740734, 30645.846770766002, 30696.0, 31229.219269517536, 21356.633295366282, 23106.653400199346, 23210.1876434324, 23284.417889552897, 23579.882100589388], "value": 17466.66273464879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1165787200904, 570.4181734630674, 572.5619900775905, 572.8281515545336, 601.4016054026243, 21955.780442195573, 22620.88689556554, 23030.539389212205, 23034.769652303494, 23047.654285185734, 24837.13070042549, 25254.0, 25322.113726019546, 25344.0, 25532.87233563834, 6637.170353705799, 6795.966020169917, 6801.6599170041545, 6812.284710105442, 6819.0, 6074.969625151868, 6574.737010519573, 6655.534112612119, 6716.126903502538, 6718.664066796665, 6516.413522782948, 6519.445847103002, 6530.477561795069, 6547.9017814732815, 6548.410643042125, 6549.312322206171, 6554.147960765118, 6564.081028655992, 6565.638889861103, 6582.308857569958, 6094.055421409645, 6115.235595550556, 6120.112583675342, 6131.233595800525, 6140.385961403824, 27868.721312786816, 28889.0, 29380.26549336262, 29548.70451295481, 29874.253143671365, 1871.4853415310763, 1915.6551820672273, 1915.817997290255, 1916.9424917252366, 1920.6446807340687, 18800.153993070344, 19022.52443688905, 19284.517887052796, 19286.939218342985, 19998.200071997104, 2352.541254455382, 2375.9881200593886, 2393.0786647140976, 2426.6047022961866, 2434.9513009739885, 132288.33855830756, 134385.328073359, 134507.0, 138536.30731846378, 138718.0, 14543.20012399307, 14582.41670333196, 15086.849131508763, 15153.621159471102, 15615.531534053769, 23264.883675581852, 23315.300540983797, 23345.0, 23349.88325058364, 23387.0, 9730.562124704264, 9783.510824458748, 9852.408855468551, 9926.751831204134, 10034.598616055422, 8809.603567839462, 8811.33914956368, 8818.77953051166, 8920.197182253629, 8949.552522373855, 8824.470531768115, 9287.349885507949, 9491.857622135674, 9501.477418742035, 9650.179734722627, 2649.3906401527756, 2700.046397693082, 2709.891604335844, 2755.5728862026417, 2830.589564513134, 951.8905325887473, 966.9129778319844, 992.0426788149471, 996.6362277768707, 1000.1848493477938, 19480.44156467479, 19510.90244548768, 19532.12105455258, 19643.0, 20148.899255503628, 975.3952549419264, 1038.8182068138046, 1050.3487837540622, 1058.878229003659, 1067.2849191042021, 10379.221558383151, 10404.231280682303, 10530.884970858753, 10555.261131720707, 10996.450177491093, 487819.0, 493300.0, 494987.0, 504357.0, 505869.0, 106653.4667326674, 109090.0, 109266.45366773116, 110385.0, 111926.0, 1219.634109767084, 1241.4413513918591, 1278.054239862495, 1285.5179307759404, 1296.7471343088196, 16510.504684859472, 17195.312187512358, 17441.912790436476, 17567.209475573374, 17702.734458982868, 54286.0, 56146.71926640341, 57466.13800793075, 58644.0, 59532.40467595268, 63469.682651586445, 64086.0, 64459.355406445335, 64465.67767161134, 64693.353066468735, 14807.777883331973, 14960.775588366401, 15060.924695376452, 15137.621559461102, 15214.315355809236, 23336.533269334177, 23424.297271081894, 23680.05279788858, 24137.63793543063, 24156.87921560381, 18483.260669573065, 19208.519787005436, 19451.416457506297, 19617.117229724983, 19637.70543441821, 15119.395224190908, 15457.768133477783, 15942.282597283382, 17616.383426580007, 17780.644387112443, 19333.873273939575, 19983.500412489804, 19987.900060499604, 20016.89991550033, 20022.69965950541, 14784.260786960824, 15052.247387630794, 15077.095374277578, 15077.924610376878, 15104.924475377553, 17487.475375738748, 18338.81661183371, 18987.620247594696, 19046.619067618292, 19214.0], "value": 11950.779821036565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.1287643716928, 1380.1029330934891, 1402.586237060067, 1409.5489443378117, 1414.2221778022085, 13575.932120339408, 14086.929565352159, 14147.434102635894, 14157.362918668672, 14187.290635468236, 13970.37133329, 14427.783583246233, 14449.060811047275, 14454.132752034886, 14471.92764036181, 2577.639130521724, 2646.4310173312733, 2647.245535022519, 2648.986755066222, 2649.072824511415, 2549.3244290263096, 2568.9871550642315, 2595.7274486178962, 2637.287932258289, 2664.2673264852224, 2652.5225459417297, 2708.0251109600526, 2709.509769626707, 2709.7425744554234, 2714.267147870074, 2538.7715105640486, 2587.2884956636885, 2591.6371707960902, 2595.3511622094475, 2607.661004069468, 2446.376174075617, 2449.5713250181325, 2478.9836167171375, 2534.3664083979006, 2543.885525151373, 13391.933040334834, 13416.329183540882, 13496.662583435493, 13513.594592162252, 13515.324233788271, 7327.2306407826945, 7504.474686771928, 7549.886751698729, 7583.241675832428, 7603.0876294844975, 4760.880977975544, 4875.463698993108, 4955.801767929279, 5018.5232402921665, 5022.497750224985, 1867.4322806141556, 1868.290049781088, 1894.0529735132434, 1933.1204302042536, 1934.864559480837, 22385.664215036788, 22716.318510444715, 22868.542629147323, 22992.195273165526, 23030.309090727304, 6146.262448506208, 6374.266959299647, 6392.9360706392345, 6634.303398143222, 6642.236142843635, 17710.38013669541, 17929.910350448165, 17930.103494825205, 17940.55148621295, 17968.1015949202, 7333.816654583571, 7546.056742907137, 7556.0, 7561.697532098655, 7565.130010048915, 6696.933030669631, 6748.223954245226, 6878.174619045646, 6935.722571097201, 6942.618156001367, 5209.426963034063, 5385.7576409061685, 5387.622866399314, 5488.4785945335125, 5505.834824955257, 1543.9150846703315, 1561.2974161627312, 1628.6905487957488, 1670.8329167083436, 1739.4259894234872, 876.1501343696605, 879.8517934095938, 895.1540793949786, 924.7872989212384, 938.3619138985555, 7199.568025918462, 8278.751637450887, 8520.360972927056, 8564.657413703382, 8654.567271636393, 931.5575101826713, 950.273041123541, 961.2118063188119, 996.476849653923, 1024.2267088348399, 4959.404871415453, 4986.32684587576, 5053.191489361684, 5078.720670363092, 5086.796528138907, 18321.3587524436, 19208.90395548041, 19473.707894381594, 19536.0, 19536.413907582795, 18634.720479192823, 18988.905055474912, 19002.42992710221, 19008.239670413306, 19008.714869276973, 10228.335158214692, 10689.358638481715, 10721.303115297636, 10748.623798167027, 10882.836757448644, 7313.488055836253, 7757.1079325878245, 7807.843843123219, 7860.410469214946, 7924.088729796147, 15708.92145539265, 16135.193240337701, 16275.104869232306, 16301.266443009856, 16591.25339359756, 15896.523104306889, 16656.666866662355, 16667.74998375001, 16817.243224055193, 17171.570710732332, 10207.0, 10396.480175991019, 10449.21630877672, 10470.214733894836, 10483.842742358718, 12454.190477618926, 12735.172213806072, 12766.361681916052, 12807.551735689207, 12863.0, 10143.239257055602, 10504.842427363443, 10704.357738535713, 10712.678619641423, 11082.22424430282, 9890.77551339429, 10401.167906567305, 10454.32046916948, 10515.421651809223, 10623.734406639896, 9132.863007055032, 9277.211437027929, 9280.58237379306, 9302.581383837609, 9321.487318197564, 6089.421504957022, 6314.1160237565855, 6505.967470162808, 6600.075989361397, 6713.227978782307, 6884.5180837342905, 6967.407770339578, 7040.155181378267, 7070.646467676698, 7102.928970710227], "value": 6320.818864916606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.67303743010876, 498.97505124743753, 522.5897670328793, 525.9868503287418, 533.5411546070379, 6058.424809549521, 6105.664188469644, 6132.724027418772, 6175.289841668204, 6194.442500174983, 5804.448577385152, 5915.792947246847, 6022.578419510636, 6031.607945483541, 6034.577579569432, 4877.146499362615, 4879.39007624047, 4886.364772579577, 4899.191633380506, 4937.210046392578, 4867.221244600864, 4870.220764677652, 4899.975500122495, 4908.239222920435, 4925.138100832358, 4702.365180700596, 4791.4250289965075, 4834.395700537433, 4859.489753575876, 4879.560839524442, 4880.145974454456, 4888.902221955576, 4908.846421091041, 4910.361652985125, 4912.287718280847, 4340.696151269412, 4343.9348409773875, 4350.390945267665, 4390.956090439118, 4413.227685155085, 5878.736686375776, 5881.85295367615, 5906.320773111104, 5925.259342582177, 5946.286445626509, 5586.608937374385, 5590.664560126405, 5617.831465056055, 5626.099824028177, 5634.661920284796, 6301.590396624205, 6359.523035772289, 6410.487161027153, 6423.903641445382, 6426.710798014101, 4732.503087175832, 4750.691205071659, 4759.833405830814, 4765.904681906377, 4791.305260737208, 6683.398494135503, 6753.3246675332075, 6765.8646827063185, 6782.864342713167, 6787.389134977876, 4919.434265059493, 4922.90154196914, 4934.445649620358, 4939.456659767423, 4940.555350018516, 4965.75856035991, 5007.198848184273, 5012.849614511498, 5035.255785596859, 5044.445111037783, 5485.945140548543, 5563.276774019351, 5602.411746766612, 5629.971850140805, 5640.915386269209, 6353.174087368612, 6356.745730170742, 6379.489640828722, 6459.644719540471, 6461.838454038687, 1644.7697322374877, 1714.2285971312958, 1737.1314342828587, 1748.239515810601, 1748.8688348373669, 1138.5502726423183, 1167.1246565076192, 1175.6825657072543, 1213.2780995307778, 1220.1337050693928, 5581.962583657018, 5606.411326810708, 5609.971950140305, 5614.07015089439, 5759.1937128802, 6386.029062826272, 6435.356464353621, 6437.485001199892, 6527.314631963671, 6535.856225160578, 5503.862403439946, 5596.188552659842, 5637.830865074055, 5695.430456954271, 5730.512906402919, 3443.4146195146886, 3448.8792892248653, 3518.612952575215, 3521.5245941798044, 3534.7879127252445, 6272.686365681789, 6375.234971803413, 6383.234011918599, 6436.292007879129, 6440.227172739301, 6680.730661174459, 6715.731370745116, 6770.69531871067, 6771.984202369684, 6802.65986700663, 6353.396427339396, 6368.872622547523, 6442.9355706443275, 6458.451031662267, 6486.383793539606, 6409.198850143732, 6546.24718157418, 6574.572652777554, 6578.506612004023, 6605.735770569124, 6457.741690332334, 6483.351664833479, 6487.935120648733, 6556.377144171296, 6585.267114147575, 6262.530310226843, 6282.717277722605, 6299.653519056313, 6318.873622527615, 6348.809535713936, 4892.192788189909, 4926.975365123295, 4928.852134435972, 4938.185199442052, 4954.677945933503, 6526.24948130971, 6578.967105164444, 6674.43267322283, 6677.899831502628, 6698.698558564974, 6264.436200741955, 6279.152314437492, 6382.808515744535, 6400.167978162809, 6414.166158399565, 6348.206474190726, 6351.777687780906, 6352.237731472253, 6352.36476352361, 6368.694417644279, 6083.0, 6208.813735587759, 6212.81361559154, 6241.656708881055, 6329.6518691470565, 6235.0, 6347.71435285404, 6355.237371515448, 6374.991877558554, 6376.776812811715, 6165.660888651168, 6201.286852012076, 6289.465395441439, 6312.400321969406, 6318.273398559225], "value": 4946.02281519853, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.4422236102432, 920.3695468604006, 922.2806211155302, 922.8523436250201, 934.5327336331832, 18035.09824508774, 19016.04919754012, 19025.0, 19169.1373888175, 19202.807971920276, 19973.90013049933, 21546.0, 21556.8922155389, 21655.67516487254, 21732.3480295591, 1000.3097862474888, 1027.691692492253, 1029.2229366828035, 1029.8661174047363, 1031.587365053977, 989.4805227255677, 990.9900900991006, 993.0317940008506, 1003.9949800250988, 1029.0995379043336, 1071.196602548089, 1072.587053984214, 1073.7584043590168, 1073.7798751256014, 1074.7581794096343, 1060.5280650110703, 1065.9093977011964, 1065.9200559957994, 1068.5351871935734, 1068.615298492542, 785.9764207073797, 786.2923368967918, 786.6656670914838, 787.4291138924291, 787.9716969354989, 17614.383496577557, 17839.108044597717, 17902.373416930346, 17936.820631793646, 18124.728129078074, 20425.69361459579, 20609.793902060937, 21123.788762112337, 21262.468438289012, 21346.146154153816, 15874.682506349809, 16039.35842566296, 16078.43725469603, 16078.5980350491, 16149.111798851058, 3496.9650303497147, 3520.348735483918, 3533.3993221152464, 3533.7349698772696, 3540.539729835105, 120968.0, 124375.0, 125367.3731631336, 126144.0, 129046.0, 16000.679986400206, 16568.502944911674, 16573.83426165747, 16607.83392166087, 16644.83355166457, 28711.0, 30351.848240759096, 30408.54387184194, 30607.0, 30610.69389306123, 7400.851982960311, 7544.094708634889, 7550.056242969629, 7571.886421703679, 7582.734604288823, 3877.495925529663, 3927.253821773854, 3941.428492868518, 3943.507061617298, 3953.7627742335553, 4994.70031798086, 5164.974175129176, 5643.181738647955, 5795.971020144872, 5814.883702325929, 1060.9416482093404, 1086.581666058573, 1100.6367898593444, 1106.2201148190507, 1109.8945600168133, 622.9781957631461, 623.4762799248653, 623.5011990407655, 646.0632083478974, 651.5211319680031, 11424.42877856104, 12006.936277929502, 12115.575954841539, 12561.309127997865, 13026.41381137851, 653.7254353171679, 666.6600033982606, 682.9419499342612, 709.5387997801367, 723.10335184371, 5320.547753440924, 5373.838784836461, 5526.778928842801, 5701.4298570142655, 5709.714514274269, 95183.0, 99327.00672993321, 100078.49960750295, 101801.0, 103389.0, 85727.57136214279, 88217.55891220503, 88503.0, 88563.0, 88743.0, 73750.0, 76885.0, 78442.2155778435, 80613.59693201614, 81151.99999999882, 10106.845508790717, 11027.283226590245, 11165.762183119388, 11402.94298528502, 11523.711907202052, 36129.45805812862, 36928.26143477062, 36940.81529592335, 37447.25105497929, 37581.0, 61101.38898610957, 63197.684011581485, 65973.67013164904, 66317.33682663305, 66931.0, 18201.45395638133, 18656.067196640386, 18673.253069877595, 19060.428187154408, 19099.90450047741, 19869.900650496656, 20581.279655211994, 20965.0, 21250.14999400007, 21357.893210533846, 18321.083945802922, 18657.0, 19041.619167616846, 19046.333378331692, 19237.711434328216, 17871.463856084338, 17957.820421795615, 18317.816821832144, 19076.90461547739, 19332.0, 18307.176177071797, 18640.533986650444, 18699.626007480045, 18757.249710011445, 18877.244910203986, 13157.473701051851, 13307.26810025458, 13779.655508612364, 14490.782638260645, 14504.564863054125, 13104.737905242033, 13318.067735258439, 13736.313184340943, 13973.860261397256, 14565.344559494637], "value": 8979.254992140415, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 103.0, 110.0, 109.0, 112.0, 111.0, 104.0, 112.0, 113.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 156.0, 182.0, 121.0, 149.0, 145.0, 120.0, 173.0, 119.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 163.0, 164.0, 162.0, 166.0, 165.0, 168.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 174.0, 79.0, 77.0, 76.0, 76.0, 158.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 140.0, 80.0, 81.0, 81.0, 126.0, 82.0, 82.0, 131.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 150.0, 150.0, 151.0, 152.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 99.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 57.0, 56.0, 56.0, 63.0, 58.0, 61.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 56.0, 55.0, 54.0, 63.0, 59.0, 54.0, 55.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 79.0, 77.0, 77.0, 78.0, 77.0, 78.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 127.0, 136.0, 135.0, 124.0, 124.0, 124.0, 129.0, 164.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 200.0, 176.0, 177.0, 182.0, 181.0, 192.0, 175.0, 181.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 69.0, 68.0, 69.0, 74.0, 70.0, 72.0, 69.0], "value": 69.5, "unit": "score"}]}]} 15:54:53 INFO - Return code: 0 15:54:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:53 INFO - # TBPL SUCCESS # 15:54:53 INFO - Running post-action listener: _package_coverage_data 15:54:53 INFO - Running post-action listener: _resource_record_post_action 15:54:53 INFO - [mozharness: 2017-07-24 22:54:53.242818Z] Finished run-tests step (success) 15:54:53 INFO - Running post-run listener: _resource_record_post_run 15:54:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439918592; Read time: 12; Write time: 319232 15:54:53 INFO - TinderboxPrint: CPU usage
13.2% 15:54:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:54:53 INFO - TinderboxPrint: I/O write bytes / time
439,918,592 / 319,232 15:54:53 INFO - TinderboxPrint: CPU idle
8,265.6 (86.8%) 15:54:53 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 15:54:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109346816; Read time: 0; Write time: 67592 15:54:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:54:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 328802304; Read time: 0; Write time: 251364 15:54:53 INFO - Running post-run listener: _upload_blobber_files 15:54:53 INFO - Blob upload gear active. 15:54:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:53 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 15:54:53 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'] 15:54:53 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 15:54:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:54:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:54:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:55 INFO - (blobuploader) - INFO - Done attempting. 15:54:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:54:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:54:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:56 INFO - (blobuploader) - INFO - Done attempting. 15:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:59 INFO - (blobuploader) - INFO - Done attempting. 15:54:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:54:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:00 INFO - (blobuploader) - INFO - Done attempting. 15:55:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:55:00 INFO - Return code: 0 15:55:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:55:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:55:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d1f8dcde0f518e79cf10f2b80570c81c2f1f606bb04b804059fcf824189a09457ff848998a5c9af16fcd7575f1248d28a1a7e4b4ebae2fa25941c219481008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab76a82ae4699f540cb109e537a47b59816ffa987b9a35159d45ac54d8f68e268a471e79dfb0b5925f67341f80a1dc6a2b72cf270ec2fe3fb63ac52b78bbc91", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee06bf27c92e26f6296b207fb3fa80922f22be71be6fe581e7afc01ad7126d496eacf8e65b2b03e58a02eb4d54c4709b084d7b6da498f6512561a61a156ccd98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97f73cda5fcdf65a3695e2c627a84387a17d48875cf378cbb86c5b856768407795778f51506f0f658a62c90fa4e77c04f3550c08eeb16b15d3eda0a31fe9ce4d"} 15:55:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:55:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:55:00 INFO - Contents: 15:55:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d1f8dcde0f518e79cf10f2b80570c81c2f1f606bb04b804059fcf824189a09457ff848998a5c9af16fcd7575f1248d28a1a7e4b4ebae2fa25941c219481008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab76a82ae4699f540cb109e537a47b59816ffa987b9a35159d45ac54d8f68e268a471e79dfb0b5925f67341f80a1dc6a2b72cf270ec2fe3fb63ac52b78bbc91", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee06bf27c92e26f6296b207fb3fa80922f22be71be6fe581e7afc01ad7126d496eacf8e65b2b03e58a02eb4d54c4709b084d7b6da498f6512561a61a156ccd98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97f73cda5fcdf65a3695e2c627a84387a17d48875cf378cbb86c5b856768407795778f51506f0f658a62c90fa4e77c04f3550c08eeb16b15d3eda0a31fe9ce4d"} 15:55:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:55:00 INFO - Copying logs to upload dir... 15:55:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:55:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.586655 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-24 15:55:00.114164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 15:55:00.116486) ========= 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=337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d1f8dcde0f518e79cf10f2b80570c81c2f1f606bb04b804059fcf824189a09457ff848998a5c9af16fcd7575f1248d28a1a7e4b4ebae2fa25941c219481008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab76a82ae4699f540cb109e537a47b59816ffa987b9a35159d45ac54d8f68e268a471e79dfb0b5925f67341f80a1dc6a2b72cf270ec2fe3fb63ac52b78bbc91", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee06bf27c92e26f6296b207fb3fa80922f22be71be6fe581e7afc01ad7126d496eacf8e65b2b03e58a02eb4d54c4709b084d7b6da498f6512561a61a156ccd98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97f73cda5fcdf65a3695e2c627a84387a17d48875cf378cbb86c5b856768407795778f51506f0f658a62c90fa4e77c04f3550c08eeb16b15d3eda0a31fe9ce4d"} build_url:https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2d1f8dcde0f518e79cf10f2b80570c81c2f1f606bb04b804059fcf824189a09457ff848998a5c9af16fcd7575f1248d28a1a7e4b4ebae2fa25941c219481008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab76a82ae4699f540cb109e537a47b59816ffa987b9a35159d45ac54d8f68e268a471e79dfb0b5925f67341f80a1dc6a2b72cf270ec2fe3fb63ac52b78bbc91", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee06bf27c92e26f6296b207fb3fa80922f22be71be6fe581e7afc01ad7126d496eacf8e65b2b03e58a02eb4d54c4709b084d7b6da498f6512561a61a156ccd98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97f73cda5fcdf65a3695e2c627a84387a17d48875cf378cbb86c5b856768407795778f51506f0f658a62c90fa4e77c04f3550c08eeb16b15d3eda0a31fe9ce4d"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 15:55:00.201547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:55:00.201871) ========= 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=337fe3f4b1febe37b85fccc40000019e-1500935398.267424-307546585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:55:00.235083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 15:55:00.235423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 15:55:00.247250) ========= ========= Total master_lag: 0.29 =========