builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1502670270.64 results: success (0) revision: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.635660) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.636100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.636384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.652976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.653278) ========= 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=781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-13 17:24:31-- 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% 214M=0s 2017-08-13 17:24:31 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.793273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.793587) ========= 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=781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017397 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:30.844854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-13 17:24:30.845185) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b --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 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b --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=781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-13 17:24:31,724 truncating revision to first 12 chars 2017-08-13 17:24:31,724 Setting DEBUG logging. 2017-08-13 17:24:31,724 attempt 1/10 2017-08-13 17:24:31,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3bfcbdf5c6c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-13 17:24:32,993 unpacking tar archive at: mozilla-central-3bfcbdf5c6c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.623959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-13 17:24:32.488682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:32.489029) ========= script_repo_revision: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:32.489417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:32.489704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:32.517710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-13 17:24:32.518034) ========= /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=781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:33 INFO - MultiFileLogger online at 20170813 17:24:33 in /builds/slave/test 17:24:33 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 17:24:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:33 INFO - {'append_to_log': False, 17:24:33 INFO - 'base_work_dir': '/builds/slave/test', 17:24:33 INFO - 'blob_upload_branch': 'Firefox', 17:24:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:33 INFO - 'branch': 'Firefox', 17:24:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:33 INFO - 'code_coverage': False, 17:24:33 INFO - 'config_files': ('talos/linux_config.py',), 17:24:33 INFO - 'default_actions': ('clobber', 17:24:33 INFO - 'read-buildbot-config', 17:24:33 INFO - 'download-and-extract', 17:24:33 INFO - 'populate-webroot', 17:24:33 INFO - 'create-virtualenv', 17:24:33 INFO - 'install', 17:24:33 INFO - 'setup-mitmproxy', 17:24:33 INFO - 'run-tests'), 17:24:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:33 INFO - 'disable_ccov_upload': False, 17:24:33 INFO - 'download_minidump_stackwalk': True, 17:24:33 INFO - 'download_symbols': 'ondemand', 17:24:33 INFO - 'enable_stylo': False, 17:24:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:33 INFO - 'gecko_profile': False, 17:24:33 INFO - 'gecko_profile_interval': 0, 17:24:33 INFO - 'installer_path': 'installer.exe', 17:24:33 INFO - 'log_level': 'info', 17:24:33 INFO - 'log_name': 'talos', 17:24:33 INFO - 'log_to_console': True, 17:24:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:33 INFO - 'opt_config_files': (), 17:24:33 INFO - 'pip_index': False, 17:24:33 INFO - 'suite': 'dromaeojs-e10s', 17:24:33 INFO - 'system_bits': '32', 17:24:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:33 INFO - 'title': 'talos-linux64-ix-080', 17:24:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:33 INFO - 'use_talos_json': True, 17:24:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:33 INFO - 'work_dir': 'build'} 17:24:33 INFO - [mozharness: 2017-08-14 00:24:33.503625Z] Running clobber step. 17:24:33 INFO - Running pre-action listener: _resource_record_pre_action 17:24:33 INFO - Running main action method: clobber 17:24:33 INFO - rmtree: /builds/slave/test/build 17:24:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:34 INFO - Running post-action listener: _resource_record_post_action 17:24:34 INFO - [mozharness: 2017-08-14 00:24:34.537965Z] Finished clobber step (success) 17:24:34 INFO - [mozharness: 2017-08-14 00:24:34.538070Z] Running read-buildbot-config step. 17:24:34 INFO - Running pre-action listener: _resource_record_pre_action 17:24:34 INFO - Running main action method: read_buildbot_config 17:24:34 INFO - Using buildbot properties: 17:24:34 INFO - { 17:24:34 INFO - "project": "", 17:24:34 INFO - "product": "firefox", 17:24:34 INFO - "who": "archaeopteryx@coole-files.de", 17:24:34 INFO - "installer_path": "public/build/target.tar.bz2", 17:24:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:24:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:24:34 INFO - "stage_platform": "linux64-stylo", 17:24:34 INFO - "basedir": "/builds/slave/test", 17:24:34 INFO - "buildnumber": 81, 17:24:34 INFO - "platform": "ubuntu64_hw_stylo", 17:24:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:24:34 INFO - "slavebuilddir": "test", 17:24:34 INFO - "taskId": "Kbc9dAw0RleT_sWDEaNSaQ", 17:24:34 INFO - "branch": "mozilla-central", 17:24:34 INFO - "script_repo_revision": "production", 17:24:34 INFO - "revision": "3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b", 17:24:34 INFO - "slavename": "talos-linux64-ix-080", 17:24:34 INFO - "repo_path": "mozilla-central" 17:24:34 INFO - } 17:24:34 INFO - Finding installer, test and symbols from parent task. 17:24:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kbc9dAw0RleT_sWDEaNSaQ'}, attempt #1 17:24:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kbc9dAw0RleT_sWDEaNSaQ'}, attempt #1 17:24:35 INFO - Task dependencies: LPo6Qd1VS8e-mSF6G8gTBA 17:24:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA'}, attempt #1 17:24:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:24:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json 17:24:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip 17:24:35 INFO - Running post-action listener: _resource_record_post_action 17:24:35 INFO - [mozharness: 2017-08-14 00:24:35.886895Z] Finished read-buildbot-config step (success) 17:24:35 INFO - [mozharness: 2017-08-14 00:24:35.887117Z] Running download-and-extract step. 17:24:35 INFO - Running pre-action listener: _resource_record_pre_action 17:24:35 INFO - Running main action method: download_and_extract 17:24:35 INFO - mkdir: /builds/slave/test/build/tests 17:24:35 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')]} 17:24:35 INFO - trying https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json 17:24:35 INFO - Downloading https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:24:36 INFO - Downloaded 989 bytes. 17:24:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:24:36 INFO - Using the following test package requirements: 17:24:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:24:36 INFO - u'common': [u'target.common.tests.zip'], 17:24:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:24:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:24:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:24:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:24:36 INFO - u'mozbase': [u'target.common.tests.zip'], 17:24:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:24:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:24:36 INFO - u'web-platform': [u'target.common.tests.zip', 17:24:36 INFO - u'target.web-platform.tests.tar.gz'], 17:24:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:24:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:24:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip 17:24:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:24:36 INFO - Fetch https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip into memory 17:24:37 INFO - Content-Length response header: 54034620 17:24:37 INFO - Bytes received: 54034620 17:24:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:24:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip 17:24:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:24:48 INFO - Fetch https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip into memory 17:24:49 INFO - Content-Length response header: 54034620 17:24:49 INFO - Bytes received: 54034620 17:25:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.talos.tests.zip 17:25:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:25:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.talos.tests.zip into memory 17:25:02 INFO - Content-Length response header: 14496050 17:25:02 INFO - Bytes received: 14496050 17:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:02 INFO - trying https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:25:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:25:03 INFO - Downloaded 61718089 bytes. 17:25:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:25:03 INFO - mkdir: /builds/slave/test/properties 17:25:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:25:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:25:03 INFO - Contents: 17:25:03 INFO - build_url:https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:25:03 INFO - Running post-action listener: _resource_record_post_action 17:25:03 INFO - Running post-action listener: set_extra_try_arguments 17:25:03 INFO - [mozharness: 2017-08-14 00:25:03.802938Z] Finished download-and-extract step (success) 17:25:03 INFO - [mozharness: 2017-08-14 00:25:03.803036Z] Running populate-webroot step. 17:25:03 INFO - Running pre-action listener: _resource_record_pre_action 17:25:03 INFO - Running main action method: populate_webroot 17:25:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:25:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:25:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:25:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:25:03 INFO - 'tests': ['damp', 'tps']}, 17:25:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:25:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:25:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:25:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:25:03 INFO - 'ts_paint', 17:25:03 INFO - 'tpaint', 17:25:03 INFO - 'sessionrestore', 17:25:03 INFO - 'sessionrestore_many_windows', 17:25:03 INFO - 'sessionrestore_no_auto_restore', 17:25:03 INFO - 'tabpaint']}, 17:25:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:25:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:25:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:25:03 INFO - 'tsvgr_opacity', 17:25:03 INFO - 'tart', 17:25:03 INFO - 'tscrollx', 17:25:03 INFO - 'tsvg_static']}, 17:25:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:25:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:25:03 INFO - 'talos_options': ['--mitmproxy', 17:25:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:25:03 INFO - '--firstNonBlankPaint'], 17:25:03 INFO - 'tests': ['tp6_google', 17:25:03 INFO - 'tp6_youtube', 17:25:03 INFO - 'tp6_amazon', 17:25:03 INFO - 'tp6_facebook']}, 17:25:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:25:03 INFO - 'talos_options': ['--stylo', 17:25:03 INFO - '--mitmproxy', 17:25:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:25:03 INFO - '--firstNonBlankPaint'], 17:25:03 INFO - 'tests': ['tp6_google', 17:25:03 INFO - 'tp6_youtube', 17:25:03 INFO - 'tp6_amazon', 17:25:03 INFO - 'tp6_facebook']}, 17:25:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:25:03 INFO - 'talos_options': ['--stylo', 17:25:03 INFO - '--stylo-threads=1', 17:25:03 INFO - '--mitmproxy', 17:25:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:25:03 INFO - '--firstNonBlankPaint'], 17:25:03 INFO - 'tests': ['tp6_google', 17:25:03 INFO - 'tp6_youtube', 17:25:03 INFO - 'tp6_amazon', 17:25:03 INFO - 'tp6_facebook']}, 17:25:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:25:03 INFO - 'talos_options': ['--xperf_path', 17:25:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:03 INFO - 'tests': ['tp5n']}}} 17:25:03 INFO - Running post-action listener: _resource_record_post_action 17:25:03 INFO - [mozharness: 2017-08-14 00:25:03.811546Z] Finished populate-webroot step (success) 17:25:03 INFO - [mozharness: 2017-08-14 00:25:03.811637Z] Running create-virtualenv step. 17:25:03 INFO - Running pre-action listener: _resource_record_pre_action 17:25:03 INFO - Running main action method: create_virtualenv 17:25:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:25:03 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 17:25:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:25:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:25:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:03 INFO - Using real prefix '/usr' 17:25:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:25:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:06 INFO - Installing pip.................done. 17:25:06 INFO - Return code: 0 17:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:25:06 INFO - Reading from file tmpfile_stdout 17:25:06 INFO - Output received: 17:25:06 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) 17:25:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:25:06 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')]} 17:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:06 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')]} 17:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:06 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:06 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 17:25:06 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 17:25:06 INFO - Using env: {'DISPLAY': ':0', 17:25:06 INFO - 'HOME': '/home/cltbld', 17:25:06 INFO - 'LANG': 'en_US.UTF-8', 17:25:06 INFO - 'LANGUAGE': 'en_US:en', 17:25:06 INFO - 'LOGNAME': 'cltbld', 17:25:06 INFO - 'MAIL': '/var/mail/cltbld', 17:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:06 INFO - 'MOZ_NO_REMOTE': '1', 17:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:06 INFO - 'NO_EM_RESTART': '1', 17:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:06 INFO - 'PWD': '/builds/slave/test', 17:25:06 INFO - 'SHELL': '/bin/bash', 17:25:06 INFO - 'SHLVL': '1', 17:25:06 INFO - 'TERM': 'linux', 17:25:06 INFO - 'TMOUT': '86400', 17:25:06 INFO - 'USER': 'cltbld', 17:25:06 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:06 INFO - '_': '/tools/buildbot/bin/python'} 17:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:06 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 17:25:06 INFO - Cleaning up... 17:25:06 INFO - Return code: 0 17:25:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:25:06 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')]} 17:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:06 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')]} 17:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:06 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:06 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 17:25:06 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 17:25:06 INFO - Using env: {'DISPLAY': ':0', 17:25:06 INFO - 'HOME': '/home/cltbld', 17:25:06 INFO - 'LANG': 'en_US.UTF-8', 17:25:06 INFO - 'LANGUAGE': 'en_US:en', 17:25:06 INFO - 'LOGNAME': 'cltbld', 17:25:06 INFO - 'MAIL': '/var/mail/cltbld', 17:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:06 INFO - 'MOZ_NO_REMOTE': '1', 17:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:06 INFO - 'NO_EM_RESTART': '1', 17:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:06 INFO - 'PWD': '/builds/slave/test', 17:25:06 INFO - 'SHELL': '/bin/bash', 17:25:06 INFO - 'SHLVL': '1', 17:25:06 INFO - 'TERM': 'linux', 17:25:06 INFO - 'TMOUT': '86400', 17:25:06 INFO - 'USER': 'cltbld', 17:25:06 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:06 INFO - '_': '/tools/buildbot/bin/python'} 17:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:07 INFO - Downloading/unpacking psutil>=3.1.1 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:08 INFO - Installing collected packages: psutil 17:25:08 INFO - Running setup.py install for psutil 17:25:08 INFO - building 'psutil._psutil_linux' extension 17:25:08 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 17:25:08 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 17:25:08 INFO - building 'psutil._psutil_posix' extension 17:25:08 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 17:25:08 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 17:25:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:08 INFO - Successfully installed psutil 17:25:08 INFO - Cleaning up... 17:25:08 INFO - Return code: 0 17:25:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:25:08 INFO - Using env: {'DISPLAY': ':0', 17:25:08 INFO - 'HOME': '/home/cltbld', 17:25:08 INFO - 'LANG': 'en_US.UTF-8', 17:25:08 INFO - 'LANGUAGE': 'en_US:en', 17:25:08 INFO - 'LOGNAME': 'cltbld', 17:25:08 INFO - 'MAIL': '/var/mail/cltbld', 17:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:08 INFO - 'MOZ_NO_REMOTE': '1', 17:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:08 INFO - 'NO_EM_RESTART': '1', 17:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:08 INFO - 'PWD': '/builds/slave/test', 17:25:08 INFO - 'SHELL': '/bin/bash', 17:25:08 INFO - 'SHLVL': '1', 17:25:08 INFO - 'TERM': 'linux', 17:25:08 INFO - 'TMOUT': '86400', 17:25:08 INFO - 'USER': 'cltbld', 17:25:08 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:08 INFO - '_': '/tools/buildbot/bin/python'} 17:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:25:09 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 17:25:09 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 17:25:09 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 17:25:09 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 17:25:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:25:10 INFO - Installing collected packages: mozsystemmonitor 17:25:10 INFO - Running setup.py install for mozsystemmonitor 17:25:10 INFO - Successfully installed mozsystemmonitor 17:25:10 INFO - Cleaning up... 17:25:10 INFO - Return code: 0 17:25:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:25:10 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')]} 17:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:10 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')]} 17:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:10 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:10 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 17:25:10 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 17:25:10 INFO - Using env: {'DISPLAY': ':0', 17:25:10 INFO - 'HOME': '/home/cltbld', 17:25:10 INFO - 'LANG': 'en_US.UTF-8', 17:25:10 INFO - 'LANGUAGE': 'en_US:en', 17:25:10 INFO - 'LOGNAME': 'cltbld', 17:25:10 INFO - 'MAIL': '/var/mail/cltbld', 17:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:10 INFO - 'MOZ_NO_REMOTE': '1', 17:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:10 INFO - 'NO_EM_RESTART': '1', 17:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:10 INFO - 'PWD': '/builds/slave/test', 17:25:10 INFO - 'SHELL': '/bin/bash', 17:25:10 INFO - 'SHLVL': '1', 17:25:10 INFO - 'TERM': 'linux', 17:25:10 INFO - 'TMOUT': '86400', 17:25:10 INFO - 'USER': 'cltbld', 17:25:10 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:10 INFO - '_': '/tools/buildbot/bin/python'} 17:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:10 INFO - Downloading/unpacking jsonschema==2.5.1 17:25:10 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 17:25:10 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 17:25:10 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 17:25:10 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 17:25:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:12 INFO - warning: no files found matching '*.txt' 17:25:12 INFO - no previously-included directories found matching 'build' 17:25:12 INFO - no previously-included directories found matching 'dist' 17:25:12 INFO - no previously-included directories found matching '.git*' 17:25:12 INFO - Installing collected packages: jsonschema, functools32 17:25:12 INFO - Running setup.py install for functools32 17:25:12 INFO - warning: no files found matching '*.txt' 17:25:12 INFO - no previously-included directories found matching 'build' 17:25:12 INFO - no previously-included directories found matching 'dist' 17:25:12 INFO - no previously-included directories found matching '.git*' 17:25:12 INFO - Successfully installed jsonschema functools32 17:25:12 INFO - Cleaning up... 17:25:12 INFO - Return code: 0 17:25:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:25:12 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')]} 17:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:12 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')]} 17:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:12 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:12 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 17:25:12 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 17:25:12 INFO - Using env: {'DISPLAY': ':0', 17:25:12 INFO - 'HOME': '/home/cltbld', 17:25:12 INFO - 'LANG': 'en_US.UTF-8', 17:25:12 INFO - 'LANGUAGE': 'en_US:en', 17:25:12 INFO - 'LOGNAME': 'cltbld', 17:25:12 INFO - 'MAIL': '/var/mail/cltbld', 17:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:12 INFO - 'MOZ_NO_REMOTE': '1', 17:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:12 INFO - 'NO_EM_RESTART': '1', 17:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:12 INFO - 'PWD': '/builds/slave/test', 17:25:12 INFO - 'SHELL': '/bin/bash', 17:25:12 INFO - 'SHLVL': '1', 17:25:12 INFO - 'TERM': 'linux', 17:25:12 INFO - 'TMOUT': '86400', 17:25:12 INFO - 'USER': 'cltbld', 17:25:12 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:12 INFO - '_': '/tools/buildbot/bin/python'} 17:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:25:12 INFO - Cleaning up... 17:25:12 INFO - Return code: 0 17:25:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:25:12 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')]} 17:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:12 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')]} 17:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:12 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:12 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 17:25:12 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 17:25:12 INFO - Using env: {'DISPLAY': ':0', 17:25:12 INFO - 'HOME': '/home/cltbld', 17:25:12 INFO - 'LANG': 'en_US.UTF-8', 17:25:12 INFO - 'LANGUAGE': 'en_US:en', 17:25:12 INFO - 'LOGNAME': 'cltbld', 17:25:12 INFO - 'MAIL': '/var/mail/cltbld', 17:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:12 INFO - 'MOZ_NO_REMOTE': '1', 17:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:12 INFO - 'NO_EM_RESTART': '1', 17:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:12 INFO - 'PWD': '/builds/slave/test', 17:25:12 INFO - 'SHELL': '/bin/bash', 17:25:12 INFO - 'SHLVL': '1', 17:25:12 INFO - 'TERM': 'linux', 17:25:12 INFO - 'TMOUT': '86400', 17:25:12 INFO - 'USER': 'cltbld', 17:25:12 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:12 INFO - '_': '/tools/buildbot/bin/python'} 17:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 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 17:25:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:14 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 17:25:14 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 17:25:14 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 17:25:14 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 17:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:25:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:14 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 17:25:14 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 17:25:14 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 17:25:14 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 17:25:14 INFO - Downloading docopt-0.6.1.tar.gz 17:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:14 INFO - Running setup.py install for blobuploader 17:25:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:25:14 INFO - Running setup.py install for requests 17:25:15 INFO - Running setup.py install for docopt 17:25:15 INFO - Successfully installed blobuploader requests docopt 17:25:15 INFO - Cleaning up... 17:25:15 INFO - Return code: 0 17:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:15 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')]} 17:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:15 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')]} 17:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:15 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:15 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 17:25:15 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 17:25:15 INFO - Using env: {'DISPLAY': ':0', 17:25:15 INFO - 'HOME': '/home/cltbld', 17:25:15 INFO - 'LANG': 'en_US.UTF-8', 17:25:15 INFO - 'LANGUAGE': 'en_US:en', 17:25:15 INFO - 'LOGNAME': 'cltbld', 17:25:15 INFO - 'MAIL': '/var/mail/cltbld', 17:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:15 INFO - 'MOZ_NO_REMOTE': '1', 17:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:15 INFO - 'NO_EM_RESTART': '1', 17:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:15 INFO - 'PWD': '/builds/slave/test', 17:25:15 INFO - 'SHELL': '/bin/bash', 17:25:15 INFO - 'SHLVL': '1', 17:25:15 INFO - 'TERM': 'linux', 17:25:15 INFO - 'TMOUT': '86400', 17:25:15 INFO - 'USER': 'cltbld', 17:25:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:15 INFO - '_': '/tools/buildbot/bin/python'} 17:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:15 INFO - Running setup.py (path:/tmp/pip-xAq7YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:15 INFO - Running setup.py (path:/tmp/pip-6l_8bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:15 INFO - Running setup.py (path:/tmp/pip-XAxBTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:15 INFO - Running setup.py (path:/tmp/pip-9kI00R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:15 INFO - Running setup.py (path:/tmp/pip-7ojbds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:15 INFO - Running setup.py (path:/tmp/pip-jI0HaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:15 INFO - Running setup.py (path:/tmp/pip-Oe9YZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:16 INFO - Running setup.py (path:/tmp/pip-O7iIyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:16 INFO - Running setup.py (path:/tmp/pip-0p7TTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:16 INFO - Running setup.py (path:/tmp/pip-XWCivA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:16 INFO - Running setup.py (path:/tmp/pip-XQVKFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:16 INFO - Running setup.py (path:/tmp/pip-8JyTGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:16 INFO - Running setup.py (path:/tmp/pip-X7dx5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:16 INFO - Running setup.py (path:/tmp/pip-OiM2jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:16 INFO - Running setup.py (path:/tmp/pip-dKRbLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:16 INFO - Running setup.py (path:/tmp/pip-cECtbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:16 INFO - Running setup.py (path:/tmp/pip-VQJv7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:16 INFO - Running setup.py install for manifestparser 17:25:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:16 INFO - Running setup.py install for mozcrash 17:25:16 INFO - Running setup.py install for mozdebug 17:25:17 INFO - Running setup.py install for mozdevice 17:25:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Running setup.py install for mozfile 17:25:17 INFO - Running setup.py install for mozhttpd 17:25:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Running setup.py install for mozinfo 17:25:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Running setup.py install for mozInstall 17:25:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Running setup.py install for mozleak 17:25:17 INFO - Running setup.py install for mozlog 17:25:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Running setup.py install for moznetwork 17:25:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:17 INFO - Running setup.py install for mozprocess 17:25:17 INFO - Running setup.py install for mozprofile 17:25:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:18 INFO - Running setup.py install for mozrunner 17:25:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:18 INFO - Running setup.py install for mozscreenshot 17:25:18 INFO - Running setup.py install for moztest 17:25:18 INFO - Running setup.py install for mozversion 17:25:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:18 INFO - Cleaning up... 17:25:18 INFO - Return code: 0 17:25:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:18 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')]} 17:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:18 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')]} 17:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:18 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:18 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 17:25:18 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 17:25:18 INFO - Using env: {'DISPLAY': ':0', 17:25:18 INFO - 'HOME': '/home/cltbld', 17:25:18 INFO - 'LANG': 'en_US.UTF-8', 17:25:18 INFO - 'LANGUAGE': 'en_US:en', 17:25:18 INFO - 'LOGNAME': 'cltbld', 17:25:18 INFO - 'MAIL': '/var/mail/cltbld', 17:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:18 INFO - 'MOZ_NO_REMOTE': '1', 17:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:18 INFO - 'NO_EM_RESTART': '1', 17:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:18 INFO - 'PWD': '/builds/slave/test', 17:25:18 INFO - 'SHELL': '/bin/bash', 17:25:18 INFO - 'SHLVL': '1', 17:25:18 INFO - 'TERM': 'linux', 17:25:18 INFO - 'TMOUT': '86400', 17:25:18 INFO - 'USER': 'cltbld', 17:25:18 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:18 INFO - '_': '/tools/buildbot/bin/python'} 17:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:18 INFO - Running setup.py (path:/tmp/pip-_dwG1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:18 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)) 17:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:18 INFO - Running setup.py (path:/tmp/pip-pEf4Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:18 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)) 17:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:18 INFO - Running setup.py (path:/tmp/pip-O9hEU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:18 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)) 17:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:19 INFO - Running setup.py (path:/tmp/pip-LEaVDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:19 INFO - Running setup.py (path:/tmp/pip-VQ8ASF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:19 INFO - Running setup.py (path:/tmp/pip-VDC5Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:19 INFO - Running setup.py (path:/tmp/pip-hDHSLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:19 INFO - Running setup.py (path:/tmp/pip-fz_eUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:19 INFO - Running setup.py (path:/tmp/pip-BGcCmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:19 INFO - Running setup.py (path:/tmp/pip-nj5Aht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:19 INFO - Running setup.py (path:/tmp/pip-5CJgGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:19 INFO - Running setup.py (path:/tmp/pip-tQJOfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:19 INFO - Running setup.py (path:/tmp/pip-0TdYTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:19 INFO - Running setup.py (path:/tmp/pip-7Oq6Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:19 INFO - Running setup.py (path:/tmp/pip-uzMpdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:19 INFO - Running setup.py (path:/tmp/pip-2lGWw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:19 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)) 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:19 INFO - Running setup.py (path:/tmp/pip-NBLauM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:20 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)) 17:25:20 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)) 17:25:20 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)) 17:25:20 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)) 17:25:20 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)) 17:25:20 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)) 17:25:20 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)) 17:25:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:20 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 17:25:20 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 17:25:20 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 17:25:20 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 17:25:21 INFO - Downloading blessings-1.6.tar.gz 17:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:21 INFO - Installing collected packages: blessings 17:25:21 INFO - Running setup.py install for blessings 17:25:21 INFO - Successfully installed blessings 17:25:21 INFO - Cleaning up... 17:25:21 INFO - Return code: 0 17:25:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:21 INFO - Reading from file tmpfile_stdout 17:25:21 INFO - Current package versions: 17:25:21 INFO - argparse == 1.2.1 17:25:21 INFO - blessings == 1.6 17:25:21 INFO - blobuploader == 1.2.4 17:25:21 INFO - docopt == 0.6.1 17:25:21 INFO - functools32 == 3.2.3-2 17:25:21 INFO - jsonschema == 2.5.1 17:25:21 INFO - manifestparser == 1.1 17:25:21 INFO - mozInstall == 1.13 17:25:21 INFO - mozcrash == 1.0 17:25:21 INFO - mozdebug == 0.1 17:25:21 INFO - mozdevice == 0.51 17:25:21 INFO - mozfile == 1.2 17:25:21 INFO - mozhttpd == 0.7 17:25:21 INFO - mozinfo == 0.10 17:25:21 INFO - mozleak == 0.1 17:25:21 INFO - mozlog == 3.5 17:25:21 INFO - moznetwork == 0.27 17:25:21 INFO - mozprocess == 0.25 17:25:21 INFO - mozprofile == 0.28 17:25:21 INFO - mozrunner == 6.13 17:25:21 INFO - mozscreenshot == 0.1 17:25:21 INFO - mozsystemmonitor == 0.3 17:25:21 INFO - moztest == 0.8 17:25:21 INFO - mozversion == 1.4 17:25:21 INFO - psutil == 3.1.1 17:25:21 INFO - requests == 1.2.3 17:25:21 INFO - wsgiref == 0.1.2 17:25:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:21 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')]} 17:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:21 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')]} 17:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:21 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:21 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 17:25:21 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 17:25:21 INFO - Using env: {'DISPLAY': ':0', 17:25:21 INFO - 'HOME': '/home/cltbld', 17:25:21 INFO - 'LANG': 'en_US.UTF-8', 17:25:21 INFO - 'LANGUAGE': 'en_US:en', 17:25:21 INFO - 'LOGNAME': 'cltbld', 17:25:21 INFO - 'MAIL': '/var/mail/cltbld', 17:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:21 INFO - 'MOZ_NO_REMOTE': '1', 17:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:21 INFO - 'NO_EM_RESTART': '1', 17:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:21 INFO - 'PWD': '/builds/slave/test', 17:25:21 INFO - 'SHELL': '/bin/bash', 17:25:21 INFO - 'SHLVL': '1', 17:25:21 INFO - 'TERM': 'linux', 17:25:21 INFO - 'TMOUT': '86400', 17:25:21 INFO - 'USER': 'cltbld', 17:25:21 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:21 INFO - '_': '/tools/buildbot/bin/python'} 17:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 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)) 17:25:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:25:21 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 17:25:21 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 17:25:21 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 17:25:21 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 17:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:25:22 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)) 17:25:22 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)) 17:25:22 INFO - Installing collected packages: simplejson 17:25:22 INFO - Running setup.py install for simplejson 17:25:23 INFO - building 'simplejson._speedups' extension 17:25:23 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 17:25:23 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 17:25:23 INFO - Successfully installed simplejson 17:25:23 INFO - Cleaning up... 17:25:24 INFO - Return code: 0 17:25:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25:24 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')]} 17:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:24 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')]} 17:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:24 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 0x1f301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229db20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, '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': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', '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 17:25:24 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 17:25:24 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 17:25:24 INFO - Using env: {'DISPLAY': ':0', 17:25:24 INFO - 'HOME': '/home/cltbld', 17:25:24 INFO - 'LANG': 'en_US.UTF-8', 17:25:24 INFO - 'LANGUAGE': 'en_US:en', 17:25:24 INFO - 'LOGNAME': 'cltbld', 17:25:24 INFO - 'MAIL': '/var/mail/cltbld', 17:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:24 INFO - 'MOZ_NO_REMOTE': '1', 17:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:24 INFO - 'NO_EM_RESTART': '1', 17:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:24 INFO - 'PWD': '/builds/slave/test', 17:25:24 INFO - 'SHELL': '/bin/bash', 17:25:24 INFO - 'SHLVL': '1', 17:25:24 INFO - 'TERM': 'linux', 17:25:24 INFO - 'TMOUT': '86400', 17:25:24 INFO - 'USER': 'cltbld', 17:25:24 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:24 INFO - '_': '/tools/buildbot/bin/python'} 17:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:25:24 INFO - Cleaning up... 17:25:24 INFO - Return code: 0 17:25:24 INFO - Running post-action listener: _resource_record_post_action 17:25:24 INFO - Running post-action listener: _start_resource_monitoring 17:25:24 INFO - Starting resource monitoring. 17:25:24 INFO - [mozharness: 2017-08-14 00:25:24.279794Z] Finished create-virtualenv step (success) 17:25:24 INFO - [mozharness: 2017-08-14 00:25:24.280314Z] Running install step. 17:25:24 INFO - Running pre-action listener: _resource_record_pre_action 17:25:24 INFO - Running main action method: install 17:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:24 INFO - Reading from file tmpfile_stdout 17:25:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:24 INFO - Reading from file tmpfile_stdout 17:25:24 INFO - Output received: 17:25:24 INFO - Usage: mozinstall [options] installer 17:25:24 INFO - Options: 17:25:24 INFO - -h, --help show this help message and exit 17:25:24 INFO - -d DEST, --destination=DEST 17:25:24 INFO - Directory to install application into. [default: 17:25:24 INFO - "/builds/slave/test"] 17:25:24 INFO - --app=APP Application being installed. [default: firefox] 17:25:24 INFO - mkdir: /builds/slave/test/build/application 17:25:24 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'] 17:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:25:42 INFO - Reading from file tmpfile_stdout 17:25:42 INFO - Output received: 17:25:42 INFO - /builds/slave/test/build/application/firefox/firefox 17:25:42 INFO - Running post-action listener: _resource_record_post_action 17:25:42 INFO - [mozharness: 2017-08-14 00:25:42.652493Z] Finished install step (success) 17:25:42 INFO - [mozharness: 2017-08-14 00:25:42.652840Z] Running setup-mitmproxy step. 17:25:42 INFO - Running pre-action listener: _resource_record_pre_action 17:25:42 INFO - Running main action method: setup_mitmproxy 17:25:42 INFO - Skipping: mitmproxy is not required 17:25:42 INFO - Running post-action listener: _resource_record_post_action 17:25:42 INFO - [mozharness: 2017-08-14 00:25:42.654484Z] Finished setup-mitmproxy step (success) 17:25:42 INFO - [mozharness: 2017-08-14 00:25:42.654909Z] Running run-tests step. 17:25:42 INFO - Running pre-action listener: _resource_record_pre_action 17:25:42 INFO - Running pre-action listener: _set_gcov_prefix 17:25:42 INFO - Running main action method: run_tests 17:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:42 INFO - Python 2.7.3 17:25:42 INFO - Return code: 0 17:25:42 INFO - grabbing minidump binary from tooltool 17:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:42 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 0x22a0f00>, '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 0x229bba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:42 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 17:25:42 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 17:25:42 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 17:25:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:42 INFO - Return code: 0 17:25:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:25:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:42 INFO - ENV: RUST_BACKTRACE is now full 17:25:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:25:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:42 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/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 17:25:42 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/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 17:25:42 INFO - Using env: {'DISPLAY': ':0', 17:25:42 INFO - 'HOME': '/home/cltbld', 17:25:42 INFO - 'LANG': 'en_US.UTF-8', 17:25:42 INFO - 'LANGUAGE': 'en_US:en', 17:25:42 INFO - 'LOGNAME': 'cltbld', 17:25:42 INFO - 'MAIL': '/var/mail/cltbld', 17:25:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:42 INFO - 'MOZ_NO_REMOTE': '1', 17:25:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:42 INFO - 'NO_EM_RESTART': '1', 17:25:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:42 INFO - 'PWD': '/builds/slave/test', 17:25:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:42 INFO - 'RUST_BACKTRACE': 'full', 17:25:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:25:42 INFO - 'SHELL': '/bin/bash', 17:25:42 INFO - 'SHLVL': '1', 17:25:42 INFO - 'STYLO_FORCE_ENABLED': '1', 17:25:42 INFO - 'TERM': 'linux', 17:25:42 INFO - 'TMOUT': '86400', 17:25:42 INFO - 'USER': 'cltbld', 17:25:42 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164', 17:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:42 INFO - '_': '/tools/buildbot/bin/python'} 17:25:42 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/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 17:25:43 INFO - mozversion application_buildid: 20170813233048 17:25:43 INFO - mozversion application_changeset: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b 17:25:43 INFO - mozversion application_display_name: Nightly 17:25:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:43 INFO - mozversion application_name: Firefox 17:25:43 INFO - mozversion application_remotingname: firefox 17:25:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:25:43 INFO - mozversion application_vendor: Mozilla 17:25:43 INFO - mozversion application_version: 57.0a1 17:25:43 INFO - mozversion platform_buildid: 20170813233048 17:25:43 INFO - mozversion platform_changeset: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b 17:25:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:25:43 INFO - mozversion platform_version: 57.0a1 17:25:43 INFO - using testdate: 1502670343 17:25:43 INFO - actual date: 1502670343 17:25:43 INFO - starting webserver on 'localhost:46926' 17:25:43 INFO - SUITE-START | Running 2 tests 17:25:43 INFO - TEST-START | dromaeo_css 17:25:43 INFO - Initialising browser for dromaeo_css test... 17:25:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46926/getInfo.html -profile /tmp/tmp0dv1K3/profile 17:25:43 INFO - TEST-INFO | started process 26788 (/builds/slave/test/build/application/firefox/firefox http://localhost:46926/getInfo.html) 17:25:49 INFO - TEST-INFO | 26788: exit 0 17:25:49 INFO - Browser initialized. 17:25:49 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:49 INFO - TEST-INFO | started process 27025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0dv1K3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:50 INFO - PID 27025 | 17:25:50 INFO - PID 27025 | (/builds/slave/test/build/application/firefox/firefox:27079): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:25:50 INFO - PID 27025 | 17:26:00 INFO - PID 27025 | RSS: Main: 171044864 17:26:00 INFO - PID 27025 | 17:29:00 INFO - PID 27025 | Cycle 1(1): loaded http://localhost:46926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46926/tests/dromaeo/cssquery-ext.html) 17:29:01 INFO - PID 27025 | RSS: Main: 175783936 17:29:01 INFO - PID 27025 | 17:32:03 INFO - PID 27025 | Cycle 1(1): loaded http://localhost:46926/tests/dromaeo/cssquery-ext.html (next: http://localhost:46926/tests/dromaeo/cssquery-jquery.html) 17:32:03 INFO - PID 27025 | RSS: Main: 173498368 17:32:03 INFO - PID 27025 | 17:35:05 INFO - PID 27025 | Cycle 1(1): loaded http://localhost:46926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46926/tests/dromaeo/cssquery-mootools.html) 17:35:06 INFO - PID 27025 | RSS: Main: 175472640 17:35:06 INFO - PID 27025 | 17:38:07 INFO - PID 27025 | Cycle 1(1): loaded http://localhost:46926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46926/tests/dromaeo/cssquery-prototype.html) 17:38:08 INFO - PID 27025 | RSS: Main: 173563904 17:38:08 INFO - PID 27025 | 17:41:12 INFO - PID 27025 | Cycle 1(1): loaded http://localhost:46926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46926/tests/dromaeo/cssquery-yui.html) 17:41:13 INFO - PID 27025 | RSS: Main: 175063040 17:41:13 INFO - PID 27025 | 17:44:14 INFO - PID 27025 | Cycle 1(1): loaded http://localhost:46926/tests/dromaeo/cssquery-yui.html (next: http://localhost:46926/tests/dromaeo/cssquery-dojo.html) 17:44:15 INFO - PID 27025 | RSS: Main: 177152000 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | __start_tp_report 17:44:15 INFO - PID 27025 | _x_x_mozilla_page_load 17:44:15 INFO - PID 27025 | _x_x_mozilla_page_load_details 17:44:15 INFO - PID 27025 | |i|pagename|runs| 17:44:15 INFO - PID 27025 | |0;dojo.html;3145.3709258148374;3161.193895556633;3171.682831716828;3179.8092114473125;3211.341674956634;6176.752929882805;6308.842278943029;6343.873122537552;6346.048092786079;6358.364163583639;6091.543134264925;6184.938150618493;6191.907121393171;6219.937800621992;6234.064890266451;5657.2928383952;5692.48767610916;5785.247917770684;5791.247137872071;5798.594098413113;5645.576581756364;5676.318841738997;5754.539636829044;5779.046457334534;5784.045632470637;5365.114756065244;5596.048671725796;5642.463965923231;5655.1799989001365;5739.311282646067;5657.886842263131;5741.712914354265;5754.6547207167705;5754.884902301972;5763.279590051244;5491.697956612385;5605.103183490622;5620.634658747209;5719.914201286984;5722.685252311121;6082.60463069899;6096.817095487142;6158.445739883432;6169.537284703621;6263.404976527223;6662.400383965466;6663.033860090308;6751.324867513258;6757.864842703168;6759.628220447873;6524.902126468107;6702.195736511601;6715.3620406061345;6804.387605115514;6806.55757375769;6196.41134092265;6207;6264.9373506265265;6282.968585157045;6307.95918673423;6703.463722902156;6851.45188384928;6855.108835851307;6939.965300173467;7001.544899581511;6427.2929977702415;6451.516136289797;6480.319566445455;6531.3142120077655;6612.933870661328;6695.46436285096;6735.090762746966;6787.898181527281;6792.864142717118;6793.422559082534;6676.799696009128;6689.09697190873;6724.327567243335;6775.864482710318;6784.2876497967;6558.868822623616;6671.699773510204;6672.266050734415;6675.032120342523;6704.329567043256;5339.652922560022;5342.572594192456;5350.652207606571;5354.759035843396;5359.3032905722;4564.817407303737;4615.469221039556;4652.023075154188;4677.953220467752;4688.2733176357715;5784.479396854304;5855.853603659943;5872.17789509469;5874.412558744091;5883.411658834168;6568.80293591193;6715.328467153246;6740.460763138937;6805.3875151236625;6812.557183783038;5764.481196692318;5769.942300577024;5814.389489103668;5829;5849.298084229919;5857.70711464425;5867.14926335679;5877.647341159459;5894.823155305347;5900.557458190653;6437.0988061671405;6437.163168788121;6529.151210342625;6536.673166341664;6540.574862633914;6474.708638111202;6609.834754131185;6654.700538475683;6760.695768690519;6761.391474767294;6404;6407.839804004937;6422.293547709654;6431.228252609717;6438.4527315176865;6435.970244760816;6552.3775241352;6565.080888675494;6569.408753212043;6570.934290657032;6687.933120668926;6718.093057437183;6727.26000139994;6769.052332673331;6770;6420.518461115342;6428.774992875414;6519.5436319457185;6527.869442611026;6535.3464653534265;6368.9044664330995;6426.678666066585;6430.967845160744;6516.804495865132;6530.510211734044;6369.490440764635;6392.520560957853;6488.513361498001;6512.413882750575;6548.3124271952665;6557.868842623026;6600;6615.966920165369;6617.040529123154;6647.534672573067;6338.778142764981;6341.8097457076365;6442.323556026549;6445.1943507061615;6471.579347342596 17:44:15 INFO - PID 27025 | |1;ext.html;816.7019038051113;837.8701301298299;850.0776657326799;865.731623196809;1184.5972369394403;31945.36109277816;32494.837525812367;43405.13189736204;44320.55679443213;44400.555994440045;44104.77947610265;44484.110317793704;44502.55497445033;44577.77711111448;44581.77709111458;7718;7761.961190194041;7921.287084162424;7956.641951112214;7959.920400796005;7758.7672369828715;7852.764417067498;7853.64658590362;7854.410919181056;7857.253560911704;7852.607369631524;7878.212178782133;7885.723999660013;7886.408519361043;7888.171741967069;7828.099768526636;7844.607769611525;7844.686212551491;7853.136155022943;7862.449628526006;7696.9615151924445;7757.612119394008;7765.961170194169;7773.844523109507;7789.9221007789765;40652.796736016426;40915.181696366206;41061.178776424305;41106.177876442605;41118;3545.2732189901008;3578.910527236814;3579.982100089509;3584.9641503585153;3595.334863050344;33360.83319583411;33493.6650633493;33495;33512.329753404796;33569.6643033569;5105.974470127663;5119.769610367543;5162.767675454576;5168.5606723428555;5178.404483484373;201017;201653;202267;202432.99999999852;202909;50343.49656503461;50543.24185137226;50564.49435505598;50672;50710.49289507058;53438.465615344125;53520.19719704208;53572;53643.463565364626;53664.73167634137;14707;17080.65838683244;17471.30114795394;17476.737848932276;17482.912585437247;12174.208676436003;12340.568080117333;12406.193597416139;12431.254124752544;12456.626301210978;14984.47554335593;14988.775168372484;14989.475368362055;15077.246137693071;15185.544433667008;5840.328362238312;5865.970670146708;5983.790567330123;6103.084537319438;6104.481119104926;1011.8279892418307;1014.7463134216446;1014.8680671512803;1027.209049032241;1032.1536340201112;22996.885015574815;23718.644220336708;24193.15323963653;24291.63562546528;24399.63400548993;1114.899659030691;1126.8253420719802;1135.3982389333667;1144.542183126756;1146.7419830538229;12407.75184496305;12531.373431328579;12592.559260425842;12705.682357941125;12764.680882977815;238236;240830;242319;242454;242508;54872.725636371564;54971.72514137404;55279;55415.72292138513;55546;1444.8482909294373;1461.437346621537;1496.8503149684943;1505.8494150584854;1509.0266777928175;23146.421339466648;23220.3033908983;23322.650160247947;23342.416439589146;23463;38796.80601596974;38858.22283554257;39016;39143.41284880786;39256.80371598124;206353;209266;214361;222910;223176;34704;34740.305193895474;35086.12284692903;35164.296714065065;39824;48887;49012.2648160285;49260;50074.49925500844;50163.49836501588;35542.28915421729;35594.28811423809;36030;36066.8196659015;36194.63805362018;35055.59777608867;35430.46854297136;35469.113272168404;35685.46471802873;35875.28249434944;37559.43660845144;38384.616153838106;38666.42000370053;38791.22417551577;39003.80498097491;33132.00603981884;33140.84007059741;33206;33507;33509.664903350655;24014.759852401254;24094.080127565714;24309.82781245453;24505.509889801746;25160.496790064462 17:44:15 INFO - PID 27025 | |2;jquery.html;563.8806968168185;565.4769338362014;572.9226554415155;586.5542187937169;588.6909372579395;22674.65988010179;23610.999999999978;23617.64573531394;23624.291271261867;24663.630045549286;26571.202863914066;27238.45523089537;27304.08871378999;27351.179464616045;27352;6671.332866713338;6809.0467334573195;6826.078479405292;6834.077399551072;6854.040434339172;6019.5184385249295;6570.638614876204;6611.834704132411;6638.535302528825;6707.094542236809;6518.445932095754;6546.44355229806;6550.279469258401;6553.410193082622;6565.93434065658;6560.179977502812;6562.310957349458;6567.179102612174;6578.375054369827;6582.80251592453;6103.786367477117;6120.632762034292;6121.081837724332;6122.632642041492;6134.110553969649;29649.258768530744;29819.40361192764;30291.394172116656;30396.54405183924;30456.238594035105;2016.5059560407647;2053.1274208461496;2053.753549574046;2058.8970551472516;2058.9176432942663;18696.158672859754;19444.416667499998;19680.311189108314;20701.68947465789;20770.273040443513;2185;2238.3061251012236;2241.2715867343018;2244.494988627562;2311.884405779704;134108;138743;152428.23785881;157654;158851;14624.824579737688;14776.556703298918;15337.6165595861;15395.461158859385;15555.84444155544;23938.760612394002;23952.760472395054;23967;23969.760302397102;24199.75800241975;10139.543720532594;10164.593416263267;10523.684289471328;10583.417912014758;10584.841227381596;9766.804663906682;9776.462294573867;9840.212782977345;9849.162821160282;9880.40717556949;9230;9299.302552308603;9353.456679647918;9408.43549387039;9621.18219951298;2654.973450265473;2682.8524431156475;2715.769159621415;2733.166384252822;2811.9859400702867;936.7798567336671;941.5010044676333;967.2793768642406;978.6281213138961;990.5839547390113;19729.802701972796;20372.592548148954;20564.177432902517;24006.27981160568;24044.27867163988;1030.3817709374466;1048.627737153315;1056.6882769582837;1065.4619417194267;1065.616378103882;11155.776884462266;11449.427528623535;11559.711007224887;11601.883981160081;11727.648170554898;485775;490898;492750;496032;502085;123160.38419808022;123587;123735;124442.37778811048;125954;1127.0814286356756;1175.6825657072543;1251.5056552661829;1265.6013355792895;1304.9934750326188;20680.689789652868;21341.573168536233;22026;22139.667904981117;22615;59982.700086501034;60635;61649.69175154275;62236.37763622306;63057;68342;68414.3158568408;69982;71586;73041.6347918257;14626.268686565416;14996.175210363535;15142.924285378502;15156.848431515544;15174.544763657108;23613.173538926054;23863.642045368986;23943.880280598485;24063.879680601483;24224.51550969006;18713.25146994105;18726.53183670419;19069.713954290975;19114.33099841499;19189.808101918803;16914.66170676604;16976.490705278862;17359.392421265195;17651.646967060842;17744.733828992834;19318.61362772765;19336.93646849437;19508.31720889762;19670;19707.40877773669;14911.701765964837;14968.877334200197;15174.393024279347;15231.086134831945;15251.542453726406;18453.53866153357;18737.812621873607;18785.718214226523;18842.246310147442;18890.622187556448 17:44:15 INFO - PID 27025 | |3;mootools.html;1333.4466196528442;1396.04371005861;1401.1102949626984;1402.0115818348072;1410.4851729118868;13946;14677.192754398504;14694.118352898833;14707.485238016672;14722;14793.92603036986;15055.698886022274;15073.773893391608;15084.472043478481;15085.396584136648;2697.7302269773013;2760.3375189954468;2768.7784977201877;2770.0581802187253;2771.528840097178;2549.2352294311727;2639.142278759411;2680.075373995968;2681.4503026879543;2688.502627013999;2586.508563372953;2617.685877694679;2623.8950441982297;2667.6932152802383;2669.1191906670847;2552.540542702313;2574.909878154265;2583.8191326607143;2586.262915069215;2586.6120081987665;2541.1614167324738;2542.364408897776;2566.6021766626204;2569.5117927593697;2575.072973729456;13889.79165312521;13932.791008134885;14001.159930404208;14041;14088.71822563543;7451.32938035574;7705.190954949761;7740.6129693515095;7745.496542724705;7753.418493612945;4876.804927802884;5033.421156567005;5067.961067981092;5123.897522049576;5131.640785145004;1870;1872.241742094454;1919.2418994497234;1919.9904000479908;1939;23102.884485577466;23346.2996110117;23362.883185584134;23384.298471045895;24030.639540406733;6390.488760899117;6518.771842985473;6700.329967003358;6701.463882889358;6778.3221677831825;16293.592660183353;16301.103439310715;16313.510594682179;16316.836831631768;16331.26509307084;7539.32146106853;7768.611569421506;7769.805754856174;7787.961060194662;7798.103218129988;6081.179040829431;6207.875842483125;6917.27368626287;7097.396721278749;7157.749478768323;4847.5394837491085;5026.472220416804;5045.495450454925;5082.466341034138;5090.10923088458;1498.4980031689288;1512.8108986376703;1513.0921447131634;1515.1060874084344;1520.9847901521064;873.5850471026212;906.4334790755778;922.423485321674;929.1405449958761;934.4346670264392;8276.751697449086;8605.65577376898;8612.311015118776;8634.870476942851;8643.35174861888;994.049632828518;1021.667957913681;1024.8975102489692;1033.204432586904;1037.2790910317258;5265.262863199156;5712.65724056558;5816.098504731774;5833.358330583633;5939.673317967553;19660.311889083812;20394.592108157754;20614.58770824605;20624;20625.48436289105;18886.716699249522;20205;20209.191632334543;20227.696584551242;20272.493187670425;11038.558457661764;11064.391458469861;11336.94331528337;11422.257553259178;11426.371549564687;8135.9186408135165;8719.651213951625;8977.461352318882;9077.228435583049;9165.358424910191;17728.734068988717;17955.192016359033;18062.92930201895;18063.638727225643;18160.818391815912;17978.01120938361;17985.19066641978;18094.72857907106;18146.818531815043;18207.271709132016;11566.537338506365;11999.40002999864;12006.39968001579;12010.519579216734;12084.637460876187;13422.39599218057;13473.461061557427;13539;13559.525416610371;13593.184408935496;10952.123830093415;10976.615818446317;11115.666530004113;11206.607768728056;11209.719757005814;10820.945895270474;10890.128789696964;10990.340579565252;11065.889341106807;11172.49723762449;9491.857622135536;9646.18007469373;9647;9647.903520964981;9662;7155.266393544646;7260.673269702982;7387.630618468947;7519.962400187964;7623.275788800055;7366.77899663011;7436.256374362737;7498.437617178843;7522.473426860067;7571.697132114654 17:44:15 INFO - PID 27025 | |4;prototype.html;491.20179707974563;502.72852659563836;521.2520033751564;522.2870781383411;523.834991977527;6251.7499300028;6256.781012664557;6265.624062556244;6322.525810564214;6332.335104813986;5935.465808077272;6097.115918191859;6134.957057300258;6154.292256390517;6194.318624951263;4938.876528086791;4952.380952380952;4971.950280497185;4988.900221995567;5000.2747952775235;4950.752462376885;4965.950340496603;4987.451380348159;4999.175136102539;5015.899682006358;4773.64197685175;4869.70781753096;4894.412670479547;4935.950640493603;4942.678725882824;4838.854834354975;4857.708537487762;4881.755912204411;4908.386451693538;4948.158813001798;4415.271480205763;4425.3140763181755;4426.867193984153;4443.133588950156;4491.4161159049445;6025.186599809013;6032.577719559633;6056.3338032816355;6106.4809491192855;6136.269360134742;5570.275864137677;5677.347105082927;5707.400722924116;5710.400407957146;5745.08078707409;6381.872362552723;6397.904031439532;6404.583702059351;6476.352364763486;6513.511486638521;4845.830395936126;4859.611231101539;4871.6846451457905;4877.244192090844;4943.134951383529;6876.0746990842645;6884.862302753967;6906.930930690729;6941.548799328078;6969;4963.205887058053;4973.950260497349;4994.550490455804;5009.66470708694;5011.646855349035;5067.391912970467;5088.51659092393;5098.898022039539;5102.3877134743325;5103.550295858009;5669.291338582677;5695.829125126253;5709.800156994485;5733.31200255972;5740.339860916049;6534.150560427114;6559.311272316338;6617.669116544153;6629.701663425158;6644.415353406134;1690.1633691322875;1714.7084995550786;1716.8153973758067;1752.2027477497709;1789.9821001790076;1206.957756478519;1221.6518292286655;1226.8650448450662;1232.600997867427;1242.465739731924;5626.483447845097;5676.943230567724;5710.5146062585145;5725.221353906401;5769.480746732815;6556.033190042968;6565.179352580927;6720.53892245494;6724.193096828412;6774.72901083961;5820.563457740686;5836.562257830595;5846.23531821564;5848.303991842403;5853.7365818538265;3609;3609.9458508122398;3616.9638303617153;3638.799866007395;3649.39784935488;6502.707378167994;6506.837329066811;6546.672666366662;6584.8024559263295;6619.2056953164965;6939.965300173568;6947.444204463732;7028;7037.824054398681;7065.293470652894;6406.231252249667;6562.80311590653;6563;6608.207015158212;6663.6001839888795;6740.169753163576;6810.387065164159;6822.829429264308;6828.5220034597105;6864.279250678806;6659.234188068434;6678.7328506859185;6745.628990405575;6785.423239024738;6794.898076528955;6514.446272066927;6530.216374035146;6558.80323590293;6600.735970561316;6634.402903738686;4998.60011199096;5036.546710796046;5042.268871013755;5043.798248070036;5073.2897394365555;6777.559458635173;6809.250982392032;6864.725410983505;6913.5506192097355;6966.686499107654;6606.53754237218;6651.63416012124;6671.566348187546;6671.666416679243;6701.363370479797;6500.837479063061;6587;6617.437517810848;6646.202455705346;6692;6176.289726681489;6290.528210384148;6347.143135676624;6429.145994773916;6494.123293355526;6504.1869766279215;6558.245801732862;6570.277269500256;6618.437432818265;6660.600363978177;6298.968505157445;6376.39424254695;6422.903656445251;6433;6434.517411194272 17:44:15 INFO - PID 27025 | |5;yui.html;925.2644147902417;932.4824722279136;935.3873213045449;940.0317672797022;953.880764904387;17510.82489175108;17994.28022879085;18009.18958646861;18030.819691803077;20840.687389689167;20509;21735.347939561798;21961.890190549064;22089;22146.778532214714;1015.558232169007;1052.5894900988583;1053.0890779475737;1054.425338190684;1054.6888667843004;984.3945973226486;1061.851340812287;1062.1768129699506;1065.4938904020566;1066.855974443452;1109.528450408577;1111.3109871879446;1112.1547623805884;1112.365951407698;1112.6383925224334;1108.794872948499;1109.944502774858;1110.5058249079163;1110.6723516562593;1112.7774445110929;813.4346629092782;813.4875028731861;814.1207495904409;814.5479259011246;818.6234332207192;20207.19171233149;20439.48901277465;20642.48393790152;20644.5871082579;21061.262855799974;21825.890870545703;22228.11087556496;22235.888820555956;22236.55526889453;22614.66078008831;16881.577960550963;17121.143942802933;17385.739213911802;17429.21568529419;17492;3647.8358473868475;3669.944950825713;3673.1735359544155;3674.136577904217;3674.6876515496215;130100.34949825285;130214;130340.3482982579;131666;134992.32503837516;17176.484705458857;17343;17355.3057877686;17391.391301304393;17482.562935926704;30127.548086778716;32233.194170145463;32463.675363246064;32509.349813003606;32583.51124733131;7589.962050189824;8038.794180872916;8360.958195208985;8701.042885282613;8797.956010219908;4018.176273863851;4083.285425050664;4094.6519545838937;4108.712390132662;4132.111596006873;5305.124654432053;5341.679499230058;5386.434424385461;5438.5377242934;5440.782368705287;1106.1040557148735;1113.3932007056173;1123.8314252861971;1129.0403157316216;1131.6378758797107;690.19247480448;693.4833549006023;699.5872435263219;716.1620903542868;721.4913485992363;11803.763924721457;11995.940020299842;12143;12922.67693307656;13438.529651462151;695.2491309385852;695.5652717051843;700.58315302395;712.2094475132599;713.579375767128;5785;5880.176775251382;5908.645481271137;6087.995480745716;6195.16365290689;116091;118345;119814.40092799481;119939;120489;101031;103661;103936;104466;105625;87408;87453.56273218594;87817.56091219503;88936;92365.07634923699;10863;10872.510737016695;10908.890911091104;11072.557097716324;11383.829242561202;39771.40342894917;40550.59449405586;41126.38310425286;41496.792516037225;42476;72438;73827.63086184535;74003;75016;76142.61928690321;19016.904915475334;19111;19116.808831912058;19356.225750969803;19435.902820485808;22501.437464062874;22635.886820565793;22859.428514287276;22927;23180.420489487897;18917.43247702571;18984.620307593494;19305;19557.413277601696;19850.305239316556;20128.09423575972;20154.29459968894;20249;20266.392008239778;20887.58224835525;18712.25150993945;19568;19707.802921970597;19772.505687357356;19876.801231987494;12627.11610187278;13395.799063013868;13703.725925481634;13784.655383615489;13801;14389.712205756035;14939.850601494281;15407.306671200047;15477.303521341342;15675.294611742727 17:44:15 INFO - PID 27025 | __end_tp_report 17:44:15 INFO - PID 27025 | __start_cc_report 17:44:15 INFO - PID 27025 | _x_x_mozilla_cycle_collect,366 17:44:15 INFO - PID 27025 | __end_cc_report 17:44:15 INFO - PID 27025 | __startTimestamp1502671455155__endTimestamp 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | ------- Summary: start ------- 17:44:15 INFO - PID 27025 | Number of tests: 6 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | [#0] dojo.html Cycles:165 Average:6150.79 Median:6420.52 stddev:728.39 (11.3%) stddev-sans-first:691.42 17:44:15 INFO - PID 27025 | Values: 3145.4 3161.2 3171.7 3179.8 3211.3 6176.8 6308.8 6343.9 6346.0 6358.4 6091.5 6184.9 6191.9 6219.9 6234.1 5657.3 5692.5 5785.2 5791.2 5798.6 5645.6 5676.3 5754.5 5779.0 5784.0 5365.1 5596.0 5642.5 5655.2 5739.3 5657.9 5741.7 5754.7 5754.9 5763.3 5491.7 5605.1 5620.6 5719.9 5722.7 6082.6 6096.8 6158.4 6169.5 6263.4 6662.4 6663.0 6751.3 6757.9 6759.6 6524.9 6702.2 6715.4 6804.4 6806.6 6196.4 6207.0 6264.9 6283.0 6308.0 6703.5 6851.5 6855.1 6940.0 7001.5 6427.3 6451.5 6480.3 6531.3 6612.9 6695.5 6735.1 6787.9 6792.9 6793.4 6676.8 6689.1 6724.3 6775.9 6784.3 6558.9 6671.7 6672.3 6675.0 6704.3 5339.7 5342.6 5350.7 5354.8 5359.3 4564.8 4615.5 4652.0 4678.0 4688.3 5784.5 5855.9 5872.2 5874.4 5883.4 6568.8 6715.3 6740.5 6805.4 6812.6 5764.5 5769.9 5814.4 5829.0 5849.3 5857.7 5867.1 5877.6 5894.8 5900.6 6437.1 6437.2 6529.2 6536.7 6540.6 6474.7 6609.8 6654.7 6760.7 6761.4 6404.0 6407.8 6422.3 6431.2 6438.5 6436.0 6552.4 6565.1 6569.4 6570.9 6687.9 6718.1 6727.3 6769.1 6770.0 6420.5 6428.8 6519.5 6527.9 6535.3 6368.9 6426.7 6431.0 6516.8 6530.5 6369.5 6392.5 6488.5 6512.4 6548.3 6557.9 6600.0 6616.0 6617.0 6647.5 6338.8 6341.8 6442.3 6445.2 6471.6 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | [#1] ext.html Cycles:180 Average:39738.79 Median:3582.47 stddev:57096.66 (1593.8%) stddev-sans-first:57182.03 17:44:15 INFO - PID 27025 | Values: 816.7 837.9 850.1 865.7 1184.6 31945.4 32494.8 43405.1 44320.6 44400.6 44104.8 44484.1 44502.6 44577.8 44581.8 7718.0 7762.0 7921.3 7956.6 7959.9 7758.8 7852.8 7853.6 7854.4 7857.3 7852.6 7878.2 7885.7 7886.4 7888.2 7828.1 7844.6 7844.7 7853.1 7862.4 7697.0 7757.6 7766.0 7773.8 7789.9 40652.8 40915.2 41061.2 41106.2 41118.0 3545.3 3578.9 3580.0 3585.0 3595.3 33360.8 33493.7 33495.0 33512.3 33569.7 5106.0 5119.8 5162.8 5168.6 5178.4 201017.0 201653.0 202267.0 202433.0 202909.0 50343.5 50543.2 50564.5 50672.0 50710.5 53438.5 53520.2 53572.0 53643.5 53664.7 14707.0 17080.7 17471.3 17476.7 17482.9 12174.2 12340.6 12406.2 12431.3 12456.6 14984.5 14988.8 14989.5 15077.2 15185.5 5840.3 5866.0 5983.8 6103.1 6104.5 1011.8 1014.7 1014.9 1027.2 1032.2 22996.9 23718.6 24193.2 24291.6 24399.6 1114.9 1126.8 1135.4 1144.5 1146.7 12407.8 12531.4 12592.6 12705.7 12764.7 238236.0 240830.0 242319.0 242454.0 242508.0 54872.7 54971.7 55279.0 55415.7 55546.0 1444.8 1461.4 1496.9 1505.8 1509.0 23146.4 23220.3 23322.7 23342.4 23463.0 38796.8 38858.2 39016.0 39143.4 39256.8 206353.0 209266.0 214361.0 222910.0 223176.0 34704.0 34740.3 35086.1 35164.3 39824.0 48887.0 49012.3 49260.0 50074.5 50163.5 35542.3 35594.3 36030.0 36066.8 36194.6 35055.6 35430.5 35469.1 35685.5 35875.3 37559.4 38384.6 38666.4 38791.2 39003.8 33132.0 33140.8 33206.0 33507.0 33509.7 24014.8 24094.1 24309.8 24505.5 25160.5 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | [#2] jquery.html Cycles:180 Average:35954.04 Median:23615.41 stddev:83688.27 (354.4%) stddev-sans-first:83880.86 17:44:15 INFO - PID 27025 | Values: 563.9 565.5 572.9 586.6 588.7 22674.7 23611.0 23617.6 23624.3 24663.6 26571.2 27238.5 27304.1 27351.2 27352.0 6671.3 6809.0 6826.1 6834.1 6854.0 6019.5 6570.6 6611.8 6638.5 6707.1 6518.4 6546.4 6550.3 6553.4 6565.9 6560.2 6562.3 6567.2 6578.4 6582.8 6103.8 6120.6 6121.1 6122.6 6134.1 29649.3 29819.4 30291.4 30396.5 30456.2 2016.5 2053.1 2053.8 2058.9 2058.9 18696.2 19444.4 19680.3 20701.7 20770.3 2185.0 2238.3 2241.3 2244.5 2311.9 134108.0 138743.0 152428.2 157654.0 158851.0 14624.8 14776.6 15337.6 15395.5 15555.8 23938.8 23952.8 23967.0 23969.8 24199.8 10139.5 10164.6 10523.7 10583.4 10584.8 9766.8 9776.5 9840.2 9849.2 9880.4 9230.0 9299.3 9353.5 9408.4 9621.2 2655.0 2682.9 2715.8 2733.2 2812.0 936.8 941.5 967.3 978.6 990.6 19729.8 20372.6 20564.2 24006.3 24044.3 1030.4 1048.6 1056.7 1065.5 1065.6 11155.8 11449.4 11559.7 11601.9 11727.6 485775.0 490898.0 492750.0 496032.0 502085.0 123160.4 123587.0 123735.0 124442.4 125954.0 1127.1 1175.7 1251.5 1265.6 1305.0 20680.7 21341.6 22026.0 22139.7 22615.0 59982.7 60635.0 61649.7 62236.4 63057.0 68342.0 68414.3 69982.0 71586.0 73041.6 14626.3 14996.2 15142.9 15156.8 15174.5 23613.2 23863.6 23943.9 24063.9 24224.5 18713.3 18726.5 19069.7 19114.3 19189.8 16914.7 16976.5 17359.4 17651.6 17744.7 19318.6 19336.9 19508.3 19670.0 19707.4 14911.7 14968.9 15174.4 15231.1 15251.5 18453.5 18737.8 18785.7 18842.2 18890.6 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | [#3] mootools.html Cycles:180 Average:9022.03 Median:2545.80 stddev:6184.01 (242.9%) stddev-sans-first:6174.37 17:44:15 INFO - PID 27025 | Values: 1333.4 1396.0 1401.1 1402.0 1410.5 13946.0 14677.2 14694.1 14707.5 14722.0 14793.9 15055.7 15073.8 15084.5 15085.4 2697.7 2760.3 2768.8 2770.1 2771.5 2549.2 2639.1 2680.1 2681.5 2688.5 2586.5 2617.7 2623.9 2667.7 2669.1 2552.5 2574.9 2583.8 2586.3 2586.6 2541.2 2542.4 2566.6 2569.5 2575.1 13889.8 13932.8 14001.2 14041.0 14088.7 7451.3 7705.2 7740.6 7745.5 7753.4 4876.8 5033.4 5068.0 5123.9 5131.6 1870.0 1872.2 1919.2 1920.0 1939.0 23102.9 23346.3 23362.9 23384.3 24030.6 6390.5 6518.8 6700.3 6701.5 6778.3 16293.6 16301.1 16313.5 16316.8 16331.3 7539.3 7768.6 7769.8 7788.0 7798.1 6081.2 6207.9 6917.3 7097.4 7157.7 4847.5 5026.5 5045.5 5082.5 5090.1 1498.5 1512.8 1513.1 1515.1 1521.0 873.6 906.4 922.4 929.1 934.4 8276.8 8605.7 8612.3 8634.9 8643.4 994.0 1021.7 1024.9 1033.2 1037.3 5265.3 5712.7 5816.1 5833.4 5939.7 19660.3 20394.6 20614.6 20624.0 20625.5 18886.7 20205.0 20209.2 20227.7 20272.5 11038.6 11064.4 11336.9 11422.3 11426.4 8135.9 8719.7 8977.5 9077.2 9165.4 17728.7 17955.2 18062.9 18063.6 18160.8 17978.0 17985.2 18094.7 18146.8 18207.3 11566.5 11999.4 12006.4 12010.5 12084.6 13422.4 13473.5 13539.0 13559.5 13593.2 10952.1 10976.6 11115.7 11206.6 11209.7 10820.9 10890.1 10990.3 11065.9 11172.5 9491.9 9646.2 9647.0 9647.9 9662.0 7155.3 7260.7 7387.6 7520.0 7623.3 7366.8 7436.3 7498.4 7522.5 7571.7 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | [#4] prototype.html Cycles:180 Average:5526.71 Median:6120.72 stddev:1562.12 (25.5%) stddev-sans-first:1520.09 17:44:15 INFO - PID 27025 | Values: 491.2 502.7 521.3 522.3 523.8 6251.7 6256.8 6265.6 6322.5 6332.3 5935.5 6097.1 6135.0 6154.3 6194.3 4938.9 4952.4 4972.0 4988.9 5000.3 4950.8 4966.0 4987.5 4999.2 5015.9 4773.6 4869.7 4894.4 4936.0 4942.7 4838.9 4857.7 4881.8 4908.4 4948.2 4415.3 4425.3 4426.9 4443.1 4491.4 6025.2 6032.6 6056.3 6106.5 6136.3 5570.3 5677.3 5707.4 5710.4 5745.1 6381.9 6397.9 6404.6 6476.4 6513.5 4845.8 4859.6 4871.7 4877.2 4943.1 6876.1 6884.9 6906.9 6941.5 6969.0 4963.2 4974.0 4994.6 5009.7 5011.6 5067.4 5088.5 5098.9 5102.4 5103.6 5669.3 5695.8 5709.8 5733.3 5740.3 6534.2 6559.3 6617.7 6629.7 6644.4 1690.2 1714.7 1716.8 1752.2 1790.0 1207.0 1221.7 1226.9 1232.6 1242.5 5626.5 5676.9 5710.5 5725.2 5769.5 6556.0 6565.2 6720.5 6724.2 6774.7 5820.6 5836.6 5846.2 5848.3 5853.7 3609.0 3609.9 3617.0 3638.8 3649.4 6502.7 6506.8 6546.7 6584.8 6619.2 6940.0 6947.4 7028.0 7037.8 7065.3 6406.2 6562.8 6563.0 6608.2 6663.6 6740.2 6810.4 6822.8 6828.5 6864.3 6659.2 6678.7 6745.6 6785.4 6794.9 6514.4 6530.2 6558.8 6600.7 6634.4 4998.6 5036.5 5042.3 5043.8 5073.3 6777.6 6809.3 6864.7 6913.6 6966.7 6606.5 6651.6 6671.6 6671.7 6701.4 6500.8 6587.0 6617.4 6646.2 6692.0 6176.3 6290.5 6347.1 6429.1 6494.1 6504.2 6558.2 6570.3 6618.4 6660.6 6299.0 6376.4 6422.9 6433.0 6434.5 17:44:15 INFO - PID 27025 | 17:44:15 INFO - PID 27025 | [#5] yui.html Cycles:180 Average:24923.24 Median:20228.10 stddev:33927.66 (167.7%) stddev-sans-first:33974.98 17:44:15 INFO - PID 27025 | Values: 925.3 932.5 935.4 940.0 953.9 17510.8 17994.3 18009.2 18030.8 20840.7 20509.0 21735.3 21961.9 22089.0 22146.8 1015.6 1052.6 1053.1 1054.4 1054.7 984.4 1061.9 1062.2 1065.5 1066.9 1109.5 1111.3 1112.2 1112.4 1112.6 1108.8 1109.9 1110.5 1110.7 1112.8 813.4 813.5 814.1 814.5 818.6 20207.2 20439.5 20642.5 20644.6 21061.3 21825.9 22228.1 22235.9 22236.6 22614.7 16881.6 17121.1 17385.7 17429.2 17492.0 3647.8 3669.9 3673.2 3674.1 3674.7 130100.3 130214.0 130340.3 131666.0 134992.3 17176.5 17343.0 17355.3 17391.4 17482.6 30127.5 32233.2 32463.7 32509.3 32583.5 7590.0 8038.8 8361.0 8701.0 8798.0 4018.2 4083.3 4094.7 4108.7 4132.1 5305.1 5341.7 5386.4 5438.5 5440.8 1106.1 1113.4 1123.8 1129.0 1131.6 690.2 693.5 699.6 716.2 721.5 11803.8 11995.9 12143.0 12922.7 13438.5 695.2 695.6 700.6 712.2 713.6 5785.0 5880.2 5908.6 6088.0 6195.2 116091.0 118345.0 119814.4 119939.0 120489.0 101031.0 103661.0 103936.0 104466.0 105625.0 87408.0 87453.6 87817.6 88936.0 92365.1 10863.0 10872.5 10908.9 11072.6 11383.8 39771.4 40550.6 41126.4 41496.8 42476.0 72438.0 73827.6 74003.0 75016.0 76142.6 19016.9 19111.0 19116.8 19356.2 19435.9 22501.4 22635.9 22859.4 22927.0 23180.4 18917.4 18984.6 19305.0 19557.4 19850.3 20128.1 20154.3 20249.0 20266.4 20887.6 18712.3 19568.0 19707.8 19772.5 19876.8 12627.1 13395.8 13703.7 13784.7 13801.0 14389.7 14939.9 15407.3 15477.3 15675.3 17:44:15 INFO - PID 27025 | -------- Summary: end -------- 17:44:15 INFO - PID 27025 | 17:44:15 INFO - TEST-INFO | 27025: exit 0 17:44:15 INFO - TEST-OK | dromaeo_css | took 1112791ms 17:44:15 INFO - TEST-START | kraken 17:44:15 INFO - Initialising browser for kraken test... 17:44:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46926/getInfo.html -profile /tmp/tmpfVV4mC/profile 17:44:15 INFO - TEST-INFO | started process 27394 (/builds/slave/test/build/application/firefox/firefox http://localhost:46926/getInfo.html) 17:44:22 INFO - TEST-INFO | 27394: exit 0 17:44:22 INFO - Browser initialized. 17:44:22 INFO - Running cycle 1/1 for kraken test... 17:44:22 INFO - TEST-INFO | started process 27627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfVV4mC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:23 INFO - PID 27627 | 17:44:23 INFO - PID 27627 | (/builds/slave/test/build/application/firefox/firefox:27682): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:44:23 INFO - PID 27627 | 17:44:33 INFO - PID 27627 | RSS: Main: 167964672 17:44:33 INFO - PID 27627 | 17:44:36 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46926/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:37 INFO - PID 27627 | RSS: Main: 173780992 17:44:37 INFO - PID 27627 | 17:44:39 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46926/tests/kraken/driver.html?testName=audio-dft) 17:44:40 INFO - PID 27627 | RSS: Main: 174555136 17:44:40 INFO - PID 27627 | 17:44:43 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46926/tests/kraken/driver.html?testName=audio-fft) 17:44:44 INFO - PID 27627 | RSS: Main: 169459712 17:44:44 INFO - PID 27627 | 17:44:46 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46926/tests/kraken/driver.html?testName=audio-oscillator) 17:44:47 INFO - PID 27627 | RSS: Main: 169938944 17:44:47 INFO - PID 27627 | 17:44:49 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:49 INFO - PID 27627 | RSS: Main: 169951232 17:44:49 INFO - PID 27627 | 17:44:53 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46926/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:53 INFO - PID 27627 | RSS: Main: 173088768 17:44:53 INFO - PID 27627 | 17:44:57 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46926/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:57 INFO - PID 27627 | RSS: Main: 172494848 17:44:57 INFO - PID 27627 | 17:45:00 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46926/tests/kraken/driver.html?testName=json-parse-financial) 17:45:01 INFO - PID 27627 | RSS: Main: 173740032 17:45:01 INFO - PID 27627 | 17:45:03 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:03 INFO - PID 27627 | RSS: Main: 173453312 17:45:03 INFO - PID 27627 | 17:45:05 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:06 INFO - PID 27627 | RSS: Main: 173568000 17:45:06 INFO - PID 27627 | 17:45:08 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:09 INFO - PID 27627 | RSS: Main: 173527040 17:45:09 INFO - PID 27627 | 17:45:11 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:12 INFO - PID 27627 | RSS: Main: 173981696 17:45:12 INFO - PID 27627 | 17:45:15 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:16 INFO - PID 27627 | RSS: Main: 174153728 17:45:16 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | Cycle 1(1): loaded http://localhost:46926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46926/tests/kraken/driver.html?testName=ai-astar) 17:45:18 INFO - PID 27627 | RSS: Main: 175579136 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | __start_tp_report 17:45:18 INFO - PID 27627 | _x_x_mozilla_page_load 17:45:18 INFO - PID 27627 | _x_x_mozilla_page_load_details 17:45:18 INFO - PID 27627 | |i|pagename|runs| 17:45:18 INFO - PID 27627 | |0;ai-astar;102;106;103;107;108;109;113;100;108;107 17:45:18 INFO - PID 27627 | |1;audio-beat-detection;143;118;148;185;118;144;149;124;187;118 17:45:18 INFO - PID 27627 | |2;audio-dft;165;163;162;169;164;165;170;164;164;167 17:45:18 INFO - PID 27627 | |3;audio-fft;76;76;76;175;80;76;76;76;156;76 17:45:18 INFO - PID 27627 | |4;audio-oscillator;79;79;135;84;84;80;129;82;82;136 17:45:18 INFO - PID 27627 | |5;imaging-gaussian-blur;113;118;114;114;114;118;117;117;116;117 17:45:18 INFO - PID 27627 | |6;imaging-darkroom;150;155;153;151;151;150;148;151;152;151 17:45:18 INFO - PID 27627 | |7;imaging-desaturate;93;97;94;94;99;99;94;94;93;94 17:45:18 INFO - PID 27627 | |8;json-parse-financial;55;58;54;55;54;59;59;62;55;59 17:45:18 INFO - PID 27627 | |9;json-stringify-tinderbox;54;55;55;55;56;55;55;61;56;57 17:45:18 INFO - PID 27627 | |10;stanford-crypto-aes;80;86;83;77;79;78;78;85;94;80 17:45:18 INFO - PID 27627 | |11;stanford-crypto-ccm;132;121;127;125;134;125;139;125;128;168 17:45:18 INFO - PID 27627 | |12;stanford-crypto-pbkdf2;182;179;201;189;174;179;180;175;189;182 17:45:18 INFO - PID 27627 | |13;stanford-crypto-sha256-iterative;68;73;72;69;74;70;73;68;70;67 17:45:18 INFO - PID 27627 | __end_tp_report 17:45:18 INFO - PID 27627 | __start_cc_report 17:45:18 INFO - PID 27627 | _x_x_mozilla_cycle_collect,969 17:45:18 INFO - PID 27627 | __end_cc_report 17:45:18 INFO - PID 27627 | __startTimestamp1502671518504__endTimestamp 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | ------- Summary: start ------- 17:45:18 INFO - PID 27627 | Number of tests: 14 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.50 stddev:3.77 (3.5%) stddev-sans-first:3.67 17:45:18 INFO - PID 27627 | Values: 102.0 106.0 103.0 107.0 108.0 109.0 113.0 100.0 108.0 107.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:146.00 stddev:25.81 (17.7%) stddev-sans-first:27.38 17:45:18 INFO - PID 27627 | Values: 143.0 118.0 148.0 185.0 118.0 144.0 149.0 124.0 187.0 118.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.74 17:45:18 INFO - PID 27627 | Values: 165.0 163.0 162.0 169.0 164.0 165.0 170.0 164.0 164.0 167.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:37.81 (49.8%) stddev-sans-first:39.52 17:45:18 INFO - PID 27627 | Values: 76.0 76.0 76.0 175.0 80.0 76.0 76.0 76.0 156.0 76.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:81.00 stddev:25.20 (31.1%) stddev-sans-first:25.87 17:45:18 INFO - PID 27627 | Values: 79.0 79.0 135.0 84.0 84.0 80.0 129.0 82.0 82.0 136.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:117.00 stddev:1.87 (1.6%) stddev-sans-first:1.69 17:45:18 INFO - PID 27627 | Values: 113.0 118.0 114.0 114.0 114.0 118.0 117.0 117.0 116.0 117.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:1.87 (1.2%) stddev-sans-first:1.94 17:45:18 INFO - PID 27627 | Values: 150.0 155.0 153.0 151.0 151.0 150.0 148.0 151.0 152.0 151.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.33 (2.5%) stddev-sans-first:2.35 17:45:18 INFO - PID 27627 | Values: 93.0 97.0 94.0 94.0 99.0 99.0 94.0 94.0 93.0 94.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:58.50 stddev:2.75 (4.7%) stddev-sans-first:2.82 17:45:18 INFO - PID 27627 | Values: 55.0 58.0 54.0 55.0 54.0 59.0 59.0 62.0 55.0 59.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:55.50 stddev:1.97 (3.5%) stddev-sans-first:1.96 17:45:18 INFO - PID 27627 | Values: 54.0 55.0 55.0 55.0 56.0 55.0 55.0 61.0 56.0 57.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:5.21 (6.4%) stddev-sans-first:5.47 17:45:18 INFO - PID 27627 | Values: 80.0 86.0 83.0 77.0 79.0 78.0 78.0 85.0 94.0 80.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:130.00 stddev:13.57 (10.4%) stddev-sans-first:14.39 17:45:18 INFO - PID 27627 | Values: 132.0 121.0 127.0 125.0 134.0 125.0 139.0 125.0 128.0 168.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:182.00 stddev:8.06 (4.4%) stddev-sans-first:8.54 17:45:18 INFO - PID 27627 | Values: 182.0 179.0 201.0 189.0 174.0 179.0 180.0 175.0 189.0 182.0 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:2.46 (3.5%) stddev-sans-first:2.45 17:45:18 INFO - PID 27627 | Values: 68.0 73.0 72.0 69.0 74.0 70.0 73.0 68.0 70.0 67.0 17:45:18 INFO - PID 27627 | -------- Summary: end -------- 17:45:18 INFO - PID 27627 | 17:45:18 INFO - PID 27627 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:45:19 INFO - TEST-INFO | 27627: exit 0 17:45:19 INFO - TEST-OK | kraken | took 63397ms 17:45:19 INFO - SUITE-END | took 1176s 17:45:19 INFO - Completed test suite (00:19:36) 17:45:19 INFO - javascript benchmark 17:45:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8669.920484769302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.3709258148374, 3161.193895556633, 3171.682831716828, 3179.8092114473125, 3211.341674956634, 6176.752929882805, 6308.842278943029, 6343.873122537552, 6346.048092786079, 6358.364163583639, 6091.543134264925, 6184.938150618493, 6191.907121393171, 6219.937800621992, 6234.064890266451, 5657.2928383952, 5692.48767610916, 5785.247917770684, 5791.247137872071, 5798.594098413113, 5645.576581756364, 5676.318841738997, 5754.539636829044, 5779.046457334534, 5784.045632470637, 5365.114756065244, 5596.048671725796, 5642.463965923231, 5655.1799989001365, 5739.311282646067, 5657.886842263131, 5741.712914354265, 5754.6547207167705, 5754.884902301972, 5763.279590051244, 5491.697956612385, 5605.103183490622, 5620.634658747209, 5719.914201286984, 5722.685252311121, 6082.60463069899, 6096.817095487142, 6158.445739883432, 6169.537284703621, 6263.404976527223, 6662.400383965466, 6663.033860090308, 6751.324867513258, 6757.864842703168, 6759.628220447873, 6524.902126468107, 6702.195736511601, 6715.3620406061345, 6804.387605115514, 6806.55757375769, 6196.41134092265, 6207.0, 6264.9373506265265, 6282.968585157045, 6307.95918673423, 6703.463722902156, 6851.45188384928, 6855.108835851307, 6939.965300173467, 7001.544899581511, 6427.2929977702415, 6451.516136289797, 6480.319566445455, 6531.3142120077655, 6612.933870661328, 6695.46436285096, 6735.090762746966, 6787.898181527281, 6792.864142717118, 6793.422559082534, 6676.799696009128, 6689.09697190873, 6724.327567243335, 6775.864482710318, 6784.2876497967, 6558.868822623616, 6671.699773510204, 6672.266050734415, 6675.032120342523, 6704.329567043256, 5339.652922560022, 5342.572594192456, 5350.652207606571, 5354.759035843396, 5359.3032905722, 4564.817407303737, 4615.469221039556, 4652.023075154188, 4677.953220467752, 4688.2733176357715, 5784.479396854304, 5855.853603659943, 5872.17789509469, 5874.412558744091, 5883.411658834168, 6568.80293591193, 6715.328467153246, 6740.460763138937, 6805.3875151236625, 6812.557183783038, 5764.481196692318, 5769.942300577024, 5814.389489103668, 5829.0, 5849.298084229919, 5857.70711464425, 5867.14926335679, 5877.647341159459, 5894.823155305347, 5900.557458190653, 6437.0988061671405, 6437.163168788121, 6529.151210342625, 6536.673166341664, 6540.574862633914, 6474.708638111202, 6609.834754131185, 6654.700538475683, 6760.695768690519, 6761.391474767294, 6404.0, 6407.839804004937, 6422.293547709654, 6431.228252609717, 6438.4527315176865, 6435.970244760816, 6552.3775241352, 6565.080888675494, 6569.408753212043, 6570.934290657032, 6687.933120668926, 6718.093057437183, 6727.26000139994, 6769.052332673331, 6770.0, 6420.518461115342, 6428.774992875414, 6519.5436319457185, 6527.869442611026, 6535.3464653534265, 6368.9044664330995, 6426.678666066585, 6430.967845160744, 6516.804495865132, 6530.510211734044, 6369.490440764635, 6392.520560957853, 6488.513361498001, 6512.413882750575, 6548.3124271952665, 6557.868842623026, 6600.0, 6615.966920165369, 6617.040529123154, 6647.534672573067, 6338.778142764981, 6341.8097457076365, 6442.323556026549, 6445.1943507061615, 6471.579347342596], "value": 6096.291855375871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.7019038051113, 837.8701301298299, 850.0776657326799, 865.731623196809, 1184.5972369394403, 31945.36109277816, 32494.837525812367, 43405.13189736204, 44320.55679443213, 44400.555994440045, 44104.77947610265, 44484.110317793704, 44502.55497445033, 44577.77711111448, 44581.77709111458, 7718.0, 7761.961190194041, 7921.287084162424, 7956.641951112214, 7959.920400796005, 7758.7672369828715, 7852.764417067498, 7853.64658590362, 7854.410919181056, 7857.253560911704, 7852.607369631524, 7878.212178782133, 7885.723999660013, 7886.408519361043, 7888.171741967069, 7828.099768526636, 7844.607769611525, 7844.686212551491, 7853.136155022943, 7862.449628526006, 7696.9615151924445, 7757.612119394008, 7765.961170194169, 7773.844523109507, 7789.9221007789765, 40652.796736016426, 40915.181696366206, 41061.178776424305, 41106.177876442605, 41118.0, 3545.2732189901008, 3578.910527236814, 3579.982100089509, 3584.9641503585153, 3595.334863050344, 33360.83319583411, 33493.6650633493, 33495.0, 33512.329753404796, 33569.6643033569, 5105.974470127663, 5119.769610367543, 5162.767675454576, 5168.5606723428555, 5178.404483484373, 201017.0, 201653.0, 202267.0, 202432.99999999852, 202909.0, 50343.49656503461, 50543.24185137226, 50564.49435505598, 50672.0, 50710.49289507058, 53438.465615344125, 53520.19719704208, 53572.0, 53643.463565364626, 53664.73167634137, 14707.0, 17080.65838683244, 17471.30114795394, 17476.737848932276, 17482.912585437247, 12174.208676436003, 12340.568080117333, 12406.193597416139, 12431.254124752544, 12456.626301210978, 14984.47554335593, 14988.775168372484, 14989.475368362055, 15077.246137693071, 15185.544433667008, 5840.328362238312, 5865.970670146708, 5983.790567330123, 6103.084537319438, 6104.481119104926, 1011.8279892418307, 1014.7463134216446, 1014.8680671512803, 1027.209049032241, 1032.1536340201112, 22996.885015574815, 23718.644220336708, 24193.15323963653, 24291.63562546528, 24399.63400548993, 1114.899659030691, 1126.8253420719802, 1135.3982389333667, 1144.542183126756, 1146.7419830538229, 12407.75184496305, 12531.373431328579, 12592.559260425842, 12705.682357941125, 12764.680882977815, 238236.0, 240830.0, 242319.0, 242454.0, 242508.0, 54872.725636371564, 54971.72514137404, 55279.0, 55415.72292138513, 55546.0, 1444.8482909294373, 1461.437346621537, 1496.8503149684943, 1505.8494150584854, 1509.0266777928175, 23146.421339466648, 23220.3033908983, 23322.650160247947, 23342.416439589146, 23463.0, 38796.80601596974, 38858.22283554257, 39016.0, 39143.41284880786, 39256.80371598124, 206353.0, 209266.0, 214361.0, 222910.0, 223176.0, 34704.0, 34740.305193895474, 35086.12284692903, 35164.296714065065, 39824.0, 48887.0, 49012.2648160285, 49260.0, 50074.49925500844, 50163.49836501588, 35542.28915421729, 35594.28811423809, 36030.0, 36066.8196659015, 36194.63805362018, 35055.59777608867, 35430.46854297136, 35469.113272168404, 35685.46471802873, 35875.28249434944, 37559.43660845144, 38384.616153838106, 38666.42000370053, 38791.22417551577, 39003.80498097491, 33132.00603981884, 33140.84007059741, 33206.0, 33507.0, 33509.664903350655, 24014.759852401254, 24094.080127565714, 24309.82781245453, 24505.509889801746, 25160.496790064462], "value": 17859.135339822406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.8806968168185, 565.4769338362014, 572.9226554415155, 586.5542187937169, 588.6909372579395, 22674.65988010179, 23610.999999999978, 23617.64573531394, 23624.291271261867, 24663.630045549286, 26571.202863914066, 27238.45523089537, 27304.08871378999, 27351.179464616045, 27352.0, 6671.332866713338, 6809.0467334573195, 6826.078479405292, 6834.077399551072, 6854.040434339172, 6019.5184385249295, 6570.638614876204, 6611.834704132411, 6638.535302528825, 6707.094542236809, 6518.445932095754, 6546.44355229806, 6550.279469258401, 6553.410193082622, 6565.93434065658, 6560.179977502812, 6562.310957349458, 6567.179102612174, 6578.375054369827, 6582.80251592453, 6103.786367477117, 6120.632762034292, 6121.081837724332, 6122.632642041492, 6134.110553969649, 29649.258768530744, 29819.40361192764, 30291.394172116656, 30396.54405183924, 30456.238594035105, 2016.5059560407647, 2053.1274208461496, 2053.753549574046, 2058.8970551472516, 2058.9176432942663, 18696.158672859754, 19444.416667499998, 19680.311189108314, 20701.68947465789, 20770.273040443513, 2185.0, 2238.3061251012236, 2241.2715867343018, 2244.494988627562, 2311.884405779704, 134108.0, 138743.0, 152428.23785881, 157654.0, 158851.0, 14624.824579737688, 14776.556703298918, 15337.6165595861, 15395.461158859385, 15555.84444155544, 23938.760612394002, 23952.760472395054, 23967.0, 23969.760302397102, 24199.75800241975, 10139.543720532594, 10164.593416263267, 10523.684289471328, 10583.417912014758, 10584.841227381596, 9766.804663906682, 9776.462294573867, 9840.212782977345, 9849.162821160282, 9880.40717556949, 9230.0, 9299.302552308603, 9353.456679647918, 9408.43549387039, 9621.18219951298, 2654.973450265473, 2682.8524431156475, 2715.769159621415, 2733.166384252822, 2811.9859400702867, 936.7798567336671, 941.5010044676333, 967.2793768642406, 978.6281213138961, 990.5839547390113, 19729.802701972796, 20372.592548148954, 20564.177432902517, 24006.27981160568, 24044.27867163988, 1030.3817709374466, 1048.627737153315, 1056.6882769582837, 1065.4619417194267, 1065.616378103882, 11155.776884462266, 11449.427528623535, 11559.711007224887, 11601.883981160081, 11727.648170554898, 485775.0, 490898.0, 492750.0, 496032.0, 502085.0, 123160.38419808022, 123587.0, 123735.0, 124442.37778811048, 125954.0, 1127.0814286356756, 1175.6825657072543, 1251.5056552661829, 1265.6013355792895, 1304.9934750326188, 20680.689789652868, 21341.573168536233, 22026.0, 22139.667904981117, 22615.0, 59982.700086501034, 60635.0, 61649.69175154275, 62236.37763622306, 63057.0, 68342.0, 68414.3158568408, 69982.0, 71586.0, 73041.6347918257, 14626.268686565416, 14996.175210363535, 15142.924285378502, 15156.848431515544, 15174.544763657108, 23613.173538926054, 23863.642045368986, 23943.880280598485, 24063.879680601483, 24224.51550969006, 18713.25146994105, 18726.53183670419, 19069.713954290975, 19114.33099841499, 19189.808101918803, 16914.66170676604, 16976.490705278862, 17359.392421265195, 17651.646967060842, 17744.733828992834, 19318.61362772765, 19336.93646849437, 19508.31720889762, 19670.0, 19707.40877773669, 14911.701765964837, 14968.877334200197, 15174.393024279347, 15231.086134831945, 15251.542453726406, 18453.53866153357, 18737.812621873607, 18785.718214226523, 18842.246310147442, 18890.622187556448], "value": 12342.854184760312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.4466196528442, 1396.04371005861, 1401.1102949626984, 1402.0115818348072, 1410.4851729118868, 13946.0, 14677.192754398504, 14694.118352898833, 14707.485238016672, 14722.0, 14793.92603036986, 15055.698886022274, 15073.773893391608, 15084.472043478481, 15085.396584136648, 2697.7302269773013, 2760.3375189954468, 2768.7784977201877, 2770.0581802187253, 2771.528840097178, 2549.2352294311727, 2639.142278759411, 2680.075373995968, 2681.4503026879543, 2688.502627013999, 2586.508563372953, 2617.685877694679, 2623.8950441982297, 2667.6932152802383, 2669.1191906670847, 2552.540542702313, 2574.909878154265, 2583.8191326607143, 2586.262915069215, 2586.6120081987665, 2541.1614167324738, 2542.364408897776, 2566.6021766626204, 2569.5117927593697, 2575.072973729456, 13889.79165312521, 13932.791008134885, 14001.159930404208, 14041.0, 14088.71822563543, 7451.32938035574, 7705.190954949761, 7740.6129693515095, 7745.496542724705, 7753.418493612945, 4876.804927802884, 5033.421156567005, 5067.961067981092, 5123.897522049576, 5131.640785145004, 1870.0, 1872.241742094454, 1919.2418994497234, 1919.9904000479908, 1939.0, 23102.884485577466, 23346.2996110117, 23362.883185584134, 23384.298471045895, 24030.639540406733, 6390.488760899117, 6518.771842985473, 6700.329967003358, 6701.463882889358, 6778.3221677831825, 16293.592660183353, 16301.103439310715, 16313.510594682179, 16316.836831631768, 16331.26509307084, 7539.32146106853, 7768.611569421506, 7769.805754856174, 7787.961060194662, 7798.103218129988, 6081.179040829431, 6207.875842483125, 6917.27368626287, 7097.396721278749, 7157.749478768323, 4847.5394837491085, 5026.472220416804, 5045.495450454925, 5082.466341034138, 5090.10923088458, 1498.4980031689288, 1512.8108986376703, 1513.0921447131634, 1515.1060874084344, 1520.9847901521064, 873.5850471026212, 906.4334790755778, 922.423485321674, 929.1405449958761, 934.4346670264392, 8276.751697449086, 8605.65577376898, 8612.311015118776, 8634.870476942851, 8643.35174861888, 994.049632828518, 1021.667957913681, 1024.8975102489692, 1033.204432586904, 1037.2790910317258, 5265.262863199156, 5712.65724056558, 5816.098504731774, 5833.358330583633, 5939.673317967553, 19660.311889083812, 20394.592108157754, 20614.58770824605, 20624.0, 20625.48436289105, 18886.716699249522, 20205.0, 20209.191632334543, 20227.696584551242, 20272.493187670425, 11038.558457661764, 11064.391458469861, 11336.94331528337, 11422.257553259178, 11426.371549564687, 8135.9186408135165, 8719.651213951625, 8977.461352318882, 9077.228435583049, 9165.358424910191, 17728.734068988717, 17955.192016359033, 18062.92930201895, 18063.638727225643, 18160.818391815912, 17978.01120938361, 17985.19066641978, 18094.72857907106, 18146.818531815043, 18207.271709132016, 11566.537338506365, 11999.40002999864, 12006.39968001579, 12010.519579216734, 12084.637460876187, 13422.39599218057, 13473.461061557427, 13539.0, 13559.525416610371, 13593.184408935496, 10952.123830093415, 10976.615818446317, 11115.666530004113, 11206.607768728056, 11209.719757005814, 10820.945895270474, 10890.128789696964, 10990.340579565252, 11065.889341106807, 11172.49723762449, 9491.857622135536, 9646.18007469373, 9647.0, 9647.903520964981, 9662.0, 7155.266393544646, 7260.673269702982, 7387.630618468947, 7519.962400187964, 7623.275788800055, 7366.77899663011, 7436.256374362737, 7498.437617178843, 7522.473426860067, 7571.697132114654], "value": 6553.840219956138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.20179707974563, 502.72852659563836, 521.2520033751564, 522.2870781383411, 523.834991977527, 6251.7499300028, 6256.781012664557, 6265.624062556244, 6322.525810564214, 6332.335104813986, 5935.465808077272, 6097.115918191859, 6134.957057300258, 6154.292256390517, 6194.318624951263, 4938.876528086791, 4952.380952380952, 4971.950280497185, 4988.900221995567, 5000.2747952775235, 4950.752462376885, 4965.950340496603, 4987.451380348159, 4999.175136102539, 5015.899682006358, 4773.64197685175, 4869.70781753096, 4894.412670479547, 4935.950640493603, 4942.678725882824, 4838.854834354975, 4857.708537487762, 4881.755912204411, 4908.386451693538, 4948.158813001798, 4415.271480205763, 4425.3140763181755, 4426.867193984153, 4443.133588950156, 4491.4161159049445, 6025.186599809013, 6032.577719559633, 6056.3338032816355, 6106.4809491192855, 6136.269360134742, 5570.275864137677, 5677.347105082927, 5707.400722924116, 5710.400407957146, 5745.08078707409, 6381.872362552723, 6397.904031439532, 6404.583702059351, 6476.352364763486, 6513.511486638521, 4845.830395936126, 4859.611231101539, 4871.6846451457905, 4877.244192090844, 4943.134951383529, 6876.0746990842645, 6884.862302753967, 6906.930930690729, 6941.548799328078, 6969.0, 4963.205887058053, 4973.950260497349, 4994.550490455804, 5009.66470708694, 5011.646855349035, 5067.391912970467, 5088.51659092393, 5098.898022039539, 5102.3877134743325, 5103.550295858009, 5669.291338582677, 5695.829125126253, 5709.800156994485, 5733.31200255972, 5740.339860916049, 6534.150560427114, 6559.311272316338, 6617.669116544153, 6629.701663425158, 6644.415353406134, 1690.1633691322875, 1714.7084995550786, 1716.8153973758067, 1752.2027477497709, 1789.9821001790076, 1206.957756478519, 1221.6518292286655, 1226.8650448450662, 1232.600997867427, 1242.465739731924, 5626.483447845097, 5676.943230567724, 5710.5146062585145, 5725.221353906401, 5769.480746732815, 6556.033190042968, 6565.179352580927, 6720.53892245494, 6724.193096828412, 6774.72901083961, 5820.563457740686, 5836.562257830595, 5846.23531821564, 5848.303991842403, 5853.7365818538265, 3609.0, 3609.9458508122398, 3616.9638303617153, 3638.799866007395, 3649.39784935488, 6502.707378167994, 6506.837329066811, 6546.672666366662, 6584.8024559263295, 6619.2056953164965, 6939.965300173568, 6947.444204463732, 7028.0, 7037.824054398681, 7065.293470652894, 6406.231252249667, 6562.80311590653, 6563.0, 6608.207015158212, 6663.6001839888795, 6740.169753163576, 6810.387065164159, 6822.829429264308, 6828.5220034597105, 6864.279250678806, 6659.234188068434, 6678.7328506859185, 6745.628990405575, 6785.423239024738, 6794.898076528955, 6514.446272066927, 6530.216374035146, 6558.80323590293, 6600.735970561316, 6634.402903738686, 4998.60011199096, 5036.546710796046, 5042.268871013755, 5043.798248070036, 5073.2897394365555, 6777.559458635173, 6809.250982392032, 6864.725410983505, 6913.5506192097355, 6966.686499107654, 6606.53754237218, 6651.63416012124, 6671.566348187546, 6671.666416679243, 6701.363370479797, 6500.837479063061, 6587.0, 6617.437517810848, 6646.202455705346, 6692.0, 6176.289726681489, 6290.528210384148, 6347.143135676624, 6429.145994773916, 6494.123293355526, 6504.1869766279215, 6558.245801732862, 6570.277269500256, 6618.437432818265, 6660.600363978177, 6298.968505157445, 6376.39424254695, 6422.903656445251, 6433.0, 6434.517411194272], "value": 5066.348531117119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [925.2644147902417, 932.4824722279136, 935.3873213045449, 940.0317672797022, 953.880764904387, 17510.82489175108, 17994.28022879085, 18009.18958646861, 18030.819691803077, 20840.687389689167, 20509.0, 21735.347939561798, 21961.890190549064, 22089.0, 22146.778532214714, 1015.558232169007, 1052.5894900988583, 1053.0890779475737, 1054.425338190684, 1054.6888667843004, 984.3945973226486, 1061.851340812287, 1062.1768129699506, 1065.4938904020566, 1066.855974443452, 1109.528450408577, 1111.3109871879446, 1112.1547623805884, 1112.365951407698, 1112.6383925224334, 1108.794872948499, 1109.944502774858, 1110.5058249079163, 1110.6723516562593, 1112.7774445110929, 813.4346629092782, 813.4875028731861, 814.1207495904409, 814.5479259011246, 818.6234332207192, 20207.19171233149, 20439.48901277465, 20642.48393790152, 20644.5871082579, 21061.262855799974, 21825.890870545703, 22228.11087556496, 22235.888820555956, 22236.55526889453, 22614.66078008831, 16881.577960550963, 17121.143942802933, 17385.739213911802, 17429.21568529419, 17492.0, 3647.8358473868475, 3669.944950825713, 3673.1735359544155, 3674.136577904217, 3674.6876515496215, 130100.34949825285, 130214.0, 130340.3482982579, 131666.0, 134992.32503837516, 17176.484705458857, 17343.0, 17355.3057877686, 17391.391301304393, 17482.562935926704, 30127.548086778716, 32233.194170145463, 32463.675363246064, 32509.349813003606, 32583.51124733131, 7589.962050189824, 8038.794180872916, 8360.958195208985, 8701.042885282613, 8797.956010219908, 4018.176273863851, 4083.285425050664, 4094.6519545838937, 4108.712390132662, 4132.111596006873, 5305.124654432053, 5341.679499230058, 5386.434424385461, 5438.5377242934, 5440.782368705287, 1106.1040557148735, 1113.3932007056173, 1123.8314252861971, 1129.0403157316216, 1131.6378758797107, 690.19247480448, 693.4833549006023, 699.5872435263219, 716.1620903542868, 721.4913485992363, 11803.763924721457, 11995.940020299842, 12143.0, 12922.67693307656, 13438.529651462151, 695.2491309385852, 695.5652717051843, 700.58315302395, 712.2094475132599, 713.579375767128, 5785.0, 5880.176775251382, 5908.645481271137, 6087.995480745716, 6195.16365290689, 116091.0, 118345.0, 119814.40092799481, 119939.0, 120489.0, 101031.0, 103661.0, 103936.0, 104466.0, 105625.0, 87408.0, 87453.56273218594, 87817.56091219503, 88936.0, 92365.07634923699, 10863.0, 10872.510737016695, 10908.890911091104, 11072.557097716324, 11383.829242561202, 39771.40342894917, 40550.59449405586, 41126.38310425286, 41496.792516037225, 42476.0, 72438.0, 73827.63086184535, 74003.0, 75016.0, 76142.61928690321, 19016.904915475334, 19111.0, 19116.808831912058, 19356.225750969803, 19435.902820485808, 22501.437464062874, 22635.886820565793, 22859.428514287276, 22927.0, 23180.420489487897, 18917.43247702571, 18984.620307593494, 19305.0, 19557.413277601696, 19850.305239316556, 20128.09423575972, 20154.29459968894, 20249.0, 20266.392008239778, 20887.58224835525, 18712.25150993945, 19568.0, 19707.802921970597, 19772.505687357356, 19876.801231987494, 12627.11610187278, 13395.799063013868, 13703.725925481634, 13784.655383615489, 13801.0, 14389.712205756035, 14939.850601494281, 15407.306671200047, 15477.303521341342, 15675.294611742727], "value": 9517.660206660243, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 103.0, 107.0, 108.0, 109.0, 113.0, 100.0, 108.0, 107.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 148.0, 185.0, 118.0, 144.0, 149.0, 124.0, 187.0, 118.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 169.0, 164.0, 165.0, 170.0, 164.0, 164.0, 167.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 80.0, 76.0, 76.0, 76.0, 156.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 135.0, 84.0, 84.0, 80.0, 129.0, 82.0, 82.0, 136.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 114.0, 114.0, 114.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 155.0, 153.0, 151.0, 151.0, 150.0, 148.0, 151.0, 152.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 94.0, 94.0, 99.0, 99.0, 94.0, 94.0, 93.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 54.0, 55.0, 54.0, 59.0, 59.0, 62.0, 55.0, 59.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 61.0, 56.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 83.0, 77.0, 79.0, 78.0, 78.0, 85.0, 94.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 127.0, 125.0, 134.0, 125.0, 139.0, 125.0, 128.0, 168.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 201.0, 189.0, 174.0, 179.0, 180.0, 175.0, 189.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 72.0, 69.0, 74.0, 70.0, 73.0, 68.0, 70.0, 67.0], "value": 70.4, "unit": "score"}]}]} 17:45:19 INFO - Return code: 0 17:45:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:45:19 INFO - # TBPL SUCCESS # 17:45:19 INFO - Running post-action listener: _package_coverage_data 17:45:19 INFO - Running post-action listener: _resource_record_post_action 17:45:19 INFO - [mozharness: 2017-08-14 00:45:19.780127Z] Finished run-tests step (success) 17:45:19 INFO - Running post-run listener: _resource_record_post_run 17:45:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 430522368; Read time: 12; Write time: 456452 17:45:19 INFO - TinderboxPrint: CPU usage
13.2% 17:45:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:45:19 INFO - TinderboxPrint: I/O write bytes / time
430,522,368 / 456,452 17:45:19 INFO - TinderboxPrint: CPU idle
8,270.8 (86.8%) 17:45:19 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 17:45:19 INFO - TinderboxPrint: Swap in / out
0 / 0 17:45:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108658688; Read time: 0; Write time: 141376 17:45:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:45:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 321863680; Read time: 0; Write time: 315076 17:45:20 INFO - Running post-run listener: _upload_blobber_files 17:45:20 INFO - Blob upload gear active. 17:45:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:20 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 17:45:20 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'] 17:45:20 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 17:45:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:45:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:21 INFO - (blobuploader) - INFO - Done attempting. 17:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:22 INFO - (blobuploader) - INFO - Done attempting. 17:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:23 INFO - (blobuploader) - INFO - Done attempting. 17:45:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:45:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:30 INFO - (blobuploader) - INFO - Done attempting. 17:45:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:30 INFO - Return code: 0 17:45:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f199c9643448185852bf13571e59ff86067932ae955bacfc1f91a1a57799eb5ebb7a2dea6b5d2c9055b33c6e1e971385df1c62a300c5e3ede6aec491061c3b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc6c7d9240228d9ea0eb89c17590e8a9750163177f25efab2553b0c011c4214b81b455f8ea01a6166010d70bb8f3d26c636d9c19ae7cfd01db6d0c2b93ce5eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbc04d81aac536f993948cd1fefc340b40ea2c91b6e934dc6f80f62d04b30333b55b6048e5e81d97317bc500200a1d7f1f7d32c830cf691385717a25913d813", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83ff4c7135a95646e8f9fa9cc79c5e65bac43b7b4a61b6ad5e2b6ebc7f7d2f5e48d0526a6eb9fda13281ec1c9192c813e1cd9aedd0d77c11093da3a2c25f4350"} 17:45:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:30 INFO - Contents: 17:45:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f199c9643448185852bf13571e59ff86067932ae955bacfc1f91a1a57799eb5ebb7a2dea6b5d2c9055b33c6e1e971385df1c62a300c5e3ede6aec491061c3b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc6c7d9240228d9ea0eb89c17590e8a9750163177f25efab2553b0c011c4214b81b455f8ea01a6166010d70bb8f3d26c636d9c19ae7cfd01db6d0c2b93ce5eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbc04d81aac536f993948cd1fefc340b40ea2c91b6e934dc6f80f62d04b30333b55b6048e5e81d97317bc500200a1d7f1f7d32c830cf691385717a25913d813", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83ff4c7135a95646e8f9fa9cc79c5e65bac43b7b4a61b6ad5e2b6ebc7f7d2f5e48d0526a6eb9fda13281ec1c9192c813e1cd9aedd0d77c11093da3a2c25f4350"} 17:45:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:30 INFO - Copying logs to upload dir... 17:45:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.121069 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-13 17:45:29.479873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:29.484712) ========= 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=781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f199c9643448185852bf13571e59ff86067932ae955bacfc1f91a1a57799eb5ebb7a2dea6b5d2c9055b33c6e1e971385df1c62a300c5e3ede6aec491061c3b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc6c7d9240228d9ea0eb89c17590e8a9750163177f25efab2553b0c011c4214b81b455f8ea01a6166010d70bb8f3d26c636d9c19ae7cfd01db6d0c2b93ce5eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbc04d81aac536f993948cd1fefc340b40ea2c91b6e934dc6f80f62d04b30333b55b6048e5e81d97317bc500200a1d7f1f7d32c830cf691385717a25913d813", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83ff4c7135a95646e8f9fa9cc79c5e65bac43b7b4a61b6ad5e2b6ebc7f7d2f5e48d0526a6eb9fda13281ec1c9192c813e1cd9aedd0d77c11093da3a2c25f4350"} build_url:https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f199c9643448185852bf13571e59ff86067932ae955bacfc1f91a1a57799eb5ebb7a2dea6b5d2c9055b33c6e1e971385df1c62a300c5e3ede6aec491061c3b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc6c7d9240228d9ea0eb89c17590e8a9750163177f25efab2553b0c011c4214b81b455f8ea01a6166010d70bb8f3d26c636d9c19ae7cfd01db6d0c2b93ce5eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbc04d81aac536f993948cd1fefc340b40ea2c91b6e934dc6f80f62d04b30333b55b6048e5e81d97317bc500200a1d7f1f7d32c830cf691385717a25913d813", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83ff4c7135a95646e8f9fa9cc79c5e65bac43b7b4a61b6ad5e2b6ebc7f7d2f5e48d0526a6eb9fda13281ec1c9192c813e1cd9aedd0d77c11093da3a2c25f4350"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:29.511984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:29.512328) ========= 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=781b77c4c33858b1f599d705000001c1-1502653100.493457-1715964164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:29.592234) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 17:45:29.595559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 17:45:29.595858) ========= ========= Total master_lag: -0.00 =========