builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1501547840.4 results: success (0) revision: 8b19670d12fde57d3aee50a5a7d1c734d9b709d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.400145) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.400916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.401198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.453921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.454222) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 17:37:21-- 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% 222M=0s 2017-07-31 17:37:21 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148246 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.635745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.636059) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014679 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:20.704392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 17:37:20.704726) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b19670d12fde57d3aee50a5a7d1c734d9b709d5 --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 8b19670d12fde57d3aee50a5a7d1c734d9b709d5 --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=7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 17:37:21,459 truncating revision to first 12 chars 2017-07-31 17:37:21,459 Setting DEBUG logging. 2017-07-31 17:37:21,459 attempt 1/10 2017-07-31 17:37:21,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b19670d12fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 17:37:22,389 unpacking tar archive at: mozilla-central-8b19670d12fd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 17:37:22.052988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:22.053272) ========= script_repo_revision: 8b19670d12fde57d3aee50a5a7d1c734d9b709d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:22.053638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:22.053916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 17:37:22.060251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-07-31 17:37:22.060516) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:37:22 INFO - MultiFileLogger online at 20170731 17:37:22 in /builds/slave/test 17:37:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:37:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:22 INFO - {'append_to_log': False, 17:37:22 INFO - 'base_work_dir': '/builds/slave/test', 17:37:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:37:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:22 INFO - 'branch': 'Firefox-Non-PGO', 17:37:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:22 INFO - 'code_coverage': False, 17:37:22 INFO - 'config_files': ('talos/linux_config.py',), 17:37:22 INFO - 'default_actions': ('clobber', 17:37:22 INFO - 'read-buildbot-config', 17:37:22 INFO - 'download-and-extract', 17:37:22 INFO - 'populate-webroot', 17:37:22 INFO - 'create-virtualenv', 17:37:22 INFO - 'install', 17:37:22 INFO - 'setup-mitmproxy', 17:37:22 INFO - 'run-tests'), 17:37:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:22 INFO - 'disable_ccov_upload': False, 17:37:22 INFO - 'download_minidump_stackwalk': True, 17:37:22 INFO - 'download_symbols': 'ondemand', 17:37:22 INFO - 'enable_stylo': False, 17:37:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:22 INFO - 'gecko_profile': False, 17:37:22 INFO - 'gecko_profile_interval': 0, 17:37:22 INFO - 'installer_path': 'installer.exe', 17:37:22 INFO - 'log_level': 'info', 17:37:22 INFO - 'log_name': 'talos', 17:37:22 INFO - 'log_to_console': True, 17:37:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:37:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:37:22 INFO - 'opt_config_files': (), 17:37:22 INFO - 'pip_index': False, 17:37:22 INFO - 'suite': 'dromaeojs-e10s', 17:37:22 INFO - 'system_bits': '32', 17:37:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:22 INFO - 'title': 'talos-linux64-ix-005', 17:37:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:22 INFO - 'use_talos_json': True, 17:37:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:22 INFO - 'work_dir': 'build'} 17:37:22 INFO - [mozharness: 2017-08-01 00:37:22.922874Z] Running clobber step. 17:37:22 INFO - Running pre-action listener: _resource_record_pre_action 17:37:22 INFO - Running main action method: clobber 17:37:22 INFO - rmtree: /builds/slave/test/build 17:37:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:23 INFO - Running post-action listener: _resource_record_post_action 17:37:23 INFO - [mozharness: 2017-08-01 00:37:23.959201Z] Finished clobber step (success) 17:37:23 INFO - [mozharness: 2017-08-01 00:37:23.959305Z] Running read-buildbot-config step. 17:37:23 INFO - Running pre-action listener: _resource_record_pre_action 17:37:23 INFO - Running main action method: read_buildbot_config 17:37:23 INFO - Using buildbot properties: 17:37:23 INFO - { 17:37:23 INFO - "project": "", 17:37:23 INFO - "product": "firefox", 17:37:23 INFO - "who": "kwierso@gmail.com", 17:37:23 INFO - "installer_path": "public/build/target.tar.bz2", 17:37:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:37:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:37:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:37:23 INFO - "stage_platform": "linux64", 17:37:23 INFO - "basedir": "/builds/slave/test", 17:37:23 INFO - "buildnumber": 1049, 17:37:23 INFO - "platform": "ubuntu64_hw", 17:37:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:37:23 INFO - "slavebuilddir": "test", 17:37:23 INFO - "taskId": "MLJHhu22TnOf8T6fric5oA", 17:37:23 INFO - "branch": "mozilla-central", 17:37:23 INFO - "script_repo_revision": "production", 17:37:23 INFO - "revision": "8b19670d12fde57d3aee50a5a7d1c734d9b709d5", 17:37:23 INFO - "slavename": "talos-linux64-ix-005", 17:37:23 INFO - "repo_path": "mozilla-central" 17:37:23 INFO - } 17:37:23 INFO - Finding installer, test and symbols from parent task. 17:37:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLJHhu22TnOf8T6fric5oA'}, attempt #1 17:37:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLJHhu22TnOf8T6fric5oA'}, attempt #1 17:37:24 INFO - Task dependencies: DsdJJjUsSgahxwFgH6hwYA 17:37:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA'}, attempt #1 17:37:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2 17:37:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.test_packages.json 17:37:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.crashreporter-symbols.zip 17:37:25 INFO - Running post-action listener: _resource_record_post_action 17:37:25 INFO - [mozharness: 2017-08-01 00:37:25.340537Z] Finished read-buildbot-config step (success) 17:37:25 INFO - [mozharness: 2017-08-01 00:37:25.340757Z] Running download-and-extract step. 17:37:25 INFO - Running pre-action listener: _resource_record_pre_action 17:37:25 INFO - Running main action method: download_and_extract 17:37:25 INFO - mkdir: /builds/slave/test/build/tests 17:37:25 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:37:25 INFO - trying https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.test_packages.json 17:37:25 INFO - Downloading https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:37:25 INFO - Downloaded 989 bytes. 17:37:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:37:25 INFO - Using the following test package requirements: 17:37:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:37:25 INFO - u'common': [u'target.common.tests.zip'], 17:37:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:37:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:37:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:37:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:37:25 INFO - u'mozbase': [u'target.common.tests.zip'], 17:37:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:37:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:37:25 INFO - u'web-platform': [u'target.common.tests.zip', 17:37:25 INFO - u'target.web-platform.tests.tar.gz'], 17:37:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:37:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:37:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.common.tests.zip 17:37:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:37:25 INFO - Fetch https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.common.tests.zip into memory 17:37:28 INFO - Content-Length response header: 72389642 17:37:28 INFO - Bytes received: 72389642 17:37:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:37:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.common.tests.zip 17:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.common.tests.zip into memory 17:37:42 INFO - Content-Length response header: 72389642 17:37:42 INFO - Bytes received: 72389642 17:37:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.talos.tests.zip 17:37:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:37:54 INFO - Fetch https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.talos.tests.zip into memory 17:37:55 INFO - Content-Length response header: 14496467 17:37:55 INFO - Bytes received: 14496467 17:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:55 INFO - trying https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2 17:37:55 INFO - Downloading https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:37:57 INFO - Downloaded 62118329 bytes. 17:37:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2 17:37:57 INFO - mkdir: /builds/slave/test/properties 17:37:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:37:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:37:57 INFO - Contents: 17:37:57 INFO - build_url:https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2 17:37:57 INFO - Running post-action listener: _resource_record_post_action 17:37:57 INFO - Running post-action listener: set_extra_try_arguments 17:37:57 INFO - [mozharness: 2017-08-01 00:37:57.315977Z] Finished download-and-extract step (success) 17:37:57 INFO - [mozharness: 2017-08-01 00:37:57.316207Z] Running populate-webroot step. 17:37:57 INFO - Running pre-action listener: _resource_record_pre_action 17:37:57 INFO - Running main action method: populate_webroot 17:37:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:37:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:37:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:37:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:37:57 INFO - 'tests': ['damp', 'tps']}, 17:37:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:37:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:37:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:37:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:37:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:37:57 INFO - 'ts_paint', 17:37:57 INFO - 'tpaint', 17:37:57 INFO - 'sessionrestore', 17:37:57 INFO - 'sessionrestore_many_windows', 17:37:57 INFO - 'sessionrestore_no_auto_restore', 17:37:57 INFO - 'tabpaint']}, 17:37:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:37:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:37:57 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:37:57 INFO - 'talos_options': ['--mitmproxy', 17:37:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:37:57 INFO - '--firstNonBlankPaint'], 17:37:57 INFO - 'tests': ['quantum_pageload_google', 17:37:57 INFO - 'quantum_pageload_youtube', 17:37:57 INFO - 'quantum_pageload_amazon', 17:37:57 INFO - 'quantum_pageload_facebook']}, 17:37:57 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:37:57 INFO - 'talos_options': ['--stylo', 17:37:57 INFO - '--mitmproxy', 17:37:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:37:57 INFO - '--firstNonBlankPaint'], 17:37:57 INFO - 'tests': ['quantum_pageload_google', 17:37:57 INFO - 'quantum_pageload_youtube', 17:37:57 INFO - 'quantum_pageload_amazon', 17:37:57 INFO - 'quantum_pageload_facebook']}, 17:37:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:37:57 INFO - 'tsvgr_opacity', 17:37:57 INFO - 'tart', 17:37:57 INFO - 'tscrollx', 17:37:57 INFO - 'cart', 17:37:57 INFO - 'tsvg_static']}, 17:37:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:37:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:37:57 INFO - 'talos_options': ['--stylo', 17:37:57 INFO - '--stylo-threads=1', 17:37:57 INFO - '--mitmproxy', 17:37:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:37:57 INFO - '--firstNonBlankPaint'], 17:37:57 INFO - 'tests': ['tp6_google', 17:37:57 INFO - 'tp6_youtube', 17:37:57 INFO - 'tp6_amazon', 17:37:57 INFO - 'tp6_facebook']}, 17:37:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:37:57 INFO - 'talos_options': ['--xperf_path', 17:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:37:57 INFO - 'tests': ['tp5n']}}} 17:37:57 INFO - Running post-action listener: _resource_record_post_action 17:37:57 INFO - [mozharness: 2017-08-01 00:37:57.330585Z] Finished populate-webroot step (success) 17:37:57 INFO - [mozharness: 2017-08-01 00:37:57.330676Z] Running create-virtualenv step. 17:37:57 INFO - Running pre-action listener: _resource_record_pre_action 17:37:57 INFO - Running main action method: create_virtualenv 17:37:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:37:57 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:37:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:37:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:37:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:37:57 INFO - Using real prefix '/usr' 17:37:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:37:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:37:59 INFO - Installing pip.................done. 17:37:59 INFO - Return code: 0 17:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:38:00 INFO - Reading from file tmpfile_stdout 17:38:00 INFO - Output received: 17:38:00 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:38:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:00 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:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:00 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:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:00 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:00 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:38:00 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:38:00 INFO - Using env: {'DISPLAY': ':0', 17:38:00 INFO - 'HOME': '/home/cltbld', 17:38:00 INFO - 'LANG': 'en_US.UTF-8', 17:38:00 INFO - 'LANGUAGE': 'en_US:en', 17:38:00 INFO - 'LOGNAME': 'cltbld', 17:38:00 INFO - 'MAIL': '/var/mail/cltbld', 17:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:00 INFO - 'MOZ_NO_REMOTE': '1', 17:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:00 INFO - 'NO_EM_RESTART': '1', 17:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:00 INFO - 'PWD': '/builds/slave/test', 17:38:00 INFO - 'SHELL': '/bin/bash', 17:38:00 INFO - 'SHLVL': '1', 17:38:00 INFO - 'TERM': 'linux', 17:38:00 INFO - 'TMOUT': '86400', 17:38:00 INFO - 'USER': 'cltbld', 17:38:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:00 INFO - '_': '/tools/buildbot/bin/python'} 17:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:00 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:38:00 INFO - Cleaning up... 17:38:00 INFO - Return code: 0 17:38:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:38:00 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:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:00 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:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:00 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:00 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:38:00 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:38:00 INFO - Using env: {'DISPLAY': ':0', 17:38:00 INFO - 'HOME': '/home/cltbld', 17:38:00 INFO - 'LANG': 'en_US.UTF-8', 17:38:00 INFO - 'LANGUAGE': 'en_US:en', 17:38:00 INFO - 'LOGNAME': 'cltbld', 17:38:00 INFO - 'MAIL': '/var/mail/cltbld', 17:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:00 INFO - 'MOZ_NO_REMOTE': '1', 17:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:00 INFO - 'NO_EM_RESTART': '1', 17:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:00 INFO - 'PWD': '/builds/slave/test', 17:38:00 INFO - 'SHELL': '/bin/bash', 17:38:00 INFO - 'SHLVL': '1', 17:38:00 INFO - 'TERM': 'linux', 17:38:00 INFO - 'TMOUT': '86400', 17:38:00 INFO - 'USER': 'cltbld', 17:38:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:00 INFO - '_': '/tools/buildbot/bin/python'} 17:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:00 INFO - Downloading/unpacking psutil>=3.1.1 17:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:01 INFO - Installing collected packages: psutil 17:38:01 INFO - Running setup.py install for psutil 17:38:01 INFO - building 'psutil._psutil_linux' extension 17:38:01 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:38:01 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:38:02 INFO - building 'psutil._psutil_posix' extension 17:38:02 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:38:02 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:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:02 INFO - Successfully installed psutil 17:38:02 INFO - Cleaning up... 17:38:02 INFO - Return code: 0 17:38:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:38: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:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38: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:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:02 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:02 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:38:02 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:38:02 INFO - Using env: {'DISPLAY': ':0', 17:38:02 INFO - 'HOME': '/home/cltbld', 17:38:02 INFO - 'LANG': 'en_US.UTF-8', 17:38:02 INFO - 'LANGUAGE': 'en_US:en', 17:38:02 INFO - 'LOGNAME': 'cltbld', 17:38:02 INFO - 'MAIL': '/var/mail/cltbld', 17:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:02 INFO - 'MOZ_NO_REMOTE': '1', 17:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:02 INFO - 'NO_EM_RESTART': '1', 17:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:02 INFO - 'PWD': '/builds/slave/test', 17:38:02 INFO - 'SHELL': '/bin/bash', 17:38:02 INFO - 'SHLVL': '1', 17:38:02 INFO - 'TERM': 'linux', 17:38:02 INFO - 'TMOUT': '86400', 17:38:02 INFO - 'USER': 'cltbld', 17:38:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:02 INFO - '_': '/tools/buildbot/bin/python'} 17:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:38:02 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:38:02 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:38:02 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:38:02 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:38:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:38:03 INFO - Installing collected packages: mozsystemmonitor 17:38:03 INFO - Running setup.py install for mozsystemmonitor 17:38:03 INFO - Successfully installed mozsystemmonitor 17:38:03 INFO - Cleaning up... 17:38:03 INFO - Return code: 0 17:38:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:38:03 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:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:03 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:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:03 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:03 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:38:03 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:38:03 INFO - Using env: {'DISPLAY': ':0', 17:38:03 INFO - 'HOME': '/home/cltbld', 17:38:03 INFO - 'LANG': 'en_US.UTF-8', 17:38:03 INFO - 'LANGUAGE': 'en_US:en', 17:38:03 INFO - 'LOGNAME': 'cltbld', 17:38:03 INFO - 'MAIL': '/var/mail/cltbld', 17:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:03 INFO - 'MOZ_NO_REMOTE': '1', 17:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:03 INFO - 'NO_EM_RESTART': '1', 17:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:03 INFO - 'PWD': '/builds/slave/test', 17:38:03 INFO - 'SHELL': '/bin/bash', 17:38:03 INFO - 'SHLVL': '1', 17:38:03 INFO - 'TERM': 'linux', 17:38:03 INFO - 'TMOUT': '86400', 17:38:03 INFO - 'USER': 'cltbld', 17:38:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:03 INFO - '_': '/tools/buildbot/bin/python'} 17:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:03 INFO - Downloading/unpacking jsonschema==2.5.1 17:38:03 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:38:03 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:38:03 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:38:03 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:38:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:38:05 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:38:05 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:38:05 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:38:05 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:38:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:05 INFO - warning: no files found matching '*.txt' 17:38:05 INFO - no previously-included directories found matching 'build' 17:38:05 INFO - no previously-included directories found matching 'dist' 17:38:05 INFO - no previously-included directories found matching '.git*' 17:38:05 INFO - Installing collected packages: jsonschema, functools32 17:38:05 INFO - Running setup.py install for functools32 17:38:05 INFO - warning: no files found matching '*.txt' 17:38:05 INFO - no previously-included directories found matching 'build' 17:38:05 INFO - no previously-included directories found matching 'dist' 17:38:05 INFO - no previously-included directories found matching '.git*' 17:38:05 INFO - Successfully installed jsonschema functools32 17:38:05 INFO - Cleaning up... 17:38:05 INFO - Return code: 0 17:38:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:05 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:05 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:38:05 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:38:05 INFO - Using env: {'DISPLAY': ':0', 17:38:05 INFO - 'HOME': '/home/cltbld', 17:38:05 INFO - 'LANG': 'en_US.UTF-8', 17:38:05 INFO - 'LANGUAGE': 'en_US:en', 17:38:05 INFO - 'LOGNAME': 'cltbld', 17:38:05 INFO - 'MAIL': '/var/mail/cltbld', 17:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:05 INFO - 'MOZ_NO_REMOTE': '1', 17:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:05 INFO - 'NO_EM_RESTART': '1', 17:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:05 INFO - 'PWD': '/builds/slave/test', 17:38:05 INFO - 'SHELL': '/bin/bash', 17:38:05 INFO - 'SHLVL': '1', 17:38:05 INFO - 'TERM': 'linux', 17:38:05 INFO - 'TMOUT': '86400', 17:38:05 INFO - 'USER': 'cltbld', 17:38:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:05 INFO - '_': '/tools/buildbot/bin/python'} 17:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:38:05 INFO - Cleaning up... 17:38:05 INFO - Return code: 0 17:38:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:05 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:05 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:38:05 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:38:05 INFO - Using env: {'DISPLAY': ':0', 17:38:05 INFO - 'HOME': '/home/cltbld', 17:38:05 INFO - 'LANG': 'en_US.UTF-8', 17:38:05 INFO - 'LANGUAGE': 'en_US:en', 17:38:05 INFO - 'LOGNAME': 'cltbld', 17:38:05 INFO - 'MAIL': '/var/mail/cltbld', 17:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:05 INFO - 'MOZ_NO_REMOTE': '1', 17:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:05 INFO - 'NO_EM_RESTART': '1', 17:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:05 INFO - 'PWD': '/builds/slave/test', 17:38:05 INFO - 'SHELL': '/bin/bash', 17:38:05 INFO - 'SHLVL': '1', 17:38:05 INFO - 'TERM': 'linux', 17:38:05 INFO - 'TMOUT': '86400', 17:38:05 INFO - 'USER': 'cltbld', 17:38:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:05 INFO - '_': '/tools/buildbot/bin/python'} 17:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:05 INFO - Downloading/unpacking blobuploader==1.2.4 17:38:05 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:38:05 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:38:05 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:38:05 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:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38: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:38: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:38: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:38: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:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38: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:38: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:38: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:38: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:38:07 INFO - Downloading docopt-0.6.1.tar.gz 17:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:07 INFO - Running setup.py install for blobuploader 17:38:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:07 INFO - Running setup.py install for requests 17:38:07 INFO - Running setup.py install for docopt 17:38:08 INFO - Successfully installed blobuploader requests docopt 17:38:08 INFO - Cleaning up... 17:38:08 INFO - Return code: 0 17:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38: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:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38: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:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:08 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:08 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:38:08 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:38:08 INFO - Using env: {'DISPLAY': ':0', 17:38:08 INFO - 'HOME': '/home/cltbld', 17:38:08 INFO - 'LANG': 'en_US.UTF-8', 17:38:08 INFO - 'LANGUAGE': 'en_US:en', 17:38:08 INFO - 'LOGNAME': 'cltbld', 17:38:08 INFO - 'MAIL': '/var/mail/cltbld', 17:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:08 INFO - 'MOZ_NO_REMOTE': '1', 17:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:08 INFO - 'NO_EM_RESTART': '1', 17:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:08 INFO - 'PWD': '/builds/slave/test', 17:38:08 INFO - 'SHELL': '/bin/bash', 17:38:08 INFO - 'SHLVL': '1', 17:38:08 INFO - 'TERM': 'linux', 17:38:08 INFO - 'TMOUT': '86400', 17:38:08 INFO - 'USER': 'cltbld', 17:38:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:08 INFO - '_': '/tools/buildbot/bin/python'} 17:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:08 INFO - Running setup.py (path:/tmp/pip-QX94u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:08 INFO - Running setup.py (path:/tmp/pip-2L5kJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:08 INFO - Running setup.py (path:/tmp/pip-ByON4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:08 INFO - Running setup.py (path:/tmp/pip-fe0WFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:08 INFO - Running setup.py (path:/tmp/pip-Y5njlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:08 INFO - Running setup.py (path:/tmp/pip-HeIqNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:08 INFO - Running setup.py (path:/tmp/pip-4sALq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:08 INFO - Running setup.py (path:/tmp/pip-WcayKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:08 INFO - Running setup.py (path:/tmp/pip-keMAGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:08 INFO - Running setup.py (path:/tmp/pip-AB9rNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:09 INFO - Running setup.py (path:/tmp/pip-OcR2zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:09 INFO - Running setup.py (path:/tmp/pip-Iobfn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:09 INFO - Running setup.py (path:/tmp/pip-98jfsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:09 INFO - Running setup.py (path:/tmp/pip-2QQu8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:09 INFO - Running setup.py (path:/tmp/pip-BlL8z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:09 INFO - Running setup.py (path:/tmp/pip-SxqAY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:09 INFO - Running setup.py (path:/tmp/pip-MO7p9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:38:09 INFO - Running setup.py install for manifestparser 17:38:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:38:09 INFO - Running setup.py install for mozcrash 17:38:09 INFO - Running setup.py install for mozdebug 17:38:09 INFO - Running setup.py install for mozdevice 17:38:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:38:09 INFO - Running setup.py install for mozfile 17:38:10 INFO - Running setup.py install for mozhttpd 17:38:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Running setup.py install for mozinfo 17:38:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Running setup.py install for mozInstall 17:38:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Running setup.py install for mozleak 17:38:10 INFO - Running setup.py install for mozlog 17:38:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Running setup.py install for moznetwork 17:38:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Running setup.py install for mozprocess 17:38:10 INFO - Running setup.py install for mozprofile 17:38:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:38:10 INFO - Running setup.py install for mozrunner 17:38:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:38:11 INFO - Running setup.py install for mozscreenshot 17:38:11 INFO - Running setup.py install for moztest 17:38:11 INFO - Running setup.py install for mozversion 17:38:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:38:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:38:11 INFO - Cleaning up... 17:38:11 INFO - Return code: 0 17:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:11 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:11 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:38:11 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:38:11 INFO - Using env: {'DISPLAY': ':0', 17:38:11 INFO - 'HOME': '/home/cltbld', 17:38:11 INFO - 'LANG': 'en_US.UTF-8', 17:38:11 INFO - 'LANGUAGE': 'en_US:en', 17:38:11 INFO - 'LOGNAME': 'cltbld', 17:38:11 INFO - 'MAIL': '/var/mail/cltbld', 17:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:11 INFO - 'MOZ_NO_REMOTE': '1', 17:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:11 INFO - 'NO_EM_RESTART': '1', 17:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:11 INFO - 'PWD': '/builds/slave/test', 17:38:11 INFO - 'SHELL': '/bin/bash', 17:38:11 INFO - 'SHLVL': '1', 17:38:11 INFO - 'TERM': 'linux', 17:38:11 INFO - 'TMOUT': '86400', 17:38:11 INFO - 'USER': 'cltbld', 17:38:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:11 INFO - '_': '/tools/buildbot/bin/python'} 17:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:11 INFO - Running setup.py (path:/tmp/pip-UQzDBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:11 INFO - Running setup.py (path:/tmp/pip-hvilcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:11 INFO - Running setup.py (path:/tmp/pip-cXNn0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:11 INFO - Running setup.py (path:/tmp/pip-tF2BLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:11 INFO - Running setup.py (path:/tmp/pip-8x4c0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:11 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:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:11 INFO - Running setup.py (path:/tmp/pip-v8Sz9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:12 INFO - Running setup.py (path:/tmp/pip-VCKGwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:12 INFO - Running setup.py (path:/tmp/pip-Eumwgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:12 INFO - Running setup.py (path:/tmp/pip-daWWSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:12 INFO - Running setup.py (path:/tmp/pip-MTQvWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:12 INFO - Running setup.py (path:/tmp/pip-j6Vp1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:12 INFO - Running setup.py (path:/tmp/pip-Dsuh6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:12 INFO - Running setup.py (path:/tmp/pip-tl0R_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:12 INFO - Running setup.py (path:/tmp/pip-pIv69D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:12 INFO - Running setup.py (path:/tmp/pip-4CCUjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:12 INFO - Running setup.py (path:/tmp/pip-aKC1dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:12 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:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:12 INFO - Running setup.py (path:/tmp/pip-Z6vIIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:38: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:38: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:38: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:38: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:38:13 INFO - Downloading blessings-1.6.tar.gz 17:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:13 INFO - Installing collected packages: blessings 17:38:13 INFO - Running setup.py install for blessings 17:38:14 INFO - Successfully installed blessings 17:38:14 INFO - Cleaning up... 17:38:14 INFO - Return code: 0 17:38:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:14 INFO - Reading from file tmpfile_stdout 17:38:14 INFO - Current package versions: 17:38:14 INFO - argparse == 1.2.1 17:38:14 INFO - blessings == 1.6 17:38:14 INFO - blobuploader == 1.2.4 17:38:14 INFO - docopt == 0.6.1 17:38:14 INFO - functools32 == 3.2.3-2 17:38:14 INFO - jsonschema == 2.5.1 17:38:14 INFO - manifestparser == 1.1 17:38:14 INFO - mozInstall == 1.13 17:38:14 INFO - mozcrash == 1.0 17:38:14 INFO - mozdebug == 0.1 17:38:14 INFO - mozdevice == 0.51 17:38:14 INFO - mozfile == 1.2 17:38:14 INFO - mozhttpd == 0.7 17:38:14 INFO - mozinfo == 0.10 17:38:14 INFO - mozleak == 0.1 17:38:14 INFO - mozlog == 3.5 17:38:14 INFO - moznetwork == 0.27 17:38:14 INFO - mozprocess == 0.25 17:38:14 INFO - mozprofile == 0.28 17:38:14 INFO - mozrunner == 6.13 17:38:14 INFO - mozscreenshot == 0.1 17:38:14 INFO - mozsystemmonitor == 0.3 17:38:14 INFO - moztest == 0.8 17:38:14 INFO - mozversion == 1.4 17:38:14 INFO - psutil == 3.1.1 17:38:14 INFO - requests == 1.2.3 17:38:14 INFO - wsgiref == 0.1.2 17:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:14 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:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:14 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:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:14 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:14 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:38:14 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:38:14 INFO - Using env: {'DISPLAY': ':0', 17:38:14 INFO - 'HOME': '/home/cltbld', 17:38:14 INFO - 'LANG': 'en_US.UTF-8', 17:38:14 INFO - 'LANGUAGE': 'en_US:en', 17:38:14 INFO - 'LOGNAME': 'cltbld', 17:38:14 INFO - 'MAIL': '/var/mail/cltbld', 17:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:14 INFO - 'MOZ_NO_REMOTE': '1', 17:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:14 INFO - 'NO_EM_RESTART': '1', 17:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:14 INFO - 'PWD': '/builds/slave/test', 17:38:14 INFO - 'SHELL': '/bin/bash', 17:38:14 INFO - 'SHLVL': '1', 17:38:14 INFO - 'TERM': 'linux', 17:38:14 INFO - 'TMOUT': '86400', 17:38:14 INFO - 'USER': 'cltbld', 17:38:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:14 INFO - '_': '/tools/buildbot/bin/python'} 17:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 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:38:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:38: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:38: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:38: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:38: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:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:38:15 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:38:15 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:38:15 INFO - Installing collected packages: simplejson 17:38:15 INFO - Running setup.py install for simplejson 17:38:15 INFO - building 'simplejson._speedups' extension 17:38:15 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:38:16 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:38:16 INFO - Successfully installed simplejson 17:38:16 INFO - Cleaning up... 17:38:16 INFO - Return code: 0 17:38:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:16 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 0x1dfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', '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:38:16 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:38:16 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:38:16 INFO - Using env: {'DISPLAY': ':0', 17:38:16 INFO - 'HOME': '/home/cltbld', 17:38:16 INFO - 'LANG': 'en_US.UTF-8', 17:38:16 INFO - 'LANGUAGE': 'en_US:en', 17:38:16 INFO - 'LOGNAME': 'cltbld', 17:38:16 INFO - 'MAIL': '/var/mail/cltbld', 17:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:16 INFO - 'MOZ_NO_REMOTE': '1', 17:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:16 INFO - 'NO_EM_RESTART': '1', 17:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:16 INFO - 'PWD': '/builds/slave/test', 17:38:16 INFO - 'SHELL': '/bin/bash', 17:38:16 INFO - 'SHLVL': '1', 17:38:16 INFO - 'TERM': 'linux', 17:38:16 INFO - 'TMOUT': '86400', 17:38:16 INFO - 'USER': 'cltbld', 17:38:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:16 INFO - '_': '/tools/buildbot/bin/python'} 17:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:38:16 INFO - Cleaning up... 17:38:17 INFO - Return code: 0 17:38:17 INFO - Running post-action listener: _resource_record_post_action 17:38:17 INFO - Running post-action listener: _start_resource_monitoring 17:38:17 INFO - Starting resource monitoring. 17:38:17 INFO - [mozharness: 2017-08-01 00:38:17.034307Z] Finished create-virtualenv step (success) 17:38:17 INFO - [mozharness: 2017-08-01 00:38:17.034774Z] Running install step. 17:38:17 INFO - Running pre-action listener: _resource_record_pre_action 17:38:17 INFO - Running main action method: install 17:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:17 INFO - Reading from file tmpfile_stdout 17:38:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:17 INFO - Reading from file tmpfile_stdout 17:38:17 INFO - Output received: 17:38:17 INFO - Usage: mozinstall [options] installer 17:38:17 INFO - Options: 17:38:17 INFO - -h, --help show this help message and exit 17:38:17 INFO - -d DEST, --destination=DEST 17:38:17 INFO - Directory to install application into. [default: 17:38:17 INFO - "/builds/slave/test"] 17:38:17 INFO - --app=APP Application being installed. [default: firefox] 17:38:17 INFO - mkdir: /builds/slave/test/build/application 17:38:17 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:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:38:35 INFO - Reading from file tmpfile_stdout 17:38:35 INFO - Output received: 17:38:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:38:35 INFO - Running post-action listener: _resource_record_post_action 17:38:35 INFO - [mozharness: 2017-08-01 00:38:35.512829Z] Finished install step (success) 17:38:35 INFO - [mozharness: 2017-08-01 00:38:35.513086Z] Running setup-mitmproxy step. 17:38:35 INFO - Running pre-action listener: _resource_record_pre_action 17:38:35 INFO - Running main action method: setup_mitmproxy 17:38:35 INFO - Skipping: mitmproxy is not required 17:38:35 INFO - Running post-action listener: _resource_record_post_action 17:38:35 INFO - [mozharness: 2017-08-01 00:38:35.514347Z] Finished setup-mitmproxy step (success) 17:38:35 INFO - [mozharness: 2017-08-01 00:38:35.514567Z] Running run-tests step. 17:38:35 INFO - Running pre-action listener: _resource_record_pre_action 17:38:35 INFO - Running pre-action listener: _set_gcov_prefix 17:38:35 INFO - Running main action method: run_tests 17:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:38:35 INFO - Python 2.7.3 17:38:35 INFO - Return code: 0 17:38:35 INFO - grabbing minidump binary from tooltool 17:38: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:38:35 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 0x2168eb0>, '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 0x2169db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:38:35 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:38:35 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:38:35 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:38:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:38:35 INFO - Return code: 0 17:38:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:38:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:38:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:38:35 INFO - ENV: RUST_BACKTRACE is now 1 17:38:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:38:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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:38:35 INFO - Using env: {'DISPLAY': ':0', 17:38:35 INFO - 'HOME': '/home/cltbld', 17:38:35 INFO - 'LANG': 'en_US.UTF-8', 17:38:35 INFO - 'LANGUAGE': 'en_US:en', 17:38:35 INFO - 'LOGNAME': 'cltbld', 17:38:35 INFO - 'MAIL': '/var/mail/cltbld', 17:38:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:38:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:35 INFO - 'MOZ_NO_REMOTE': '1', 17:38:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:35 INFO - 'NO_EM_RESTART': '1', 17:38:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:35 INFO - 'PWD': '/builds/slave/test', 17:38:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:38:35 INFO - 'RUST_BACKTRACE': '1', 17:38:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:38:35 INFO - 'SHELL': '/bin/bash', 17:38:35 INFO - 'SHLVL': '1', 17:38:35 INFO - 'TERM': 'linux', 17:38:35 INFO - 'TMOUT': '86400', 17:38:35 INFO - 'USER': 'cltbld', 17:38:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392', 17:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:35 INFO - '_': '/tools/buildbot/bin/python'} 17:38:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:38:35 INFO - mozversion application_buildid: 20170731234331 17:38:35 INFO - mozversion application_changeset: 8b19670d12fde57d3aee50a5a7d1c734d9b709d5 17:38:35 INFO - mozversion application_display_name: Nightly 17:38:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:38:35 INFO - mozversion application_name: Firefox 17:38:35 INFO - mozversion application_remotingname: firefox 17:38:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:38:35 INFO - mozversion application_vendor: Mozilla 17:38:35 INFO - mozversion application_version: 56.0a1 17:38:35 INFO - mozversion platform_buildid: 20170731234331 17:38:35 INFO - mozversion platform_changeset: 8b19670d12fde57d3aee50a5a7d1c734d9b709d5 17:38:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:38:35 INFO - mozversion platform_version: 56.0a1 17:38:35 INFO - using testdate: 1501547915 17:38:35 INFO - actual date: 1501547915 17:38:35 INFO - starting webserver on 'localhost:43062' 17:38:35 INFO - SUITE-START | Running 2 tests 17:38:35 INFO - TEST-START | dromaeo_css 17:38:35 INFO - Initialising browser for dromaeo_css test... 17:38:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43062/getInfo.html -profile /tmp/tmpNYyxCW/profile 17:38:35 INFO - TEST-INFO | started process 19470 (/builds/slave/test/build/application/firefox/firefox http://localhost:43062/getInfo.html) 17:38:41 INFO - TEST-INFO | 19470: exit 0 17:38:41 INFO - Browser initialized. 17:38:41 INFO - Running cycle 1/1 for dromaeo_css test... 17:38:41 INFO - TEST-INFO | started process 19678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYyxCW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:42 INFO - PID 19678 | 17:38:42 INFO - PID 19678 | (/builds/slave/test/build/application/firefox/firefox:19727): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:38:42 INFO - PID 19678 | 17:38:53 INFO - PID 19678 | RSS: Main: 171356160 17:38:53 INFO - PID 19678 | 17:41:52 INFO - PID 19678 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43062/tests/dromaeo/cssquery-ext.html) 17:41:54 INFO - PID 19678 | RSS: Main: 173572096 17:41:54 INFO - PID 19678 | 17:44:56 INFO - PID 19678 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-ext.html (next: http://localhost:43062/tests/dromaeo/cssquery-jquery.html) 17:44:56 INFO - PID 19678 | RSS: Main: 170733568 17:44:56 INFO - PID 19678 | 17:47:58 INFO - PID 19678 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43062/tests/dromaeo/cssquery-mootools.html) 17:47:59 INFO - PID 19678 | RSS: Main: 171110400 17:47:59 INFO - PID 19678 | 17:51:00 INFO - PID 19678 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43062/tests/dromaeo/cssquery-prototype.html) 17:51:01 INFO - PID 19678 | RSS: Main: 171139072 17:51:01 INFO - PID 19678 | 17:54:05 INFO - PID 19678 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43062/tests/dromaeo/cssquery-yui.html) 17:54:05 INFO - PID 19678 | RSS: Main: 174518272 17:54:05 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-yui.html (next: http://localhost:43062/tests/dromaeo/cssquery-dojo.html) 17:57:07 INFO - PID 19678 | RSS: Main: 175058944 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | __start_tp_report 17:57:07 INFO - PID 19678 | _x_x_mozilla_page_load 17:57:07 INFO - PID 19678 | _x_x_mozilla_page_load_details 17:57:07 INFO - PID 19678 | |i|pagename|runs| 17:57:07 INFO - PID 19678 | |0;dojo.html;3111.1755384823027;3133.7806353555247;3139.607549056368;3164.952525712114;3184.840757962101;6065.818025459238;6074.088886667002;6107.938920610793;6112.633242005477;6130.019196928492;6093;6129.325774164839;6258.5306102042305;6267.247930248376;6295.559310848243;5589.329280486348;5664.801731939383;5708.372079071299;5713.17159011943;5735.885282294352;5566.944330556704;5670.036093864032;5678.318601767773;5703.885922281552;5769.769209231626;5474.616776825624;5563.693996830173;5582.944170558283;5637.069883469243;5671.319441666985;5559.082751346023;5633.8591535211535;5635.718214089279;5636.436356364372;5651.632643878134;5531.115021596565;5558.249636299089;5562.4993750562235;5611.915821262684;5625.80309689163;5889.617174883619;5981.970090149522;6000.729967151488;6029.306629737593;6061.787837425669;6553.410193082598;6561.475081993429;6593.901091483632;6599.670016499156;6610.7355705771715;6558.50811189158;6578.440832529241;6588.571742836701;6667.966660166668;6674.532782705212;6096.3903609639565;6117.816465506042;6183.443490085914;6213.906791398133;6219.09823075656;6779.322067793181;6788.93211067883;6789.796306110825;6794.524383293122;6795.660216989131;6324.956382196886;6490.772822951174;6495.967520162369;6497.610143391412;6499.545031847725;6567.868642627121;6629.801105966829;6660.400563949268;6663.300353462817;6674.432673222734;6516.902246466307;6527;6560.245571759308;6628.767993120217;6645.235797883305;6496.415322620986;6547.476201903836;6603.141591593062;6636.83407914806;6664.100346453264;5377.435369286169;5433.0763770159165;5443.401225865152;5452.018636645442;5456.59075569326;4659.044895796354;4676.69601475903;4707.340972263886;4718.787654555554;4732.195526760459;5712.971665100322;5750.2524671793235;5841.649501029951;5842.211301474246;5851.882962340729;6570.342965703487;6593.80218593443;6678.131842860397;6689.966550167218;6701.329867013357;5641.633293835887;5692.686902220417;5758.481736643722;5759.827205183851;5767.740451679684;5780.306363236355;5831;5854.912176317359;5857.033589457692;5867.970660146757;6440.774572889926;6444.387783160592;6457.644829534327;6463.224413070461;6466.385693359123;6629.105070815571;6630.370114839083;6633.701483433354;6635.601863888182;6639.170103737033;6349.809505714836;6367.331430199948;6376.139221205078;6482.773102941374;6493.058506516623;6477.935220647733;6486.708098135501;6493.545451818327;6508.739650413931;6510.544261901621;6614.10709554204;6631;6647.135872336566;6732.495062870402;6733.42765864907;6324.083007963912;6337.112804207322;6356.141920840627;6421.935780642134;6438.356164383712;6359.427651511386;6407.167068281094;6409.070684750778;6409.102725618324;6410.775622853178;6305.873882522415;6327.651979141007;6328.335524770017;6329.620222786648;6335.65153916539;6281.371862813682;6323.6838158090995;6382.808515744535;6465.741370345321;6475.417212450902;6198.473129783839;6219.906701399573;6274.686265686606;6302.054691796267;6309.936900630935 17:57:07 INFO - PID 19678 | |1;ext.html;847.9236868681818;862.7325529085983;894.1505569708776;900.2213085680888;1187.4419023059158;30510.847445762767;40947.18105637885;42021.99999999996;42061.57938420615;42080.36879446803;42876.35685464713;42965.78517107418;42978.140437191236;43195.568044319545;43392.3491147633;7670.501417407864;7844.254795794391;7855.567943763091;7862.449628526006;7874.173211812735;7683.961580192119;7805.1804560520895;7813.17961614028;7824.139344672081;7829.921700783005;7804.453688241825;7832.882506762403;7843.607819609026;7847.332976696987;7856.842863142734;7635.427342949273;7837.0987336456465;7840.7647770567255;7843.098043724931;7846.921530784676;7716.961415192888;7743.574103424309;7753.457257991943;7763.72826951054;7775.339096176832;37359.252814943546;37587.62412375869;37808.81095594532;37821.432678509846;38129;3458;3578.5169002184634;3579.5167652367118;3584.605693373727;3587.928241435183;31994.20014499656;32220.838895805606;32224.516632250536;32241.51637725436;32332.515012274835;4839.612830973514;4890.853274401774;4930.654854160211;4932.21084626458;4969.676970996909;186425;186797.99999999863;187031;187083;187589;48223.5177648226;48745.756271218415;49014.75492622514;49016.75491622519;49051.75474122607;51584.22623660648;51603.74198128985;51613;51649.225261621104;51727.74136129295;15907;16059.116748578941;16059.277332520065;16072.919635401748;16090.517284481484;13049.28228947398;13053.869461305265;13058.15122017066;13064.608061758163;13064.673383165307;12953.870461295455;14484.493042743454;14604.269786510631;14834.554963351116;14854.70290594182;5740.684262365527;5802.274715660543;5803.738831752581;5900.675462849498;6115.480184184395;986.8585170180725;987.8863930647924;989.5942663507927;1031.242037102729;1034.9534270957824;23194.76805231926;23292.7670723294;23618.409539761644;23724.169654062025;23845.046198152228;1072.8371296658283;1090.9399983000853;1104.447776111944;1118.1781390677845;1123.3540714089268;11706.01179128548;11991.760164796655;12342.938285308695;15041.623959400884;15659.765103523456;234125;237823;239067;240317;240706;51724.74137629288;51811.74094129505;51975.74012129915;52131.21803172956;52166.73916630469;1455.0760267230385;1479.5931118942376;1488.7245859516024;1511.04803973496;1523.1850959736487;25627;26183.214503564923;26186.798630376798;26230.606540902285;26279;37755;38050;38359.2328153441;38452.615473844904;38477.42283865688;207569;209793;210261;210691;210988;32796.1800954978;32821.17947051343;32891.50662740013;32962.50556241706;33282.500762489064;38113.04717382088;40178.39732403958;42234.57765422307;42874.78562607167;43176.784116079216;23413.531729364975;25316.113936012152;25621.74378256268;25626.487470250864;26073.73926260789;24150.51698966046;24697.259082227563;25153.748462515872;25320.620190697522;26359;37911.81044094762;38155.42766858444;38352.23295534129;38556.614433856426;38655;28912.85543572353;31731.20671983219;31782.523262150622;31864;32773.50839737358;23976;24490.14284500034;24569;24780.25659230226;24847.25458236256 17:57:07 INFO - PID 19678 | |2;jquery.html;582.283790937147;586.5073338395747;586.9589128760986;589.9705014749263;593.5785592229516;22964.311070667885;23735.643965340532;23755.168569100086;23779;23817.285481435585;19130.521736956583;20150.294739684115;20934.790652093474;25303;25602.615960760602;6324.683765811703;6541.47668186544;6542.607443553378;6544.312847151052;6552.3775241352;5859.7070146492715;6290.056491526285;6376.202974628171;6393;6475.287718350977;6382.744690212409;6387.5209359298005;6395.584287021352;6398.13625160602;6429.774957876475;6402.039694045884;6411.653552753927;6426.839329016789;6435.613863168178;6445;5971;5975.52195824333;5978.252718410199;5980.820575382745;5991.131285963511;26748.331291717666;27542.862285688643;28013;28030.299242518897;28911.421771564663;1891.6784146695095;1942.1357495914324;1952.4142757172792;1953.5604488989864;1954.0327537868704;18244.452666420028;18813.435596932115;18847.62304753911;18848.434546963475;18866.434006979813;2289.6565515172856;2343.3321503371626;2387.164492427654;2392.5334559760854;2400.699912510936;136723;138422.30788846192;138995;139212;139539.30230348886;14023.929880350533;14913.850861491246;14974.176420296988;15145.697086058217;15370.615734606725;22108.447288817908;23071.769282307298;23134.190303339303;23197.53604927892;23274;9289.767755806024;9393.483358415217;9411.858822117674;9461.574229159567;9538.093881081286;8257.710980115668;8321.502129616607;8423.663053477792;8456.704015359433;8457.577121143919;9130.72607821753;9212.53937303132;9468.668596599224;9498.715038548855;9524.380915240487;2680.758731714155;2719.7688196503123;2723.482538317713;2795.9580606290924;2834.96523768827;936.0953683799154;953.5137080089066;955.8191507649937;965.5558443116105;986.1174249047206;19313.324033659035;19355.709664355047;22569.435764106027;24439.877800610884;24548.754512455005;991.2119864707574;999.7450650084328;1013.381837079381;1021.2187676427538;1037.8754549454113;10743.462826858782;11308.321500709984;11529.596464123715;12555.309457979716;13454.52909148175;505836;531175;536041;536529;540794;126624.36687816687;130698;130702;132220;133674;1245.4893493667553;1249.4627310256494;1286.1704200790439;1287.5815360008035;1291.4558320109556;20544.79455205429;20578.58842823105;20678.276260330815;21133.788662113184;21542.784572154706;57933;58412;59646.403535964084;60086;60097.39902600918;69354.65322673354;73253.26746732465;73859.26140738738;74287;74757.25242747503;14623.707525849637;14849.851501485278;14900.62748431298;14917.627059323604;14996.925015374853;23179.536409272056;23197.0721171158;23423;23511.647325290476;23631.291061268188;17571.648567028842;18220.817791822443;18241;18648.34730784416;18678.813211867706;13524.661883452598;14269.64325891861;14390.568282951528;14404.207768572829;14779.408823646934;18738.344157954405;18793.248270069045;18987.620247594696;19113.331033413764;19256.807431926063;14546.418143274574;14571.125732456087;14647.194404307866;14697.70604587881;14698.412063517768;18160;18307.267709292013;18416.539586510444;18551.53621159482;18591 17:57:07 INFO - PID 19678 | |3;mootools.html;1344.3883033219884;1368.7946807978801;1394.5955672854873;1397.2664351215615;1404.5014020022886;11977.161598688095;12531.812022819653;14092.788608170886;14718.852811471883;14723.705525889476;14269.072510286824;14510.709785804278;14519.709605807904;14540.200288984102;14543.636409089779;2442.2673198040607;2600.6489123968213;2628.47430513897;2641.2340421277804;2643.510950474159;2595.3122422558035;2625.2649258207734;2625.5930330798756;2631.3158578769467;2632.6051092336206;2536.1630661881627;2571.33145382201;2573.4981678572685;2581.045013345065;2584.483103379322;2523.1799665108915;2523.6719226500622;2532.9493410131786;2533.556627590174;2535.594304911224;2463.0147940823636;2504.536660717755;2509.2221411362534;2520.4455019895595;2523.9116630918015;13817;13940.721185576233;13972.231527265996;13981.300934953211;14055.718885622231;7428.62856857155;7732.6133693315105;7753.069631644183;7776.494527855728;7786.4938778979185;4913.508649135094;5107.1828507439;5132.204508301219;5148.716820574867;5181.119209734355;1667.816540180579;1676.2959556985973;1713.4174380710617;1726.7237242041213;1744.8167942365997;22972;23105.88447057754;23176.420589485228;23182.072717091298;23194.3041708749;6403.935960640427;6430.678466076677;6445.16212892321;6606;6624;15885.920570397075;15903.920480397524;15935.282912268976;15960.122193279249;15971.201439927958;7283.672234749449;7417.147028091838;7420.85158296831;7421.183669796318;7422.888656670154;6678.766243181465;6780.627065511444;6827.897581536281;6875;7003.194632617212;4973.651844370932;5063.797448102108;5077.746112694351;5151.896962060738;5263.052650522866;1506.8041154649825;1508.4343371235786;1519.8176218853587;1537.4618883390724;1539.1919242397607;796.474326944214;817.3747083481142;838.5849004742691;838.781916701662;857.5155037403847;6679.76620818269;6955.02629631852;7074.469414793911;7277;7582.582957937367;701.9786211062891;717.5443593318281;717.7523754304757;720.2149656874033;730.2514922204782;4058.127502586958;4227.619514243733;4288.270993930977;4304;4324.935125973113;18333.17500712471;18803.15385807642;19094;19119.808801911804;20120.993950302425;19574.119164637625;19699.803001969798;19750.30873919406;19805.40583782489;19823.504412389804;10096;10786.622468213574;10982.725431864268;10995.285306455055;11022.944885275523;7888.723894663659;8141.3893957952205;8234.341252699889;8243;8313.584320783815;15939.44211952576;17162.485125446256;17204.225809838837;17293.08276689284;17583.64832703313;17249;17594.91202543979;17680.82319176843;17798.288068477636;18053.458396248134;10668.946655266984;10996.340219586851;11106.61126860556;11108.389038602954;11161.72095697614;13058.542950996669;13195.736085278433;13232.073754837069;13237.27195004284;13244.00669949777;9572.664956726481;9667.564959576977;9835.704928852147;10047.196224302184;10213.08082272599;8987.595558199766;9481.478518681539;9516.762080948032;9526.952365238129;9562.521873906417;8769.736907892773;8945.776355590902;8947.776305592151;8953.104689530996;8971.551422428984;6556.63938483388;6754.392104710403;6776.15298087739;6978.371946524837;7017.403520700797;6509.934900650933;6669.46644268467;6814.182298124257;6891.966869773529;6924.3421874921805 17:57:07 INFO - PID 19678 | |4;prototype.html;472.36466951949615;491.510946608125;497.2292945933803;500.5970193993833;513.4942082049179;6127.56002339451;6160.537959653027;6226.377362263777;6247.812565623039;6265.624062556244;5833.5333173346135;6099.847503812407;6111.083337499377;6171.876562468748;6181.258249010114;4941.851744447672;4943.184374578191;4966.609349382161;4971.428285747149;4993.275974983625;4937.703737775727;4943.703377797344;4951.77717002734;4959.231319145538;4982;4726.527347265263;4758.096761295475;4784;4859.708417494961;4897.436794768611;4893.926591101136;4899.363082799231;4904.5831104356175;4922.433920099199;4946.3817022872145;4365.476142862845;4380.2772542530765;4394.318880573484;4429.778511074465;4433.334999750031;6031.849203769897;6055.878882422327;6065.423784740443;6095.146679464879;6114.11345354921;5660.179274005287;5687.203791469156;5691.658500489983;5701.515371193454;5723.828285151452;6521.804345869631;6530.44491218247;6548.967255163694;6558.704858281341;6609.702563384659;4788.162071637449;4795.880102997418;4801.135795556798;4812.181929072066;4827;6862.48531360145;6972.1284839395075;6979.197392299849;6998.75504357345;7000.334968178015;4890.731009794425;4893.510648935078;4895.779689913962;4899.681520701143;4954.430240522386;4977.800887964513;4980.726060066731;4993.425756038102;4995.450500444948;5000;5632.295963004624;5642.153676948491;5659.688717120598;5668.178114173422;5677.74450149736;6529.249136349285;6551.1155993941165;6551.181102362205;6616.669166541654;6624.846924749476;1599.6480774229651;1651.1826645810402;1675;1723.1212081838103;1741.9303227870996;1125.2011072138873;1201.9038476922;1206.1135065726685;1206.9155159138777;1214.372740527697;5633.57748168889;5667.376588575254;5690.9146362804595;5706.2011318414625;5728.0262355398845;6408.885067927573;6444.355564443518;6573.506986975996;6683.799486015428;6746.730130794811;5750.511206547407;5753.395893431213;5780.393058728857;5800.259922023461;5806.477417032487;3512.7892326459983;3542.8582856685957;3557.6875031229906;3569.714422846218;3599.7300202484394;6426.389492998158;6460.838479038061;6590.637514936629;6614.768483103068;6614.966925165343;6804.455643548505;6862.289395688675;6891.552049116792;6902.758403455855;6958.060661810692;6463.931541906545;6506.3818937200895;6582.913819219775;6585.868282634417;6588.96705516479;6606.570572912745;6648.235452922782;6659.933400665931;6672;6694.698738556874;6650.933490665031;6674.331417145713;6681.799546013627;6682.532222744361;6686.197656281277;6522.412982831568;6563.409293163638;6600.966995164993;6617.2721000688925;6638.468922486093;4767.380240568704;4771.475137734777;4799.712017278975;4840.201366774443;4868.634852386156;6696.363845434676;6700.597964122168;6740.9325906740305;6768.153980752406;6814.965925170342;6528.804135875931;6543.476521878333;6558.80323590293;6576.572522786004;6594.10979517759;6491.318411566717;6513.404215967118;6537.215534135934;6570;6592.560752521406;6050.939490605214;6076.574639775174;6279.843003924756;6381.553291269753;6432.807015789534;6418.19772528434;6483.740650373932;6533.444657204191;6553.246376666744;6600.867982640416;6234.532410069172;6238.594491358047;6263.4654509645425;6286.748530058747;6345.936540634534 17:57:07 INFO - PID 19678 | |5;yui.html;874.5233847553083;892.3842548641437;914.3416739947238;920.3281604428767;926.6895589977357;17935.282588696453;18842.34051808187;18880.81119188808;18882.811171888276;18907.52731181721;17196.226169822356;22131.668024979637;22205.666914996287;22206.555868882613;22379.44051398716;1021.1473419694564;1045.5556388534842;1046.08467590858;1047.3192424923784;1047.8271085270922;999.1806718490805;1030.5465595138114;1039.0907955538903;1040.8959104089606;1042.426665334067;1103.9116870650369;1107.8172101603266;1107.8227483602625;1108.4568561404894;1109.1182509904645;1096.7532305231339;1097.4786976186288;1099.2470157941796;1100.0484580837558;1101.3281898042187;799.6081919859228;803.333233416269;804.899387576553;806.4314658165979;807.3460496997451;18710.438686839418;18742.718859217122;19626.607467850565;20156.395308140778;20156.596868062705;20458.693119603216;20656.380308590768;20831.89584052085;20976.47558811027;21030.158793648236;15273.847261527353;15352.846471535366;15381.230938453033;15420.922895385564;15463.149526776022;3486.18074752433;3491.5460990071383;3500.597431295408;3508.1755787389943;3512.2799826035603;119939;121496;126488.99999999908;127589.36205319007;129143.35428322892;15780.763288550452;16145.434909778101;16312.51062468128;16378.344866205456;16393.59016024585;28597.714022859505;30275.243118922204;30333.848330758647;30362.84818575893;30579;8212.096669366365;8431.072582015973;8432.45189062709;8439.324854011664;8443.28232100266;3979.820908059144;4062.4921884764403;4075.653569446571;4106.240345536085;4112.424260603518;4730.361401210861;5219.217117432416;5942.7920022799;5943.465088142088;6007.219061522062;1052.4948024947914;1083.9295445796156;1095.808233559124;1103.1175059952006;1107.413071072333;650.3691419323249;667.3826710292959;679.6465837764334;686.7424715731601;689.96205208713;11137.833306722;11179.385133817717;11988.760224795455;12074.818877716842;12688.619341419771;649.0621052579072;661.3287513174132;678.4335080207983;688.4733179117978;702.0978043214546;5456.072467680504;5482.945170548323;5510.732531517773;5673.74468148926;5720.056190728483;91841.54079229561;93472.53263733638;95898;100418.49790751145;103298.48350758199;85916;89413.55293223623;92028.53985730163;92040;94397.52801236087;81090.59454702807;81122;82292.58853705693;85656;85881;11792.941035294769;11800.82298765502;12135.271883687006;12290.877091228973;12309.384530773246;31678.683213167573;31724.365512690078;32165.1958701025;34115.488267676505;36040.27919441649;46050.30924536067;46093.53906460892;67156;68423.65788171027;72621;16788.832111679214;16956;17162.39931602388;17271.56821079433;17332.30670773155;20123.993800310218;20490.18039278412;20599.485012874797;20722.067506962525;20808.791912080684;17225.74161387555;17478.91260543689;17633.823661763217;17652.558686032953;18139.183736732142;17818.643627127643;18196.45410637683;18416.63166736631;18509.814901851347;18629.161687723812;17867.195976181363;18523.722144168118;18531.44405667832;18708.345207917657;18897.90551047236;11034.834477482684;11582.478788454708;11789.41052947332;11920.821187682019;11945.880541194478;13329.400176991865;13436.261005644783;13604;14005;14237.786433203717 17:57:07 INFO - PID 19678 | __end_tp_report 17:57:07 INFO - PID 19678 | __start_cc_report 17:57:07 INFO - PID 19678 | _x_x_mozilla_cycle_collect,368 17:57:07 INFO - PID 19678 | __end_cc_report 17:57:07 INFO - PID 19678 | __startTimestamp1501549027891__endTimestamp 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | ------- Summary: start ------- 17:57:07 INFO - PID 19678 | Number of tests: 6 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | [#0] dojo.html Cycles:165 Average:6077.85 Median:6323.68 stddev:700.72 (11.1%) stddev-sans-first:663.10 17:57:07 INFO - PID 19678 | Values: 3111.2 3133.8 3139.6 3165.0 3184.8 6065.8 6074.1 6107.9 6112.6 6130.0 6093.0 6129.3 6258.5 6267.2 6295.6 5589.3 5664.8 5708.4 5713.2 5735.9 5566.9 5670.0 5678.3 5703.9 5769.8 5474.6 5563.7 5582.9 5637.1 5671.3 5559.1 5633.9 5635.7 5636.4 5651.6 5531.1 5558.2 5562.5 5611.9 5625.8 5889.6 5982.0 6000.7 6029.3 6061.8 6553.4 6561.5 6593.9 6599.7 6610.7 6558.5 6578.4 6588.6 6668.0 6674.5 6096.4 6117.8 6183.4 6213.9 6219.1 6779.3 6788.9 6789.8 6794.5 6795.7 6325.0 6490.8 6496.0 6497.6 6499.5 6567.9 6629.8 6660.4 6663.3 6674.4 6516.9 6527.0 6560.2 6628.8 6645.2 6496.4 6547.5 6603.1 6636.8 6664.1 5377.4 5433.1 5443.4 5452.0 5456.6 4659.0 4676.7 4707.3 4718.8 4732.2 5713.0 5750.3 5841.6 5842.2 5851.9 6570.3 6593.8 6678.1 6690.0 6701.3 5641.6 5692.7 5758.5 5759.8 5767.7 5780.3 5831.0 5854.9 5857.0 5868.0 6440.8 6444.4 6457.6 6463.2 6466.4 6629.1 6630.4 6633.7 6635.6 6639.2 6349.8 6367.3 6376.1 6482.8 6493.1 6477.9 6486.7 6493.5 6508.7 6510.5 6614.1 6631.0 6647.1 6732.5 6733.4 6324.1 6337.1 6356.1 6421.9 6438.4 6359.4 6407.2 6409.1 6409.1 6410.8 6305.9 6327.7 6328.3 6329.6 6335.7 6281.4 6323.7 6382.8 6465.7 6475.4 6198.5 6219.9 6274.7 6302.1 6309.9 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | [#1] ext.html Cycles:180 Average:37822.88 Median:3579.02 stddev:55182.63 (1541.8%) stddev-sans-first:55267.59 17:57:07 INFO - PID 19678 | Values: 847.9 862.7 894.2 900.2 1187.4 30510.8 40947.2 42022.0 42061.6 42080.4 42876.4 42965.8 42978.1 43195.6 43392.3 7670.5 7844.3 7855.6 7862.4 7874.2 7684.0 7805.2 7813.2 7824.1 7829.9 7804.5 7832.9 7843.6 7847.3 7856.8 7635.4 7837.1 7840.8 7843.1 7846.9 7717.0 7743.6 7753.5 7763.7 7775.3 37359.3 37587.6 37808.8 37821.4 38129.0 3458.0 3578.5 3579.5 3584.6 3587.9 31994.2 32220.8 32224.5 32241.5 32332.5 4839.6 4890.9 4930.7 4932.2 4969.7 186425.0 186798.0 187031.0 187083.0 187589.0 48223.5 48745.8 49014.8 49016.8 49051.8 51584.2 51603.7 51613.0 51649.2 51727.7 15907.0 16059.1 16059.3 16072.9 16090.5 13049.3 13053.9 13058.2 13064.6 13064.7 12953.9 14484.5 14604.3 14834.6 14854.7 5740.7 5802.3 5803.7 5900.7 6115.5 986.9 987.9 989.6 1031.2 1035.0 23194.8 23292.8 23618.4 23724.2 23845.0 1072.8 1090.9 1104.4 1118.2 1123.4 11706.0 11991.8 12342.9 15041.6 15659.8 234125.0 237823.0 239067.0 240317.0 240706.0 51724.7 51811.7 51975.7 52131.2 52166.7 1455.1 1479.6 1488.7 1511.0 1523.2 25627.0 26183.2 26186.8 26230.6 26279.0 37755.0 38050.0 38359.2 38452.6 38477.4 207569.0 209793.0 210261.0 210691.0 210988.0 32796.2 32821.2 32891.5 32962.5 33282.5 38113.0 40178.4 42234.6 42874.8 43176.8 23413.5 25316.1 25621.7 25626.5 26073.7 24150.5 24697.3 25153.7 25320.6 26359.0 37911.8 38155.4 38352.2 38556.6 38655.0 28912.9 31731.2 31782.5 31864.0 32773.5 23976.0 24490.1 24569.0 24780.3 24847.3 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | [#2] jquery.html Cycles:180 Average:36370.21 Median:23571.47 stddev:89283.16 (378.8%) stddev-sans-first:89493.19 17:57:07 INFO - PID 19678 | Values: 582.3 586.5 587.0 590.0 593.6 22964.3 23735.6 23755.2 23779.0 23817.3 19130.5 20150.3 20934.8 25303.0 25602.6 6324.7 6541.5 6542.6 6544.3 6552.4 5859.7 6290.1 6376.2 6393.0 6475.3 6382.7 6387.5 6395.6 6398.1 6429.8 6402.0 6411.7 6426.8 6435.6 6445.0 5971.0 5975.5 5978.3 5980.8 5991.1 26748.3 27542.9 28013.0 28030.3 28911.4 1891.7 1942.1 1952.4 1953.6 1954.0 18244.5 18813.4 18847.6 18848.4 18866.4 2289.7 2343.3 2387.2 2392.5 2400.7 136723.0 138422.3 138995.0 139212.0 139539.3 14023.9 14913.9 14974.2 15145.7 15370.6 22108.4 23071.8 23134.2 23197.5 23274.0 9289.8 9393.5 9411.9 9461.6 9538.1 8257.7 8321.5 8423.7 8456.7 8457.6 9130.7 9212.5 9468.7 9498.7 9524.4 2680.8 2719.8 2723.5 2796.0 2835.0 936.1 953.5 955.8 965.6 986.1 19313.3 19355.7 22569.4 24439.9 24548.8 991.2 999.7 1013.4 1021.2 1037.9 10743.5 11308.3 11529.6 12555.3 13454.5 505836.0 531175.0 536041.0 536529.0 540794.0 126624.4 130698.0 130702.0 132220.0 133674.0 1245.5 1249.5 1286.2 1287.6 1291.5 20544.8 20578.6 20678.3 21133.8 21542.8 57933.0 58412.0 59646.4 60086.0 60097.4 69354.7 73253.3 73859.3 74287.0 74757.3 14623.7 14849.9 14900.6 14917.6 14996.9 23179.5 23197.1 23423.0 23511.6 23631.3 17571.6 18220.8 18241.0 18648.3 18678.8 13524.7 14269.6 14390.6 14404.2 14779.4 18738.3 18793.2 18987.6 19113.3 19256.8 14546.4 14571.1 14647.2 14697.7 14698.4 18160.0 18307.3 18416.5 18551.5 18591.0 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | [#3] mootools.html Cycles:180 Average:8569.69 Median:2577.27 stddev:6011.75 (233.3%) stddev-sans-first:6004.10 17:57:07 INFO - PID 19678 | Values: 1344.4 1368.8 1394.6 1397.3 1404.5 11977.2 12531.8 14092.8 14718.9 14723.7 14269.1 14510.7 14519.7 14540.2 14543.6 2442.3 2600.6 2628.5 2641.2 2643.5 2595.3 2625.3 2625.6 2631.3 2632.6 2536.2 2571.3 2573.5 2581.0 2584.5 2523.2 2523.7 2532.9 2533.6 2535.6 2463.0 2504.5 2509.2 2520.4 2523.9 13817.0 13940.7 13972.2 13981.3 14055.7 7428.6 7732.6 7753.1 7776.5 7786.5 4913.5 5107.2 5132.2 5148.7 5181.1 1667.8 1676.3 1713.4 1726.7 1744.8 22972.0 23105.9 23176.4 23182.1 23194.3 6403.9 6430.7 6445.2 6606.0 6624.0 15885.9 15903.9 15935.3 15960.1 15971.2 7283.7 7417.1 7420.9 7421.2 7422.9 6678.8 6780.6 6827.9 6875.0 7003.2 4973.7 5063.8 5077.7 5151.9 5263.1 1506.8 1508.4 1519.8 1537.5 1539.2 796.5 817.4 838.6 838.8 857.5 6679.8 6955.0 7074.5 7277.0 7582.6 702.0 717.5 717.8 720.2 730.3 4058.1 4227.6 4288.3 4304.0 4324.9 18333.2 18803.2 19094.0 19119.8 20121.0 19574.1 19699.8 19750.3 19805.4 19823.5 10096.0 10786.6 10982.7 10995.3 11022.9 7888.7 8141.4 8234.3 8243.0 8313.6 15939.4 17162.5 17204.2 17293.1 17583.6 17249.0 17594.9 17680.8 17798.3 18053.5 10668.9 10996.3 11106.6 11108.4 11161.7 13058.5 13195.7 13232.1 13237.3 13244.0 9572.7 9667.6 9835.7 10047.2 10213.1 8987.6 9481.5 9516.8 9527.0 9562.5 8769.7 8945.8 8947.8 8953.1 8971.6 6556.6 6754.4 6776.2 6978.4 7017.4 6509.9 6669.5 6814.2 6892.0 6924.3 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | [#4] prototype.html Cycles:180 Average:5474.27 Median:6085.86 stddev:1559.83 (25.6%) stddev-sans-first:1518.36 17:57:07 INFO - PID 19678 | Values: 472.4 491.5 497.2 500.6 513.5 6127.6 6160.5 6226.4 6247.8 6265.6 5833.5 6099.8 6111.1 6171.9 6181.3 4941.9 4943.2 4966.6 4971.4 4993.3 4937.7 4943.7 4951.8 4959.2 4982.0 4726.5 4758.1 4784.0 4859.7 4897.4 4893.9 4899.4 4904.6 4922.4 4946.4 4365.5 4380.3 4394.3 4429.8 4433.3 6031.8 6055.9 6065.4 6095.1 6114.1 5660.2 5687.2 5691.7 5701.5 5723.8 6521.8 6530.4 6549.0 6558.7 6609.7 4788.2 4795.9 4801.1 4812.2 4827.0 6862.5 6972.1 6979.2 6998.8 7000.3 4890.7 4893.5 4895.8 4899.7 4954.4 4977.8 4980.7 4993.4 4995.5 5000.0 5632.3 5642.2 5659.7 5668.2 5677.7 6529.2 6551.1 6551.2 6616.7 6624.8 1599.6 1651.2 1675.0 1723.1 1741.9 1125.2 1201.9 1206.1 1206.9 1214.4 5633.6 5667.4 5690.9 5706.2 5728.0 6408.9 6444.4 6573.5 6683.8 6746.7 5750.5 5753.4 5780.4 5800.3 5806.5 3512.8 3542.9 3557.7 3569.7 3599.7 6426.4 6460.8 6590.6 6614.8 6615.0 6804.5 6862.3 6891.6 6902.8 6958.1 6463.9 6506.4 6582.9 6585.9 6589.0 6606.6 6648.2 6659.9 6672.0 6694.7 6650.9 6674.3 6681.8 6682.5 6686.2 6522.4 6563.4 6601.0 6617.3 6638.5 4767.4 4771.5 4799.7 4840.2 4868.6 6696.4 6700.6 6740.9 6768.2 6815.0 6528.8 6543.5 6558.8 6576.6 6594.1 6491.3 6513.4 6537.2 6570.0 6592.6 6050.9 6076.6 6279.8 6381.6 6432.8 6418.2 6483.7 6533.4 6553.2 6600.9 6234.5 6238.6 6263.5 6286.7 6345.9 17:57:07 INFO - PID 19678 | 17:57:07 INFO - PID 19678 | [#5] yui.html Cycles:180 Average:22438.03 Median:20140.19 stddev:30101.58 (149.5%) stddev-sans-first:30142.48 17:57:07 INFO - PID 19678 | Values: 874.5 892.4 914.3 920.3 926.7 17935.3 18842.3 18880.8 18882.8 18907.5 17196.2 22131.7 22205.7 22206.6 22379.4 1021.1 1045.6 1046.1 1047.3 1047.8 999.2 1030.5 1039.1 1040.9 1042.4 1103.9 1107.8 1107.8 1108.5 1109.1 1096.8 1097.5 1099.2 1100.0 1101.3 799.6 803.3 804.9 806.4 807.3 18710.4 18742.7 19626.6 20156.4 20156.6 20458.7 20656.4 20831.9 20976.5 21030.2 15273.8 15352.8 15381.2 15420.9 15463.1 3486.2 3491.5 3500.6 3508.2 3512.3 119939.0 121496.0 126489.0 127589.4 129143.4 15780.8 16145.4 16312.5 16378.3 16393.6 28597.7 30275.2 30333.8 30362.8 30579.0 8212.1 8431.1 8432.5 8439.3 8443.3 3979.8 4062.5 4075.7 4106.2 4112.4 4730.4 5219.2 5942.8 5943.5 6007.2 1052.5 1083.9 1095.8 1103.1 1107.4 650.4 667.4 679.6 686.7 690.0 11137.8 11179.4 11988.8 12074.8 12688.6 649.1 661.3 678.4 688.5 702.1 5456.1 5482.9 5510.7 5673.7 5720.1 91841.5 93472.5 95898.0 100418.5 103298.5 85916.0 89413.6 92028.5 92040.0 94397.5 81090.6 81122.0 82292.6 85656.0 85881.0 11792.9 11800.8 12135.3 12290.9 12309.4 31678.7 31724.4 32165.2 34115.5 36040.3 46050.3 46093.5 67156.0 68423.7 72621.0 16788.8 16956.0 17162.4 17271.6 17332.3 20124.0 20490.2 20599.5 20722.1 20808.8 17225.7 17478.9 17633.8 17652.6 18139.2 17818.6 18196.5 18416.6 18509.8 18629.2 17867.2 18523.7 18531.4 18708.3 18897.9 11034.8 11582.5 11789.4 11920.8 11945.9 13329.4 13436.3 13604.0 14005.0 14237.8 17:57:07 INFO - PID 19678 | -------- Summary: end -------- 17:57:07 INFO - PID 19678 | 17:57:08 INFO - TEST-INFO | 19678: exit 0 17:57:08 INFO - TEST-OK | dromaeo_css | took 1112768ms 17:57:08 INFO - TEST-START | kraken 17:57:08 INFO - Initialising browser for kraken test... 17:57:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43062/getInfo.html -profile /tmp/tmpFeVscB/profile 17:57:08 INFO - TEST-INFO | started process 20030 (/builds/slave/test/build/application/firefox/firefox http://localhost:43062/getInfo.html) 17:57:14 INFO - TEST-INFO | 20030: exit 0 17:57:14 INFO - Browser initialized. 17:57:14 INFO - Running cycle 1/1 for kraken test... 17:57:14 INFO - TEST-INFO | started process 20239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeVscB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:15 INFO - PID 20239 | 17:57:15 INFO - PID 20239 | (/builds/slave/test/build/application/firefox/firefox:20287): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:57:15 INFO - PID 20239 | 17:57:25 INFO - PID 20239 | RSS: Main: 172343296 17:57:25 INFO - PID 20239 | 17:57:28 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-beat-detection) 17:57:29 INFO - PID 20239 | RSS: Main: 177541120 17:57:29 INFO - PID 20239 | 17:57:31 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-dft) 17:57:32 INFO - PID 20239 | RSS: Main: 177819648 17:57:32 INFO - PID 20239 | 17:57:35 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-fft) 17:57:36 INFO - PID 20239 | RSS: Main: 172728320 17:57:36 INFO - PID 20239 | 17:57:38 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-oscillator) 17:57:38 INFO - PID 20239 | RSS: Main: 172621824 17:57:38 INFO - PID 20239 | 17:57:40 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:57:41 INFO - PID 20239 | RSS: Main: 173400064 17:57:41 INFO - PID 20239 | 17:57:44 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43062/tests/kraken/driver.html?testName=imaging-darkroom) 17:57:45 INFO - PID 20239 | RSS: Main: 175779840 17:57:45 INFO - PID 20239 | 17:57:48 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43062/tests/kraken/driver.html?testName=imaging-desaturate) 17:57:49 INFO - PID 20239 | RSS: Main: 175755264 17:57:49 INFO - PID 20239 | 17:57:52 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43062/tests/kraken/driver.html?testName=json-parse-financial) 17:57:52 INFO - PID 20239 | RSS: Main: 175886336 17:57:52 INFO - PID 20239 | 17:57:54 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:57:55 INFO - PID 20239 | RSS: Main: 176087040 17:57:55 INFO - PID 20239 | 17:57:56 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:57:57 INFO - PID 20239 | RSS: Main: 176119808 17:57:57 INFO - PID 20239 | 17:57:59 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:00 INFO - PID 20239 | RSS: Main: 173719552 17:58:00 INFO - PID 20239 | 17:58:03 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:03 INFO - PID 20239 | RSS: Main: 173703168 17:58:03 INFO - PID 20239 | 17:58:06 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:07 INFO - PID 20239 | RSS: Main: 173481984 17:58:07 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43062/tests/kraken/driver.html?testName=ai-astar) 17:58:09 INFO - PID 20239 | RSS: Main: 175296512 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | __start_tp_report 17:58:09 INFO - PID 20239 | _x_x_mozilla_page_load 17:58:09 INFO - PID 20239 | _x_x_mozilla_page_load_details 17:58:09 INFO - PID 20239 | |i|pagename|runs| 17:58:09 INFO - PID 20239 | |0;ai-astar;100;109;107;108;107;109;110;101;110;111 17:58:09 INFO - PID 20239 | |1;audio-beat-detection;153;118;151;181;120;144;143;118;173;123 17:58:09 INFO - PID 20239 | |2;audio-dft;163;164;164;162;162;163;163;164;166;168 17:58:09 INFO - PID 20239 | |3;audio-fft;75;74;74;178;75;75;74;74;158;77 17:58:09 INFO - PID 20239 | |4;audio-oscillator;79;78;138;79;80;79;131;79;79;125 17:58:09 INFO - PID 20239 | |5;imaging-gaussian-blur;114;115;114;114;113;114;114;115;114;114 17:58:09 INFO - PID 20239 | |6;imaging-darkroom;154;152;152;152;152;152;151;151;153;154 17:58:09 INFO - PID 20239 | |7;imaging-desaturate;94;94;94;94;94;95;95;94;94;95 17:58:09 INFO - PID 20239 | |8;json-parse-financial;57;55;56;55;55;55;56;55;55;59 17:58:09 INFO - PID 20239 | |9;json-stringify-tinderbox;54;54;54;54;54;54;55;55;54;54 17:58:09 INFO - PID 20239 | |10;stanford-crypto-aes;81;91;81;80;79;81;81;91;81;81 17:58:09 INFO - PID 20239 | |11;stanford-crypto-ccm;141;131;138;142;128;130;139;129;138;187 17:58:09 INFO - PID 20239 | |12;stanford-crypto-pbkdf2;185;194;184;182;179;181;183;180;176;181 17:58:09 INFO - PID 20239 | |13;stanford-crypto-sha256-iterative;69;67;68;66;68;69;68;65;68;66 17:58:09 INFO - PID 20239 | __end_tp_report 17:58:09 INFO - PID 20239 | __start_cc_report 17:58:09 INFO - PID 20239 | _x_x_mozilla_cycle_collect,917 17:58:09 INFO - PID 20239 | __end_cc_report 17:58:09 INFO - PID 20239 | __startTimestamp1501549089578__endTimestamp 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | ------- Summary: start ------- 17:58:09 INFO - PID 20239 | Number of tests: 14 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.00 stddev:3.77 (3.5%) stddev-sans-first:2.96 17:58:09 INFO - PID 20239 | Values: 100.0 109.0 107.0 108.0 107.0 109.0 110.0 101.0 110.0 111.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:147.50 stddev:22.81 (15.5%) stddev-sans-first:23.87 17:58:09 INFO - PID 20239 | Values: 153.0 118.0 151.0 181.0 120.0 144.0 143.0 118.0 173.0 123.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.85 (1.1%) stddev-sans-first:1.94 17:58:09 INFO - PID 20239 | Values: 163.0 164.0 164.0 162.0 162.0 163.0 163.0 164.0 166.0 168.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#3] audio-fft Cycles:10 Average:93.40 Median:74.50 stddev:39.61 (53.2%) stddev-sans-first:41.45 17:58:09 INFO - PID 20239 | Values: 75.0 74.0 74.0 178.0 75.0 75.0 74.0 74.0 158.0 77.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.47 (32.2%) stddev-sans-first:26.37 17:58:09 INFO - PID 20239 | Values: 79.0 78.0 138.0 79.0 80.0 79.0 131.0 79.0 79.0 125.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:58:09 INFO - PID 20239 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 114.0 115.0 114.0 114.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:152.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 17:58:09 INFO - PID 20239 | Values: 154.0 152.0 152.0 152.0 152.0 152.0 151.0 151.0 153.0 154.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:58:09 INFO - PID 20239 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.32 (2.4%) stddev-sans-first:1.32 17:58:09 INFO - PID 20239 | Values: 57.0 55.0 56.0 55.0 55.0 55.0 56.0 55.0 55.0 59.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 17:58:09 INFO - PID 20239 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 55.0 55.0 54.0 54.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:81.00 stddev:4.42 (5.5%) stddev-sans-first:4.65 17:58:09 INFO - PID 20239 | Values: 81.0 91.0 81.0 80.0 79.0 81.0 81.0 91.0 81.0 81.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:138.50 stddev:17.22 (12.4%) stddev-sans-first:18.26 17:58:09 INFO - PID 20239 | Values: 141.0 131.0 138.0 142.0 128.0 130.0 139.0 129.0 138.0 187.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:182.50 stddev:4.79 (2.6%) stddev-sans-first:4.99 17:58:09 INFO - PID 20239 | Values: 185.0 194.0 184.0 182.0 179.0 181.0 183.0 180.0 176.0 181.0 17:58:09 INFO - PID 20239 | 17:58:09 INFO - PID 20239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.30 17:58:09 INFO - PID 20239 | Values: 69.0 67.0 68.0 66.0 68.0 69.0 68.0 65.0 68.0 66.0 17:58:09 INFO - PID 20239 | -------- Summary: end -------- 17:58:09 INFO - PID 20239 | 17:58:10 INFO - PID 20239 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:58:10 INFO - TEST-INFO | 20239: exit 0 17:58:10 INFO - TEST-OK | kraken | took 61626ms 17:58:10 INFO - SUITE-END | took 1174s 17:58:10 INFO - Completed test suite (00:19:34) 17:58:10 INFO - javascript benchmark 17:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8363.919055804927, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.1755384823027, 3133.7806353555247, 3139.607549056368, 3164.952525712114, 3184.840757962101, 6065.818025459238, 6074.088886667002, 6107.938920610793, 6112.633242005477, 6130.019196928492, 6093.0, 6129.325774164839, 6258.5306102042305, 6267.247930248376, 6295.559310848243, 5589.329280486348, 5664.801731939383, 5708.372079071299, 5713.17159011943, 5735.885282294352, 5566.944330556704, 5670.036093864032, 5678.318601767773, 5703.885922281552, 5769.769209231626, 5474.616776825624, 5563.693996830173, 5582.944170558283, 5637.069883469243, 5671.319441666985, 5559.082751346023, 5633.8591535211535, 5635.718214089279, 5636.436356364372, 5651.632643878134, 5531.115021596565, 5558.249636299089, 5562.4993750562235, 5611.915821262684, 5625.80309689163, 5889.617174883619, 5981.970090149522, 6000.729967151488, 6029.306629737593, 6061.787837425669, 6553.410193082598, 6561.475081993429, 6593.901091483632, 6599.670016499156, 6610.7355705771715, 6558.50811189158, 6578.440832529241, 6588.571742836701, 6667.966660166668, 6674.532782705212, 6096.3903609639565, 6117.816465506042, 6183.443490085914, 6213.906791398133, 6219.09823075656, 6779.322067793181, 6788.93211067883, 6789.796306110825, 6794.524383293122, 6795.660216989131, 6324.956382196886, 6490.772822951174, 6495.967520162369, 6497.610143391412, 6499.545031847725, 6567.868642627121, 6629.801105966829, 6660.400563949268, 6663.300353462817, 6674.432673222734, 6516.902246466307, 6527.0, 6560.245571759308, 6628.767993120217, 6645.235797883305, 6496.415322620986, 6547.476201903836, 6603.141591593062, 6636.83407914806, 6664.100346453264, 5377.435369286169, 5433.0763770159165, 5443.401225865152, 5452.018636645442, 5456.59075569326, 4659.044895796354, 4676.69601475903, 4707.340972263886, 4718.787654555554, 4732.195526760459, 5712.971665100322, 5750.2524671793235, 5841.649501029951, 5842.211301474246, 5851.882962340729, 6570.342965703487, 6593.80218593443, 6678.131842860397, 6689.966550167218, 6701.329867013357, 5641.633293835887, 5692.686902220417, 5758.481736643722, 5759.827205183851, 5767.740451679684, 5780.306363236355, 5831.0, 5854.912176317359, 5857.033589457692, 5867.970660146757, 6440.774572889926, 6444.387783160592, 6457.644829534327, 6463.224413070461, 6466.385693359123, 6629.105070815571, 6630.370114839083, 6633.701483433354, 6635.601863888182, 6639.170103737033, 6349.809505714836, 6367.331430199948, 6376.139221205078, 6482.773102941374, 6493.058506516623, 6477.935220647733, 6486.708098135501, 6493.545451818327, 6508.739650413931, 6510.544261901621, 6614.10709554204, 6631.0, 6647.135872336566, 6732.495062870402, 6733.42765864907, 6324.083007963912, 6337.112804207322, 6356.141920840627, 6421.935780642134, 6438.356164383712, 6359.427651511386, 6407.167068281094, 6409.070684750778, 6409.102725618324, 6410.775622853178, 6305.873882522415, 6327.651979141007, 6328.335524770017, 6329.620222786648, 6335.65153916539, 6281.371862813682, 6323.6838158090995, 6382.808515744535, 6465.741370345321, 6475.417212450902, 6198.473129783839, 6219.906701399573, 6274.686265686606, 6302.054691796267, 6309.936900630935], "value": 6026.513244991833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.9236868681818, 862.7325529085983, 894.1505569708776, 900.2213085680888, 1187.4419023059158, 30510.847445762767, 40947.18105637885, 42021.99999999996, 42061.57938420615, 42080.36879446803, 42876.35685464713, 42965.78517107418, 42978.140437191236, 43195.568044319545, 43392.3491147633, 7670.501417407864, 7844.254795794391, 7855.567943763091, 7862.449628526006, 7874.173211812735, 7683.961580192119, 7805.1804560520895, 7813.17961614028, 7824.139344672081, 7829.921700783005, 7804.453688241825, 7832.882506762403, 7843.607819609026, 7847.332976696987, 7856.842863142734, 7635.427342949273, 7837.0987336456465, 7840.7647770567255, 7843.098043724931, 7846.921530784676, 7716.961415192888, 7743.574103424309, 7753.457257991943, 7763.72826951054, 7775.339096176832, 37359.252814943546, 37587.62412375869, 37808.81095594532, 37821.432678509846, 38129.0, 3458.0, 3578.5169002184634, 3579.5167652367118, 3584.605693373727, 3587.928241435183, 31994.20014499656, 32220.838895805606, 32224.516632250536, 32241.51637725436, 32332.515012274835, 4839.612830973514, 4890.853274401774, 4930.654854160211, 4932.21084626458, 4969.676970996909, 186425.0, 186797.99999999863, 187031.0, 187083.0, 187589.0, 48223.5177648226, 48745.756271218415, 49014.75492622514, 49016.75491622519, 49051.75474122607, 51584.22623660648, 51603.74198128985, 51613.0, 51649.225261621104, 51727.74136129295, 15907.0, 16059.116748578941, 16059.277332520065, 16072.919635401748, 16090.517284481484, 13049.28228947398, 13053.869461305265, 13058.15122017066, 13064.608061758163, 13064.673383165307, 12953.870461295455, 14484.493042743454, 14604.269786510631, 14834.554963351116, 14854.70290594182, 5740.684262365527, 5802.274715660543, 5803.738831752581, 5900.675462849498, 6115.480184184395, 986.8585170180725, 987.8863930647924, 989.5942663507927, 1031.242037102729, 1034.9534270957824, 23194.76805231926, 23292.7670723294, 23618.409539761644, 23724.169654062025, 23845.046198152228, 1072.8371296658283, 1090.9399983000853, 1104.447776111944, 1118.1781390677845, 1123.3540714089268, 11706.01179128548, 11991.760164796655, 12342.938285308695, 15041.623959400884, 15659.765103523456, 234125.0, 237823.0, 239067.0, 240317.0, 240706.0, 51724.74137629288, 51811.74094129505, 51975.74012129915, 52131.21803172956, 52166.73916630469, 1455.0760267230385, 1479.5931118942376, 1488.7245859516024, 1511.04803973496, 1523.1850959736487, 25627.0, 26183.214503564923, 26186.798630376798, 26230.606540902285, 26279.0, 37755.0, 38050.0, 38359.2328153441, 38452.615473844904, 38477.42283865688, 207569.0, 209793.0, 210261.0, 210691.0, 210988.0, 32796.1800954978, 32821.17947051343, 32891.50662740013, 32962.50556241706, 33282.500762489064, 38113.04717382088, 40178.39732403958, 42234.57765422307, 42874.78562607167, 43176.784116079216, 23413.531729364975, 25316.113936012152, 25621.74378256268, 25626.487470250864, 26073.73926260789, 24150.51698966046, 24697.259082227563, 25153.748462515872, 25320.620190697522, 26359.0, 37911.81044094762, 38155.42766858444, 38352.23295534129, 38556.614433856426, 38655.0, 28912.85543572353, 31731.20671983219, 31782.523262150622, 31864.0, 32773.50839737358, 23976.0, 24490.14284500034, 24569.0, 24780.25659230226, 24847.25458236256], "value": 17166.339176727128, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.283790937147, 586.5073338395747, 586.9589128760986, 589.9705014749263, 593.5785592229516, 22964.311070667885, 23735.643965340532, 23755.168569100086, 23779.0, 23817.285481435585, 19130.521736956583, 20150.294739684115, 20934.790652093474, 25303.0, 25602.615960760602, 6324.683765811703, 6541.47668186544, 6542.607443553378, 6544.312847151052, 6552.3775241352, 5859.7070146492715, 6290.056491526285, 6376.202974628171, 6393.0, 6475.287718350977, 6382.744690212409, 6387.5209359298005, 6395.584287021352, 6398.13625160602, 6429.774957876475, 6402.039694045884, 6411.653552753927, 6426.839329016789, 6435.613863168178, 6445.0, 5971.0, 5975.52195824333, 5978.252718410199, 5980.820575382745, 5991.131285963511, 26748.331291717666, 27542.862285688643, 28013.0, 28030.299242518897, 28911.421771564663, 1891.6784146695095, 1942.1357495914324, 1952.4142757172792, 1953.5604488989864, 1954.0327537868704, 18244.452666420028, 18813.435596932115, 18847.62304753911, 18848.434546963475, 18866.434006979813, 2289.6565515172856, 2343.3321503371626, 2387.164492427654, 2392.5334559760854, 2400.699912510936, 136723.0, 138422.30788846192, 138995.0, 139212.0, 139539.30230348886, 14023.929880350533, 14913.850861491246, 14974.176420296988, 15145.697086058217, 15370.615734606725, 22108.447288817908, 23071.769282307298, 23134.190303339303, 23197.53604927892, 23274.0, 9289.767755806024, 9393.483358415217, 9411.858822117674, 9461.574229159567, 9538.093881081286, 8257.710980115668, 8321.502129616607, 8423.663053477792, 8456.704015359433, 8457.577121143919, 9130.72607821753, 9212.53937303132, 9468.668596599224, 9498.715038548855, 9524.380915240487, 2680.758731714155, 2719.7688196503123, 2723.482538317713, 2795.9580606290924, 2834.96523768827, 936.0953683799154, 953.5137080089066, 955.8191507649937, 965.5558443116105, 986.1174249047206, 19313.324033659035, 19355.709664355047, 22569.435764106027, 24439.877800610884, 24548.754512455005, 991.2119864707574, 999.7450650084328, 1013.381837079381, 1021.2187676427538, 1037.8754549454113, 10743.462826858782, 11308.321500709984, 11529.596464123715, 12555.309457979716, 13454.52909148175, 505836.0, 531175.0, 536041.0, 536529.0, 540794.0, 126624.36687816687, 130698.0, 130702.0, 132220.0, 133674.0, 1245.4893493667553, 1249.4627310256494, 1286.1704200790439, 1287.5815360008035, 1291.4558320109556, 20544.79455205429, 20578.58842823105, 20678.276260330815, 21133.788662113184, 21542.784572154706, 57933.0, 58412.0, 59646.403535964084, 60086.0, 60097.39902600918, 69354.65322673354, 73253.26746732465, 73859.26140738738, 74287.0, 74757.25242747503, 14623.707525849637, 14849.851501485278, 14900.62748431298, 14917.627059323604, 14996.925015374853, 23179.536409272056, 23197.0721171158, 23423.0, 23511.647325290476, 23631.291061268188, 17571.648567028842, 18220.817791822443, 18241.0, 18648.34730784416, 18678.813211867706, 13524.661883452598, 14269.64325891861, 14390.568282951528, 14404.207768572829, 14779.408823646934, 18738.344157954405, 18793.248270069045, 18987.620247594696, 19113.331033413764, 19256.807431926063, 14546.418143274574, 14571.125732456087, 14647.194404307866, 14697.70604587881, 14698.412063517768, 18160.0, 18307.267709292013, 18416.539586510444, 18551.53621159482, 18591.0], "value": 11983.900158453363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.3883033219884, 1368.7946807978801, 1394.5955672854873, 1397.2664351215615, 1404.5014020022886, 11977.161598688095, 12531.812022819653, 14092.788608170886, 14718.852811471883, 14723.705525889476, 14269.072510286824, 14510.709785804278, 14519.709605807904, 14540.200288984102, 14543.636409089779, 2442.2673198040607, 2600.6489123968213, 2628.47430513897, 2641.2340421277804, 2643.510950474159, 2595.3122422558035, 2625.2649258207734, 2625.5930330798756, 2631.3158578769467, 2632.6051092336206, 2536.1630661881627, 2571.33145382201, 2573.4981678572685, 2581.045013345065, 2584.483103379322, 2523.1799665108915, 2523.6719226500622, 2532.9493410131786, 2533.556627590174, 2535.594304911224, 2463.0147940823636, 2504.536660717755, 2509.2221411362534, 2520.4455019895595, 2523.9116630918015, 13817.0, 13940.721185576233, 13972.231527265996, 13981.300934953211, 14055.718885622231, 7428.62856857155, 7732.6133693315105, 7753.069631644183, 7776.494527855728, 7786.4938778979185, 4913.508649135094, 5107.1828507439, 5132.204508301219, 5148.716820574867, 5181.119209734355, 1667.816540180579, 1676.2959556985973, 1713.4174380710617, 1726.7237242041213, 1744.8167942365997, 22972.0, 23105.88447057754, 23176.420589485228, 23182.072717091298, 23194.3041708749, 6403.935960640427, 6430.678466076677, 6445.16212892321, 6606.0, 6624.0, 15885.920570397075, 15903.920480397524, 15935.282912268976, 15960.122193279249, 15971.201439927958, 7283.672234749449, 7417.147028091838, 7420.85158296831, 7421.183669796318, 7422.888656670154, 6678.766243181465, 6780.627065511444, 6827.897581536281, 6875.0, 7003.194632617212, 4973.651844370932, 5063.797448102108, 5077.746112694351, 5151.896962060738, 5263.052650522866, 1506.8041154649825, 1508.4343371235786, 1519.8176218853587, 1537.4618883390724, 1539.1919242397607, 796.474326944214, 817.3747083481142, 838.5849004742691, 838.781916701662, 857.5155037403847, 6679.76620818269, 6955.02629631852, 7074.469414793911, 7277.0, 7582.582957937367, 701.9786211062891, 717.5443593318281, 717.7523754304757, 720.2149656874033, 730.2514922204782, 4058.127502586958, 4227.619514243733, 4288.270993930977, 4304.0, 4324.935125973113, 18333.17500712471, 18803.15385807642, 19094.0, 19119.808801911804, 20120.993950302425, 19574.119164637625, 19699.803001969798, 19750.30873919406, 19805.40583782489, 19823.504412389804, 10096.0, 10786.622468213574, 10982.725431864268, 10995.285306455055, 11022.944885275523, 7888.723894663659, 8141.3893957952205, 8234.341252699889, 8243.0, 8313.584320783815, 15939.44211952576, 17162.485125446256, 17204.225809838837, 17293.08276689284, 17583.64832703313, 17249.0, 17594.91202543979, 17680.82319176843, 17798.288068477636, 18053.458396248134, 10668.946655266984, 10996.340219586851, 11106.61126860556, 11108.389038602954, 11161.72095697614, 13058.542950996669, 13195.736085278433, 13232.073754837069, 13237.27195004284, 13244.00669949777, 9572.664956726481, 9667.564959576977, 9835.704928852147, 10047.196224302184, 10213.08082272599, 8987.595558199766, 9481.478518681539, 9516.762080948032, 9526.952365238129, 9562.521873906417, 8769.736907892773, 8945.776355590902, 8947.776305592151, 8953.104689530996, 8971.551422428984, 6556.63938483388, 6754.392104710403, 6776.15298087739, 6978.371946524837, 7017.403520700797, 6509.934900650933, 6669.46644268467, 6814.182298124257, 6891.966869773529, 6924.3421874921805], "value": 6158.576169985931, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.36466951949615, 491.510946608125, 497.2292945933803, 500.5970193993833, 513.4942082049179, 6127.56002339451, 6160.537959653027, 6226.377362263777, 6247.812565623039, 6265.624062556244, 5833.5333173346135, 6099.847503812407, 6111.083337499377, 6171.876562468748, 6181.258249010114, 4941.851744447672, 4943.184374578191, 4966.609349382161, 4971.428285747149, 4993.275974983625, 4937.703737775727, 4943.703377797344, 4951.77717002734, 4959.231319145538, 4982.0, 4726.527347265263, 4758.096761295475, 4784.0, 4859.708417494961, 4897.436794768611, 4893.926591101136, 4899.363082799231, 4904.5831104356175, 4922.433920099199, 4946.3817022872145, 4365.476142862845, 4380.2772542530765, 4394.318880573484, 4429.778511074465, 4433.334999750031, 6031.849203769897, 6055.878882422327, 6065.423784740443, 6095.146679464879, 6114.11345354921, 5660.179274005287, 5687.203791469156, 5691.658500489983, 5701.515371193454, 5723.828285151452, 6521.804345869631, 6530.44491218247, 6548.967255163694, 6558.704858281341, 6609.702563384659, 4788.162071637449, 4795.880102997418, 4801.135795556798, 4812.181929072066, 4827.0, 6862.48531360145, 6972.1284839395075, 6979.197392299849, 6998.75504357345, 7000.334968178015, 4890.731009794425, 4893.510648935078, 4895.779689913962, 4899.681520701143, 4954.430240522386, 4977.800887964513, 4980.726060066731, 4993.425756038102, 4995.450500444948, 5000.0, 5632.295963004624, 5642.153676948491, 5659.688717120598, 5668.178114173422, 5677.74450149736, 6529.249136349285, 6551.1155993941165, 6551.181102362205, 6616.669166541654, 6624.846924749476, 1599.6480774229651, 1651.1826645810402, 1675.0, 1723.1212081838103, 1741.9303227870996, 1125.2011072138873, 1201.9038476922, 1206.1135065726685, 1206.9155159138777, 1214.372740527697, 5633.57748168889, 5667.376588575254, 5690.9146362804595, 5706.2011318414625, 5728.0262355398845, 6408.885067927573, 6444.355564443518, 6573.506986975996, 6683.799486015428, 6746.730130794811, 5750.511206547407, 5753.395893431213, 5780.393058728857, 5800.259922023461, 5806.477417032487, 3512.7892326459983, 3542.8582856685957, 3557.6875031229906, 3569.714422846218, 3599.7300202484394, 6426.389492998158, 6460.838479038061, 6590.637514936629, 6614.768483103068, 6614.966925165343, 6804.455643548505, 6862.289395688675, 6891.552049116792, 6902.758403455855, 6958.060661810692, 6463.931541906545, 6506.3818937200895, 6582.913819219775, 6585.868282634417, 6588.96705516479, 6606.570572912745, 6648.235452922782, 6659.933400665931, 6672.0, 6694.698738556874, 6650.933490665031, 6674.331417145713, 6681.799546013627, 6682.532222744361, 6686.197656281277, 6522.412982831568, 6563.409293163638, 6600.966995164993, 6617.2721000688925, 6638.468922486093, 4767.380240568704, 4771.475137734777, 4799.712017278975, 4840.201366774443, 4868.634852386156, 6696.363845434676, 6700.597964122168, 6740.9325906740305, 6768.153980752406, 6814.965925170342, 6528.804135875931, 6543.476521878333, 6558.80323590293, 6576.572522786004, 6594.10979517759, 6491.318411566717, 6513.404215967118, 6537.215534135934, 6570.0, 6592.560752521406, 6050.939490605214, 6076.574639775174, 6279.843003924756, 6381.553291269753, 6432.807015789534, 6418.19772528434, 6483.740650373932, 6533.444657204191, 6553.246376666744, 6600.867982640416, 6234.532410069172, 6238.594491358047, 6263.4654509645425, 6286.748530058747, 6345.936540634534], "value": 5009.010299115152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [874.5233847553083, 892.3842548641437, 914.3416739947238, 920.3281604428767, 926.6895589977357, 17935.282588696453, 18842.34051808187, 18880.81119188808, 18882.811171888276, 18907.52731181721, 17196.226169822356, 22131.668024979637, 22205.666914996287, 22206.555868882613, 22379.44051398716, 1021.1473419694564, 1045.5556388534842, 1046.08467590858, 1047.3192424923784, 1047.8271085270922, 999.1806718490805, 1030.5465595138114, 1039.0907955538903, 1040.8959104089606, 1042.426665334067, 1103.9116870650369, 1107.8172101603266, 1107.8227483602625, 1108.4568561404894, 1109.1182509904645, 1096.7532305231339, 1097.4786976186288, 1099.2470157941796, 1100.0484580837558, 1101.3281898042187, 799.6081919859228, 803.333233416269, 804.899387576553, 806.4314658165979, 807.3460496997451, 18710.438686839418, 18742.718859217122, 19626.607467850565, 20156.395308140778, 20156.596868062705, 20458.693119603216, 20656.380308590768, 20831.89584052085, 20976.47558811027, 21030.158793648236, 15273.847261527353, 15352.846471535366, 15381.230938453033, 15420.922895385564, 15463.149526776022, 3486.18074752433, 3491.5460990071383, 3500.597431295408, 3508.1755787389943, 3512.2799826035603, 119939.0, 121496.0, 126488.99999999908, 127589.36205319007, 129143.35428322892, 15780.763288550452, 16145.434909778101, 16312.51062468128, 16378.344866205456, 16393.59016024585, 28597.714022859505, 30275.243118922204, 30333.848330758647, 30362.84818575893, 30579.0, 8212.096669366365, 8431.072582015973, 8432.45189062709, 8439.324854011664, 8443.28232100266, 3979.820908059144, 4062.4921884764403, 4075.653569446571, 4106.240345536085, 4112.424260603518, 4730.361401210861, 5219.217117432416, 5942.7920022799, 5943.465088142088, 6007.219061522062, 1052.4948024947914, 1083.9295445796156, 1095.808233559124, 1103.1175059952006, 1107.413071072333, 650.3691419323249, 667.3826710292959, 679.6465837764334, 686.7424715731601, 689.96205208713, 11137.833306722, 11179.385133817717, 11988.760224795455, 12074.818877716842, 12688.619341419771, 649.0621052579072, 661.3287513174132, 678.4335080207983, 688.4733179117978, 702.0978043214546, 5456.072467680504, 5482.945170548323, 5510.732531517773, 5673.74468148926, 5720.056190728483, 91841.54079229561, 93472.53263733638, 95898.0, 100418.49790751145, 103298.48350758199, 85916.0, 89413.55293223623, 92028.53985730163, 92040.0, 94397.52801236087, 81090.59454702807, 81122.0, 82292.58853705693, 85656.0, 85881.0, 11792.941035294769, 11800.82298765502, 12135.271883687006, 12290.877091228973, 12309.384530773246, 31678.683213167573, 31724.365512690078, 32165.1958701025, 34115.488267676505, 36040.27919441649, 46050.30924536067, 46093.53906460892, 67156.0, 68423.65788171027, 72621.0, 16788.832111679214, 16956.0, 17162.39931602388, 17271.56821079433, 17332.30670773155, 20123.993800310218, 20490.18039278412, 20599.485012874797, 20722.067506962525, 20808.791912080684, 17225.74161387555, 17478.91260543689, 17633.823661763217, 17652.558686032953, 18139.183736732142, 17818.643627127643, 18196.45410637683, 18416.63166736631, 18509.814901851347, 18629.161687723812, 17867.195976181363, 18523.722144168118, 18531.44405667832, 18708.345207917657, 18897.90551047236, 11034.834477482684, 11582.478788454708, 11789.41052947332, 11920.821187682019, 11945.880541194478, 13329.400176991865, 13436.261005644783, 13604.0, 14005.0, 14237.786433203717], "value": 8950.698093078881, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 107.0, 108.0, 107.0, 109.0, 110.0, 101.0, 110.0, 111.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 151.0, 181.0, 120.0, 144.0, 143.0, 118.0, 173.0, 123.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 162.0, 162.0, 163.0, 163.0, 164.0, 166.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 178.0, 75.0, 75.0, 74.0, 74.0, 158.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 138.0, 79.0, 80.0, 79.0, 131.0, 79.0, 79.0, 125.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 152.0, 152.0, 152.0, 152.0, 151.0, 151.0, 153.0, 154.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 59.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 81.0, 80.0, 79.0, 81.0, 81.0, 91.0, 81.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 131.0, 138.0, 142.0, 128.0, 130.0, 139.0, 129.0, 138.0, 187.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 184.0, 182.0, 179.0, 181.0, 183.0, 180.0, 176.0, 181.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 66.0, 68.0, 69.0, 68.0, 65.0, 68.0, 66.0], "value": 67.4, "unit": "score"}]}]} 17:58:10 INFO - Return code: 0 17:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:58:10 INFO - # TBPL SUCCESS # 17:58:10 INFO - Running post-action listener: _package_coverage_data 17:58:10 INFO - Running post-action listener: _resource_record_post_action 17:58:10 INFO - [mozharness: 2017-08-01 00:58:10.891698Z] Finished run-tests step (success) 17:58:10 INFO - Running post-run listener: _resource_record_post_run 17:58:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432410624; Read time: 12; Write time: 272992 17:58:10 INFO - TinderboxPrint: CPU usage
13.1% 17:58:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:58:10 INFO - TinderboxPrint: I/O write bytes / time
432,410,624 / 272,992 17:58:10 INFO - TinderboxPrint: CPU idle
8,264.0 (86.9%) 17:58:10 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 17:58:10 INFO - TinderboxPrint: Swap in / out
0 / 0 17:58:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106958848; Read time: 0; Write time: 57088 17:58:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:58:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325451776; Read time: 0; Write time: 215904 17:58:11 INFO - Running post-run listener: _upload_blobber_files 17:58:11 INFO - Blob upload gear active. 17:58:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:58:11 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:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:58:11 INFO - (blobuploader) - INFO - Open directory for files ... 17:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:12 INFO - (blobuploader) - INFO - Done attempting. 17:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:13 INFO - (blobuploader) - INFO - Done attempting. 17:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:20 INFO - (blobuploader) - INFO - Done attempting. 17:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:21 INFO - (blobuploader) - INFO - Done attempting. 17:58:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:58:21 INFO - Return code: 0 17:58:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:58:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:58:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cfaef16e9076784a1aa42f0bcfba06ef27da319412f09e9e8fb4d95b2b397d99c23f0b14da2c04d287793ce3d4b8b32f05eb2f9a187b1fb30539520295e0aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a814cd7fec9a64f1053708e5bceb3ab142d22dd4d1326ea7a6934952fac70bb061d96b53a5d42b918f5c036b5e02d78cc238391af4229f14721d4b0874811e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b853f0c609b94acc3716e45648e427d3370311fd80ded67f1584fa72f410dc6e3a7125642a32e0f7242458346902a3936fac9ff23c3051c2c1fecd1cc4c6e724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28668db80d3fbeaecccac1be7d76c1cc9d8d19897a4f8433030ab360b28186daa5d7dfca08503c813290e0dccdd73e189322eb23785b5b9545cbe5503ec31af7"} 17:58:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:58:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:58:21 INFO - Contents: 17:58:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cfaef16e9076784a1aa42f0bcfba06ef27da319412f09e9e8fb4d95b2b397d99c23f0b14da2c04d287793ce3d4b8b32f05eb2f9a187b1fb30539520295e0aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a814cd7fec9a64f1053708e5bceb3ab142d22dd4d1326ea7a6934952fac70bb061d96b53a5d42b918f5c036b5e02d78cc238391af4229f14721d4b0874811e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b853f0c609b94acc3716e45648e427d3370311fd80ded67f1584fa72f410dc6e3a7125642a32e0f7242458346902a3936fac9ff23c3051c2c1fecd1cc4c6e724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28668db80d3fbeaecccac1be7d76c1cc9d8d19897a4f8433030ab360b28186daa5d7dfca08503c813290e0dccdd73e189322eb23785b5b9545cbe5503ec31af7"} 17:58:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:58:21 INFO - Copying logs to upload dir... 17:58:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:58:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.494302 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-07-31 17:58:20.565778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 17:58:20.569205) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392 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-Non-PGO/sha512/5cfaef16e9076784a1aa42f0bcfba06ef27da319412f09e9e8fb4d95b2b397d99c23f0b14da2c04d287793ce3d4b8b32f05eb2f9a187b1fb30539520295e0aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a814cd7fec9a64f1053708e5bceb3ab142d22dd4d1326ea7a6934952fac70bb061d96b53a5d42b918f5c036b5e02d78cc238391af4229f14721d4b0874811e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b853f0c609b94acc3716e45648e427d3370311fd80ded67f1584fa72f410dc6e3a7125642a32e0f7242458346902a3936fac9ff23c3051c2c1fecd1cc4c6e724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28668db80d3fbeaecccac1be7d76c1cc9d8d19897a4f8433030ab360b28186daa5d7dfca08503c813290e0dccdd73e189322eb23785b5b9545cbe5503ec31af7"} build_url:https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/DsdJJjUsSgahxwFgH6hwYA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5cfaef16e9076784a1aa42f0bcfba06ef27da319412f09e9e8fb4d95b2b397d99c23f0b14da2c04d287793ce3d4b8b32f05eb2f9a187b1fb30539520295e0aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a814cd7fec9a64f1053708e5bceb3ab142d22dd4d1326ea7a6934952fac70bb061d96b53a5d42b918f5c036b5e02d78cc238391af4229f14721d4b0874811e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b853f0c609b94acc3716e45648e427d3370311fd80ded67f1584fa72f410dc6e3a7125642a32e0f7242458346902a3936fac9ff23c3051c2c1fecd1cc4c6e724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28668db80d3fbeaecccac1be7d76c1cc9d8d19897a4f8433030ab360b28186daa5d7dfca08503c813290e0dccdd73e189322eb23785b5b9545cbe5503ec31af7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 17:58:20.592930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 17:58:20.593227) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501542625.468988-911923392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 17:58:20.676977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 17:58:20.677286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 17:58:20.677564) ========= ========= Total master_lag: 0.20 =========