builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1501550960.49 results: success (0) revision: 44121dbcac6a9d3ff18ed087a09b3205e5a04db1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.488623) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.489148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.489417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.549391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.549637) ========= 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=523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 18:29:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5M=0s 2017-07-31 18:29:20 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.676010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.676286) ========= 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=523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017286 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.727336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:20.727627) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 44121dbcac6a9d3ff18ed087a09b3205e5a04db1 --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 44121dbcac6a9d3ff18ed087a09b3205e5a04db1 --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=523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 18:29:20,942 truncating revision to first 12 chars 2017-07-31 18:29:20,942 Setting DEBUG logging. 2017-07-31 18:29:20,942 attempt 1/10 2017-07-31 18:29:20,942 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/44121dbcac6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 18:29:21,596 unpacking tar archive at: mozilla-central-44121dbcac6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:21.696847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:21.697119) ========= script_repo_revision: 44121dbcac6a9d3ff18ed087a09b3205e5a04db1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:21.697465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:21.697727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 18:29:21.707134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-31 18:29:21.707400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:22 INFO - MultiFileLogger online at 20170731 18:29:22 in /builds/slave/test 18:29:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:29:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:22 INFO - {'append_to_log': False, 18:29:22 INFO - 'base_work_dir': '/builds/slave/test', 18:29:22 INFO - 'blob_upload_branch': 'Firefox', 18:29:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:22 INFO - 'branch': 'Firefox', 18:29:22 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:22 INFO - 'code_coverage': False, 18:29:22 INFO - 'config_files': ('talos/linux_config.py',), 18:29:22 INFO - 'default_actions': ('clobber', 18:29:22 INFO - 'read-buildbot-config', 18:29:22 INFO - 'download-and-extract', 18:29:22 INFO - 'populate-webroot', 18:29:22 INFO - 'create-virtualenv', 18:29:22 INFO - 'install', 18:29:22 INFO - 'setup-mitmproxy', 18:29:22 INFO - 'run-tests'), 18:29:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:22 INFO - 'disable_ccov_upload': False, 18:29:22 INFO - 'download_minidump_stackwalk': True, 18:29:22 INFO - 'download_symbols': 'ondemand', 18:29:22 INFO - 'enable_stylo': False, 18:29:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:22 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:22 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:22 INFO - 'gecko_profile': False, 18:29:22 INFO - 'gecko_profile_interval': 0, 18:29:22 INFO - 'installer_path': 'installer.exe', 18:29:22 INFO - 'log_level': 'info', 18:29:22 INFO - 'log_name': 'talos', 18:29:22 INFO - 'log_to_console': True, 18:29:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:22 INFO - 'opt_config_files': (), 18:29:22 INFO - 'pip_index': False, 18:29:22 INFO - 'suite': 'dromaeojs-e10s', 18:29:22 INFO - 'system_bits': '32', 18:29:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:22 INFO - 'title': 'talos-linux64-ix-065', 18:29:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:22 INFO - 'use_talos_json': True, 18:29:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:22 INFO - 'work_dir': 'build'} 18:29:22 INFO - [mozharness: 2017-08-01 01:29:22.035806Z] Running clobber step. 18:29:22 INFO - Running pre-action listener: _resource_record_pre_action 18:29:22 INFO - Running main action method: clobber 18:29:22 INFO - rmtree: /builds/slave/test/build 18:29:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:23 INFO - Running post-action listener: _resource_record_post_action 18:29:23 INFO - [mozharness: 2017-08-01 01:29:23.073996Z] Finished clobber step (success) 18:29:23 INFO - [mozharness: 2017-08-01 01:29:23.074099Z] Running read-buildbot-config step. 18:29:23 INFO - Running pre-action listener: _resource_record_pre_action 18:29:23 INFO - Running main action method: read_buildbot_config 18:29:23 INFO - Using buildbot properties: 18:29:23 INFO - { 18:29:23 INFO - "project": "", 18:29:23 INFO - "product": "firefox", 18:29:23 INFO - "who": "kwierso@gmail.com", 18:29:23 INFO - "installer_path": "public/build/target.tar.bz2", 18:29:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:29:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:29:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:29:23 INFO - "stage_platform": "linux64-stylosequential", 18:29:23 INFO - "basedir": "/builds/slave/test", 18:29:23 INFO - "buildnumber": 163, 18:29:23 INFO - "platform": "ubuntu64_hw_styloseq", 18:29:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:29:23 INFO - "slavebuilddir": "test", 18:29:23 INFO - "taskId": "PKEFNHFuTr-p59PUDbPrGw", 18:29:23 INFO - "branch": "mozilla-central", 18:29:23 INFO - "script_repo_revision": "production", 18:29:23 INFO - "revision": "44121dbcac6a9d3ff18ed087a09b3205e5a04db1", 18:29:23 INFO - "slavename": "talos-linux64-ix-065", 18:29:23 INFO - "repo_path": "mozilla-central" 18:29:23 INFO - } 18:29:23 INFO - Finding installer, test and symbols from parent task. 18:29:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PKEFNHFuTr-p59PUDbPrGw'}, attempt #1 18:29:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PKEFNHFuTr-p59PUDbPrGw'}, attempt #1 18:29:23 INFO - Task dependencies: ZbeB3PV6RPy_XbcR57i83g 18:29:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g'}, attempt #1 18:29:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2 18:29:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.test_packages.json 18:29:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.crashreporter-symbols.zip 18:29:24 INFO - Running post-action listener: _resource_record_post_action 18:29:24 INFO - [mozharness: 2017-08-01 01:29:24.405745Z] Finished read-buildbot-config step (success) 18:29:24 INFO - [mozharness: 2017-08-01 01:29:24.405967Z] Running download-and-extract step. 18:29:24 INFO - Running pre-action listener: _resource_record_pre_action 18:29:24 INFO - Running main action method: download_and_extract 18:29:24 INFO - mkdir: /builds/slave/test/build/tests 18:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:24 INFO - trying https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.test_packages.json 18:29:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:29:24 INFO - Downloaded 989 bytes. 18:29:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:29:24 INFO - Using the following test package requirements: 18:29:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:29:24 INFO - u'common': [u'target.common.tests.zip'], 18:29:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:29:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:29:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:29:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:29:24 INFO - u'mozbase': [u'target.common.tests.zip'], 18:29:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:29:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:29:24 INFO - u'web-platform': [u'target.common.tests.zip', 18:29:24 INFO - u'target.web-platform.tests.tar.gz'], 18:29:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:29:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:29:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.common.tests.zip 18:29:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:29:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.common.tests.zip into memory 18:29:28 INFO - Content-Length response header: 72390366 18:29:28 INFO - Bytes received: 72390366 18:29:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:29:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.common.tests.zip 18:29:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:29:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.common.tests.zip into memory 18:29:42 INFO - Content-Length response header: 72390366 18:29:42 INFO - Bytes received: 72390366 18:29:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.talos.tests.zip 18:29:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:29:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.talos.tests.zip into memory 18:29:55 INFO - Content-Length response header: 14496467 18:29:55 INFO - Bytes received: 14496467 18:29: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')]} 18:29:55 INFO - trying https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2 18:29:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:29:59 INFO - Downloaded 62400473 bytes. 18:29:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2 18:29:59 INFO - mkdir: /builds/slave/test/properties 18:29:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:59 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:59 INFO - Contents: 18:29:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2 18:29:59 INFO - Running post-action listener: _resource_record_post_action 18:29:59 INFO - Running post-action listener: set_extra_try_arguments 18:29:59 INFO - [mozharness: 2017-08-01 01:29:59.120871Z] Finished download-and-extract step (success) 18:29:59 INFO - [mozharness: 2017-08-01 01:29:59.121100Z] Running populate-webroot step. 18:29:59 INFO - Running pre-action listener: _resource_record_pre_action 18:29:59 INFO - Running main action method: populate_webroot 18:29:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:29:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:29:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:29:59 INFO - 'tests': ['damp', 'tps']}, 18:29:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:29:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:29:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:29:59 INFO - 'other-e10s': {'tests': ['a11yr', 18:29:59 INFO - 'ts_paint', 18:29:59 INFO - 'tpaint', 18:29:59 INFO - 'sessionrestore', 18:29:59 INFO - 'sessionrestore_many_windows', 18:29:59 INFO - 'sessionrestore_no_auto_restore', 18:29:59 INFO - 'tabpaint']}, 18:29:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:29:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:29:59 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:29:59 INFO - 'talos_options': ['--mitmproxy', 18:29:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:29:59 INFO - '--firstNonBlankPaint'], 18:29:59 INFO - 'tests': ['quantum_pageload_google', 18:29:59 INFO - 'quantum_pageload_youtube', 18:29:59 INFO - 'quantum_pageload_amazon', 18:29:59 INFO - 'quantum_pageload_facebook']}, 18:29:59 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:29:59 INFO - 'talos_options': ['--stylo', 18:29:59 INFO - '--mitmproxy', 18:29:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:29:59 INFO - '--firstNonBlankPaint'], 18:29:59 INFO - 'tests': ['quantum_pageload_google', 18:29:59 INFO - 'quantum_pageload_youtube', 18:29:59 INFO - 'quantum_pageload_amazon', 18:29:59 INFO - 'quantum_pageload_facebook']}, 18:29:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:29:59 INFO - 'tsvgr_opacity', 18:29:59 INFO - 'tart', 18:29:59 INFO - 'tscrollx', 18:29:59 INFO - 'cart', 18:29:59 INFO - 'tsvg_static']}, 18:29:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:29:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:29:59 INFO - 'talos_options': ['--stylo', 18:29:59 INFO - '--stylo-threads=1', 18:29:59 INFO - '--mitmproxy', 18:29:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:29:59 INFO - '--firstNonBlankPaint'], 18:29:59 INFO - 'tests': ['tp6_google', 18:29:59 INFO - 'tp6_youtube', 18:29:59 INFO - 'tp6_amazon', 18:29:59 INFO - 'tp6_facebook']}, 18:29:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:29:59 INFO - 'talos_options': ['--xperf_path', 18:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:59 INFO - 'tests': ['tp5n']}}} 18:29:59 INFO - Running post-action listener: _resource_record_post_action 18:29:59 INFO - [mozharness: 2017-08-01 01:29:59.132481Z] Finished populate-webroot step (success) 18:29:59 INFO - [mozharness: 2017-08-01 01:29:59.132571Z] Running create-virtualenv step. 18:29:59 INFO - Running pre-action listener: _resource_record_pre_action 18:29:59 INFO - Running main action method: create_virtualenv 18:29:59 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:59 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 18:29:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:29:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:59 INFO - Using real prefix '/usr' 18:29:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:59 INFO - Installing distribute.............................................................................................................................................................................................done. 18:30:01 INFO - Installing pip.................done. 18:30:01 INFO - Return code: 0 18:30:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:30:01 INFO - Reading from file tmpfile_stdout 18:30:01 INFO - Output received: 18:30:01 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) 18:30:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:30:01 INFO - Using env: {'DISPLAY': ':0', 18:30:01 INFO - 'HOME': '/home/cltbld', 18:30:01 INFO - 'LANG': 'en_US.UTF-8', 18:30:01 INFO - 'LANGUAGE': 'en_US:en', 18:30:01 INFO - 'LOGNAME': 'cltbld', 18:30:01 INFO - 'MAIL': '/var/mail/cltbld', 18:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:01 INFO - 'MOZ_NO_REMOTE': '1', 18:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:01 INFO - 'NO_EM_RESTART': '1', 18:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:01 INFO - 'PWD': '/builds/slave/test', 18:30:01 INFO - 'SHELL': '/bin/bash', 18:30:01 INFO - 'SHLVL': '1', 18:30:01 INFO - 'TERM': 'linux', 18:30:01 INFO - 'TMOUT': '86400', 18:30:01 INFO - 'USER': 'cltbld', 18:30:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:01 INFO - '_': '/tools/buildbot/bin/python'} 18:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:02 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 18:30:02 INFO - Cleaning up... 18:30:02 INFO - Return code: 0 18:30:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30: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')]} 18:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30: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', '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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:30: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 psutil>=3.1.1 18:30:02 INFO - Using env: {'DISPLAY': ':0', 18:30:02 INFO - 'HOME': '/home/cltbld', 18:30:02 INFO - 'LANG': 'en_US.UTF-8', 18:30:02 INFO - 'LANGUAGE': 'en_US:en', 18:30:02 INFO - 'LOGNAME': 'cltbld', 18:30:02 INFO - 'MAIL': '/var/mail/cltbld', 18:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:02 INFO - 'MOZ_NO_REMOTE': '1', 18:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:02 INFO - 'NO_EM_RESTART': '1', 18:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:02 INFO - 'PWD': '/builds/slave/test', 18:30:02 INFO - 'SHELL': '/bin/bash', 18:30:02 INFO - 'SHLVL': '1', 18:30:02 INFO - 'TERM': 'linux', 18:30:02 INFO - 'TMOUT': '86400', 18:30:02 INFO - 'USER': 'cltbld', 18:30:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:02 INFO - '_': '/tools/buildbot/bin/python'} 18:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:02 INFO - Downloading/unpacking psutil>=3.1.1 18:30: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 18:30: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 18:30: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 18:30: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 18:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:30:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:03 INFO - Installing collected packages: psutil 18:30:03 INFO - Running setup.py install for psutil 18:30:03 INFO - building 'psutil._psutil_linux' extension 18:30:03 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 18:30:03 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 18:30:03 INFO - building 'psutil._psutil_posix' extension 18:30:03 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 18:30:03 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 18:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:04 INFO - Successfully installed psutil 18:30:04 INFO - Cleaning up... 18:30:04 INFO - Return code: 0 18:30:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:30:04 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')]} 18:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:04 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')]} 18:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:04 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:04 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 18:30:04 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 18:30:04 INFO - Using env: {'DISPLAY': ':0', 18:30:04 INFO - 'HOME': '/home/cltbld', 18:30:04 INFO - 'LANG': 'en_US.UTF-8', 18:30:04 INFO - 'LANGUAGE': 'en_US:en', 18:30:04 INFO - 'LOGNAME': 'cltbld', 18:30:04 INFO - 'MAIL': '/var/mail/cltbld', 18:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:04 INFO - 'MOZ_NO_REMOTE': '1', 18:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:04 INFO - 'NO_EM_RESTART': '1', 18:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:04 INFO - 'PWD': '/builds/slave/test', 18:30:04 INFO - 'SHELL': '/bin/bash', 18:30:04 INFO - 'SHLVL': '1', 18:30:04 INFO - 'TERM': 'linux', 18:30:04 INFO - 'TMOUT': '86400', 18:30:04 INFO - 'USER': 'cltbld', 18:30:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:04 INFO - '_': '/tools/buildbot/bin/python'} 18:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:30:05 INFO - Installing collected packages: mozsystemmonitor 18:30:05 INFO - Running setup.py install for mozsystemmonitor 18:30:05 INFO - Successfully installed mozsystemmonitor 18:30:05 INFO - Cleaning up... 18:30:05 INFO - Return code: 0 18:30:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30: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')]} 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30: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', '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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:30: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 jsonschema==2.5.1 18:30:05 INFO - Using env: {'DISPLAY': ':0', 18:30:05 INFO - 'HOME': '/home/cltbld', 18:30:05 INFO - 'LANG': 'en_US.UTF-8', 18:30:05 INFO - 'LANGUAGE': 'en_US:en', 18:30:05 INFO - 'LOGNAME': 'cltbld', 18:30:05 INFO - 'MAIL': '/var/mail/cltbld', 18:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:05 INFO - 'MOZ_NO_REMOTE': '1', 18:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:05 INFO - 'NO_EM_RESTART': '1', 18:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:05 INFO - 'PWD': '/builds/slave/test', 18:30:05 INFO - 'SHELL': '/bin/bash', 18:30:05 INFO - 'SHLVL': '1', 18:30:05 INFO - 'TERM': 'linux', 18:30:05 INFO - 'TMOUT': '86400', 18:30:05 INFO - 'USER': 'cltbld', 18:30:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:05 INFO - '_': '/tools/buildbot/bin/python'} 18:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:05 INFO - Downloading/unpacking jsonschema==2.5.1 18:30: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 18:30: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 18:30: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 18:30: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 18:30:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:07 INFO - warning: no files found matching '*.txt' 18:30:07 INFO - no previously-included directories found matching 'build' 18:30:07 INFO - no previously-included directories found matching 'dist' 18:30:07 INFO - no previously-included directories found matching '.git*' 18:30:07 INFO - Installing collected packages: jsonschema, functools32 18:30:07 INFO - Running setup.py install for functools32 18:30:07 INFO - warning: no files found matching '*.txt' 18:30:07 INFO - no previously-included directories found matching 'build' 18:30:07 INFO - no previously-included directories found matching 'dist' 18:30:07 INFO - no previously-included directories found matching '.git*' 18:30:07 INFO - Successfully installed jsonschema functools32 18:30:07 INFO - Cleaning up... 18:30:07 INFO - Return code: 0 18:30:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:07 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:07 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 18:30:07 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 18:30:07 INFO - Using env: {'DISPLAY': ':0', 18:30:07 INFO - 'HOME': '/home/cltbld', 18:30:07 INFO - 'LANG': 'en_US.UTF-8', 18:30:07 INFO - 'LANGUAGE': 'en_US:en', 18:30:07 INFO - 'LOGNAME': 'cltbld', 18:30:07 INFO - 'MAIL': '/var/mail/cltbld', 18:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:07 INFO - 'MOZ_NO_REMOTE': '1', 18:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:07 INFO - 'NO_EM_RESTART': '1', 18:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:07 INFO - 'PWD': '/builds/slave/test', 18:30:07 INFO - 'SHELL': '/bin/bash', 18:30:07 INFO - 'SHLVL': '1', 18:30:07 INFO - 'TERM': 'linux', 18:30:07 INFO - 'TMOUT': '86400', 18:30:07 INFO - 'USER': 'cltbld', 18:30:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:07 INFO - '_': '/tools/buildbot/bin/python'} 18:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:30:07 INFO - Cleaning up... 18:30:07 INFO - Return code: 0 18:30:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:07 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:07 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 18:30:07 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 18:30:07 INFO - Using env: {'DISPLAY': ':0', 18:30:07 INFO - 'HOME': '/home/cltbld', 18:30:07 INFO - 'LANG': 'en_US.UTF-8', 18:30:07 INFO - 'LANGUAGE': 'en_US:en', 18:30:07 INFO - 'LOGNAME': 'cltbld', 18:30:07 INFO - 'MAIL': '/var/mail/cltbld', 18:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:07 INFO - 'MOZ_NO_REMOTE': '1', 18:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:07 INFO - 'NO_EM_RESTART': '1', 18:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:07 INFO - 'PWD': '/builds/slave/test', 18:30:07 INFO - 'SHELL': '/bin/bash', 18:30:07 INFO - 'SHLVL': '1', 18:30:07 INFO - 'TERM': 'linux', 18:30:07 INFO - 'TMOUT': '86400', 18:30:07 INFO - 'USER': 'cltbld', 18:30:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:07 INFO - '_': '/tools/buildbot/bin/python'} 18:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:30: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 18:30: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 18:30: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 18:30: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 18:30:08 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:08 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 18:30:08 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 18:30:08 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 18:30:08 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 18:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:09 INFO - Downloading docopt-0.6.1.tar.gz 18:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:09 INFO - Running setup.py install for blobuploader 18:30:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:09 INFO - Running setup.py install for requests 18:30:09 INFO - Running setup.py install for docopt 18:30:09 INFO - Successfully installed blobuploader requests docopt 18:30:09 INFO - Cleaning up... 18:30:10 INFO - Return code: 0 18:30:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:10 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:10 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 18:30:10 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 18:30:10 INFO - Using env: {'DISPLAY': ':0', 18:30:10 INFO - 'HOME': '/home/cltbld', 18:30:10 INFO - 'LANG': 'en_US.UTF-8', 18:30:10 INFO - 'LANGUAGE': 'en_US:en', 18:30:10 INFO - 'LOGNAME': 'cltbld', 18:30:10 INFO - 'MAIL': '/var/mail/cltbld', 18:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:10 INFO - 'MOZ_NO_REMOTE': '1', 18:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:10 INFO - 'NO_EM_RESTART': '1', 18:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:10 INFO - 'PWD': '/builds/slave/test', 18:30:10 INFO - 'SHELL': '/bin/bash', 18:30:10 INFO - 'SHLVL': '1', 18:30:10 INFO - 'TERM': 'linux', 18:30:10 INFO - 'TMOUT': '86400', 18:30:10 INFO - 'USER': 'cltbld', 18:30:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:10 INFO - '_': '/tools/buildbot/bin/python'} 18:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:10 INFO - Running setup.py (path:/tmp/pip-a4m5CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:10 INFO - Running setup.py (path:/tmp/pip-PCAR6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:10 INFO - Running setup.py (path:/tmp/pip-QkCwZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:10 INFO - Running setup.py (path:/tmp/pip-QL5mpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:10 INFO - Running setup.py (path:/tmp/pip-CLtDAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:10 INFO - Running setup.py (path:/tmp/pip-c1XHAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:10 INFO - Running setup.py (path:/tmp/pip-Q1HnFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:10 INFO - Running setup.py (path:/tmp/pip-DH2YyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:10 INFO - Running setup.py (path:/tmp/pip-Pim6AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:10 INFO - Running setup.py (path:/tmp/pip-uQv954-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:10 INFO - Running setup.py (path:/tmp/pip-tLeMOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:11 INFO - Running setup.py (path:/tmp/pip-V2uJdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:11 INFO - Running setup.py (path:/tmp/pip-mK8rUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:11 INFO - Running setup.py (path:/tmp/pip-tTDdvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:11 INFO - Running setup.py (path:/tmp/pip-xZfKzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:11 INFO - Running setup.py (path:/tmp/pip-EQm4gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:11 INFO - Running setup.py (path:/tmp/pip-VS9b1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:11 INFO - Running setup.py install for manifestparser 18:30:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:11 INFO - Running setup.py install for mozcrash 18:30:11 INFO - Running setup.py install for mozdebug 18:30:11 INFO - Running setup.py install for mozdevice 18:30:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:11 INFO - Running setup.py install for mozfile 18:30:11 INFO - Running setup.py install for mozhttpd 18:30:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for mozinfo 18:30:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for mozInstall 18:30:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for mozleak 18:30:12 INFO - Running setup.py install for mozlog 18:30:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for moznetwork 18:30:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for mozprocess 18:30:12 INFO - Running setup.py install for mozprofile 18:30:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for mozrunner 18:30:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:12 INFO - Running setup.py install for mozscreenshot 18:30:13 INFO - Running setup.py install for moztest 18:30:13 INFO - Running setup.py install for mozversion 18:30:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:13 INFO - Cleaning up... 18:30:13 INFO - Return code: 0 18:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:13 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')]} 18:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:13 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')]} 18:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:13 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:13 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 18:30:13 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 18:30:13 INFO - Using env: {'DISPLAY': ':0', 18:30:13 INFO - 'HOME': '/home/cltbld', 18:30:13 INFO - 'LANG': 'en_US.UTF-8', 18:30:13 INFO - 'LANGUAGE': 'en_US:en', 18:30:13 INFO - 'LOGNAME': 'cltbld', 18:30:13 INFO - 'MAIL': '/var/mail/cltbld', 18:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:13 INFO - 'MOZ_NO_REMOTE': '1', 18:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:13 INFO - 'NO_EM_RESTART': '1', 18:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:13 INFO - 'PWD': '/builds/slave/test', 18:30:13 INFO - 'SHELL': '/bin/bash', 18:30:13 INFO - 'SHLVL': '1', 18:30:13 INFO - 'TERM': 'linux', 18:30:13 INFO - 'TMOUT': '86400', 18:30:13 INFO - 'USER': 'cltbld', 18:30:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:13 INFO - '_': '/tools/buildbot/bin/python'} 18:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:13 INFO - Running setup.py (path:/tmp/pip-89x5Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:13 INFO - Running setup.py (path:/tmp/pip-zf7wWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:13 INFO - Running setup.py (path:/tmp/pip-wCRfJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:13 INFO - Running setup.py (path:/tmp/pip-psIDOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:13 INFO - Running setup.py (path:/tmp/pip-gE9ea5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:13 INFO - Running setup.py (path:/tmp/pip-ReyfYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:13 INFO - Running setup.py (path:/tmp/pip-dN8lT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:13 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)) 18:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:13 INFO - Running setup.py (path:/tmp/pip-ioV7OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:14 INFO - Running setup.py (path:/tmp/pip-5wZZ8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:14 INFO - Running setup.py (path:/tmp/pip-5dvrwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:14 INFO - Running setup.py (path:/tmp/pip-p4uK8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:14 INFO - Running setup.py (path:/tmp/pip-JzaG50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:14 INFO - Running setup.py (path:/tmp/pip-dMVuPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:14 INFO - Running setup.py (path:/tmp/pip-Pf46cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:14 INFO - Running setup.py (path:/tmp/pip-yklDJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:14 INFO - Running setup.py (path:/tmp/pip-uJmbgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:14 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)) 18:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:14 INFO - Running setup.py (path:/tmp/pip-r_by2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:14 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)) 18:30:14 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)) 18:30:14 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)) 18:30:14 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)) 18:30:14 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)) 18:30:14 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)) 18:30:14 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)) 18:30:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30: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 18:30: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 18:30: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 18:30: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 18:30:15 INFO - Downloading blessings-1.6.tar.gz 18:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:15 INFO - Installing collected packages: blessings 18:30:15 INFO - Running setup.py install for blessings 18:30:15 INFO - Successfully installed blessings 18:30:15 INFO - Cleaning up... 18:30:16 INFO - Return code: 0 18:30:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:16 INFO - Reading from file tmpfile_stdout 18:30:16 INFO - Current package versions: 18:30:16 INFO - argparse == 1.2.1 18:30:16 INFO - blessings == 1.6 18:30:16 INFO - blobuploader == 1.2.4 18:30:16 INFO - docopt == 0.6.1 18:30:16 INFO - functools32 == 3.2.3-2 18:30:16 INFO - jsonschema == 2.5.1 18:30:16 INFO - manifestparser == 1.1 18:30:16 INFO - mozInstall == 1.13 18:30:16 INFO - mozcrash == 1.0 18:30:16 INFO - mozdebug == 0.1 18:30:16 INFO - mozdevice == 0.51 18:30:16 INFO - mozfile == 1.2 18:30:16 INFO - mozhttpd == 0.7 18:30:16 INFO - mozinfo == 0.10 18:30:16 INFO - mozleak == 0.1 18:30:16 INFO - mozlog == 3.5 18:30:16 INFO - moznetwork == 0.27 18:30:16 INFO - mozprocess == 0.25 18:30:16 INFO - mozprofile == 0.28 18:30:16 INFO - mozrunner == 6.13 18:30:16 INFO - mozscreenshot == 0.1 18:30:16 INFO - mozsystemmonitor == 0.3 18:30:16 INFO - moztest == 0.8 18:30:16 INFO - mozversion == 1.4 18:30:16 INFO - psutil == 3.1.1 18:30:16 INFO - requests == 1.2.3 18:30:16 INFO - wsgiref == 0.1.2 18:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30: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')]} 18:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:16 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:16 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 18:30:16 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 18:30:16 INFO - Using env: {'DISPLAY': ':0', 18:30:16 INFO - 'HOME': '/home/cltbld', 18:30:16 INFO - 'LANG': 'en_US.UTF-8', 18:30:16 INFO - 'LANGUAGE': 'en_US:en', 18:30:16 INFO - 'LOGNAME': 'cltbld', 18:30:16 INFO - 'MAIL': '/var/mail/cltbld', 18:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:16 INFO - 'MOZ_NO_REMOTE': '1', 18:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:16 INFO - 'NO_EM_RESTART': '1', 18:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:16 INFO - 'PWD': '/builds/slave/test', 18:30:16 INFO - 'SHELL': '/bin/bash', 18:30:16 INFO - 'SHLVL': '1', 18:30:16 INFO - 'TERM': 'linux', 18:30:16 INFO - 'TMOUT': '86400', 18:30:16 INFO - 'USER': 'cltbld', 18:30:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:16 INFO - '_': '/tools/buildbot/bin/python'} 18:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 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)) 18:30:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:30:16 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 18:30:16 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 18:30:16 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 18:30:16 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 18:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:30:17 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)) 18:30:17 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)) 18:30:17 INFO - Installing collected packages: simplejson 18:30:17 INFO - Running setup.py install for simplejson 18:30:17 INFO - building 'simplejson._speedups' extension 18:30:17 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 18:30:18 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 18:30:18 INFO - Successfully installed simplejson 18:30:18 INFO - Cleaning up... 18:30:18 INFO - Return code: 0 18:30:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:18 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 0x292b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, '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': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', '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 18:30:18 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 18:30:18 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 18:30:18 INFO - Using env: {'DISPLAY': ':0', 18:30:18 INFO - 'HOME': '/home/cltbld', 18:30:18 INFO - 'LANG': 'en_US.UTF-8', 18:30:18 INFO - 'LANGUAGE': 'en_US:en', 18:30:18 INFO - 'LOGNAME': 'cltbld', 18:30:18 INFO - 'MAIL': '/var/mail/cltbld', 18:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:18 INFO - 'MOZ_NO_REMOTE': '1', 18:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:18 INFO - 'NO_EM_RESTART': '1', 18:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:18 INFO - 'PWD': '/builds/slave/test', 18:30:18 INFO - 'SHELL': '/bin/bash', 18:30:18 INFO - 'SHLVL': '1', 18:30:18 INFO - 'TERM': 'linux', 18:30:18 INFO - 'TMOUT': '86400', 18:30:18 INFO - 'USER': 'cltbld', 18:30:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:18 INFO - '_': '/tools/buildbot/bin/python'} 18:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:18 INFO - Cleaning up... 18:30:18 INFO - Return code: 0 18:30:18 INFO - Running post-action listener: _resource_record_post_action 18:30:18 INFO - Running post-action listener: _start_resource_monitoring 18:30:18 INFO - Starting resource monitoring. 18:30:18 INFO - [mozharness: 2017-08-01 01:30:18.928857Z] Finished create-virtualenv step (success) 18:30:18 INFO - [mozharness: 2017-08-01 01:30:18.929321Z] Running install step. 18:30:18 INFO - Running pre-action listener: _resource_record_pre_action 18:30:18 INFO - Running main action method: install 18:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:19 INFO - Reading from file tmpfile_stdout 18:30:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:19 INFO - Reading from file tmpfile_stdout 18:30:19 INFO - Output received: 18:30:19 INFO - Usage: mozinstall [options] installer 18:30:19 INFO - Options: 18:30:19 INFO - -h, --help show this help message and exit 18:30:19 INFO - -d DEST, --destination=DEST 18:30:19 INFO - Directory to install application into. [default: 18:30:19 INFO - "/builds/slave/test"] 18:30:19 INFO - --app=APP Application being installed. [default: firefox] 18:30:19 INFO - mkdir: /builds/slave/test/build/application 18:30:19 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'] 18:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:30:37 INFO - Reading from file tmpfile_stdout 18:30:37 INFO - Output received: 18:30:37 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:37 INFO - Running post-action listener: _resource_record_post_action 18:30:37 INFO - [mozharness: 2017-08-01 01:30:37.356056Z] Finished install step (success) 18:30:37 INFO - [mozharness: 2017-08-01 01:30:37.356311Z] Running setup-mitmproxy step. 18:30:37 INFO - Running pre-action listener: _resource_record_pre_action 18:30:37 INFO - Running main action method: setup_mitmproxy 18:30:37 INFO - Skipping: mitmproxy is not required 18:30:37 INFO - Running post-action listener: _resource_record_post_action 18:30:37 INFO - [mozharness: 2017-08-01 01:30:37.357545Z] Finished setup-mitmproxy step (success) 18:30:37 INFO - [mozharness: 2017-08-01 01:30:37.357776Z] Running run-tests step. 18:30:37 INFO - Running pre-action listener: _resource_record_pre_action 18:30:37 INFO - Running pre-action listener: _set_gcov_prefix 18:30:37 INFO - Running main action method: run_tests 18:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:37 INFO - Python 2.7.3 18:30:37 INFO - Return code: 0 18:30:37 INFO - grabbing minidump binary from tooltool 18:30:37 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')]} 18:30:37 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 0x2c97eb0>, '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 0x2c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c99240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:37 INFO - Return code: 0 18:30:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:37 INFO - ENV: RUST_BACKTRACE is now 1 18:30:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 18:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 18:30:37 INFO - Using env: {'DISPLAY': ':0', 18:30:37 INFO - 'HOME': '/home/cltbld', 18:30:37 INFO - 'LANG': 'en_US.UTF-8', 18:30:37 INFO - 'LANGUAGE': 'en_US:en', 18:30:37 INFO - 'LOGNAME': 'cltbld', 18:30:37 INFO - 'MAIL': '/var/mail/cltbld', 18:30:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:37 INFO - 'MOZ_NO_REMOTE': '1', 18:30:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:37 INFO - 'NO_EM_RESTART': '1', 18:30:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:37 INFO - 'PWD': '/builds/slave/test', 18:30:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:37 INFO - 'RUST_BACKTRACE': '1', 18:30:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:30:37 INFO - 'SHELL': '/bin/bash', 18:30:37 INFO - 'SHLVL': '1', 18:30:37 INFO - 'STYLO_FORCE_ENABLED': '1', 18:30:37 INFO - 'TERM': 'linux', 18:30:37 INFO - 'TMOUT': '86400', 18:30:37 INFO - 'USER': 'cltbld', 18:30:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034', 18:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:37 INFO - '_': '/tools/buildbot/bin/python'} 18:30:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 18:30:37 INFO - mozversion application_buildid: 20170801004347 18:30:37 INFO - mozversion application_changeset: 44121dbcac6a9d3ff18ed087a09b3205e5a04db1 18:30:37 INFO - mozversion application_display_name: Nightly 18:30:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:37 INFO - mozversion application_name: Firefox 18:30:37 INFO - mozversion application_remotingname: firefox 18:30:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:30:37 INFO - mozversion application_vendor: Mozilla 18:30:37 INFO - mozversion application_version: 56.0a1 18:30:37 INFO - mozversion platform_buildid: 20170801004347 18:30:37 INFO - mozversion platform_changeset: 44121dbcac6a9d3ff18ed087a09b3205e5a04db1 18:30:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:30:37 INFO - mozversion platform_version: 56.0a1 18:30:37 INFO - using testdate: 1501551037 18:30:37 INFO - actual date: 1501551037 18:30:37 INFO - starting webserver on 'localhost:35526' 18:30:37 INFO - SUITE-START | Running 2 tests 18:30:37 INFO - TEST-START | dromaeo_css 18:30:37 INFO - Initialising browser for dromaeo_css test... 18:30:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35526/getInfo.html -profile /tmp/tmpxnJsyr/profile 18:30:37 INFO - TEST-INFO | started process 18114 (/builds/slave/test/build/application/firefox/firefox http://localhost:35526/getInfo.html) 18:30:43 INFO - TEST-INFO | 18114: exit 0 18:30:43 INFO - Browser initialized. 18:30:43 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:43 INFO - TEST-INFO | started process 18337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnJsyr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:44 INFO - PID 18337 | 18:30:44 INFO - PID 18337 | (/builds/slave/test/build/application/firefox/firefox:18391): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:30:44 INFO - PID 18337 | 18:30:55 INFO - PID 18337 | RSS: Main: 174383104 18:30:55 INFO - PID 18337 | 18:33:54 INFO - PID 18337 | Cycle 1(1): loaded http://localhost:35526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35526/tests/dromaeo/cssquery-ext.html) 18:33:56 INFO - PID 18337 | RSS: Main: 175910912 18:33:56 INFO - PID 18337 | 18:36:58 INFO - PID 18337 | Cycle 1(1): loaded http://localhost:35526/tests/dromaeo/cssquery-ext.html (next: http://localhost:35526/tests/dromaeo/cssquery-jquery.html) 18:36:58 INFO - PID 18337 | RSS: Main: 173436928 18:36:58 INFO - PID 18337 | 18:40:00 INFO - PID 18337 | Cycle 1(1): loaded http://localhost:35526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35526/tests/dromaeo/cssquery-mootools.html) 18:40:01 INFO - PID 18337 | RSS: Main: 175423488 18:40:01 INFO - PID 18337 | 18:43:03 INFO - PID 18337 | Cycle 1(1): loaded http://localhost:35526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35526/tests/dromaeo/cssquery-prototype.html) 18:43:03 INFO - PID 18337 | RSS: Main: 174120960 18:43:03 INFO - PID 18337 | 18:46:07 INFO - PID 18337 | Cycle 1(1): loaded http://localhost:35526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35526/tests/dromaeo/cssquery-yui.html) 18:46:08 INFO - PID 18337 | RSS: Main: 177504256 18:46:08 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | Cycle 1(1): loaded http://localhost:35526/tests/dromaeo/cssquery-yui.html (next: http://localhost:35526/tests/dromaeo/cssquery-dojo.html) 18:49:10 INFO - PID 18337 | RSS: Main: 177496064 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | __start_tp_report 18:49:10 INFO - PID 18337 | _x_x_mozilla_page_load 18:49:10 INFO - PID 18337 | _x_x_mozilla_page_load_details 18:49:10 INFO - PID 18337 | |i|pagename|runs| 18:49:10 INFO - PID 18337 | |0;dojo.html;3106.4408406486837;3172.5875636167293;3193.8722451101958;3194.9840250798748;3197.6962188592092;6107.694615269235;6169.722362493687;6183.845403864906;6183.907241391383;6250.624962502253;6180.629162250269;6197.814065578029;6215.782447614334;6218.906716399247;6241.531885108624;5707.5148612368;5712.143178523234;5713.514351280146;5718.342390625069;5771.105478650816;5698.43015698431;5779.1620215069;5779.653220806744;5806.535477161817;5806.82579522615;5619.831405057835;5715.5427565794635;5724.742386592613;5734.311882574076;5784.537237021049;5570.610057295991;5580.469855363734;5631.408702086263;5656.2929633795775;5680.517156041741;5619.887602247933;5629.3526244482;5670;5681.7727290908315;5684.971575142098;6095.573309868311;6102.389761023906;6126.509879209697;6220.720067596969;6245.531585131088;6527.771527996498;6620.205575330943;6626.668666566652;6636.30318816527;6695.163104611924;6647.069410282565;6692.63190524521;6696.263411024784;6699.062131301622;6715.899261511081;6157.7229024694;6187.504999600022;6199.194104766397;6200.224971878515;6201.596896201778;6764.4926630502905;6818.829529261808;6843.0419741236265;6853.348931851466;6853.623050732258;6474.384933431316;6494.090827284184;6509.609423434609;6520.315366886503;6527.281998980204;6567.474602031826;6617.735290588323;6652.301508341651;6722.563033402813;6747.628880411527;6559.442447392025;6579.47364210862;6581.539292249592;6588.4070433660245;6603.141591593062;6598.967005164944;6603.867922641521;6618.86762264752;6622.966885165543;6647.468202543785;5340.092184328673;5365.839024829262;5365.892682146336;5388.407275199725;5398.13629819227;4643.466001409881;4663;4710.788014539354;4759.928601070987;4778.37881075458;5691.9146212806845;5745.0397463357485;5757.913631295534;5796.536277097822;5843.0066888629035;6655.23464801554;6661.3338666132995;6662.333766623396;6665.533412661067;6668.099806526154;5602.299712535933;5610.13042978339;5666.150077488327;5677.858053548694;5724.599278050497;5503.862403439946;5790.10253410722;5851.795187168429;5863.677497737665;6017.1275165100815;6403.071554624554;6418.358164183544;6497.480201583862;6497.64262965532;6552.901706474407;6606.966965165144;6690.899636505554;6704.329567043452;6716.83207919806;6792.72829086831;6424.068510065921;6426.068220108152;6431.517636177399;6434.517411194086;6438.967805160944;6440.677966101583;6463.385978332239;6522.771702990372;6532.248791389051;6553.574017688835;6651.900221496779;6681.365270299314;6688.030235615905;6695.598264104169;6748.493862960199;6523.054157147282;6529.575577587441;6611.074449576967;6619.205695316593;6626.768063117768;6332.398422149889;6434.099226108255;6486.6756662167645;6521.771737989147;6610.4711623071;6407.16706828128;6408.9038664421005;6441.355864413521;6449.193850768654;6467.417932386108;6511.055896894829;6559.639219842955;6573.835654108494;6578.407943285128;6591.274959754519;6286.497080233479;6333.936660633335;6359.713812878339;6364.586301890362;6433.517486188648 18:49:10 INFO - PID 18337 | |1;ext.html;813.2477458351027;850.6767428377216;879.1516186879662;899.8605216191488;905.2260317428598;38339.80830095849;39102;39182.21635567287;39212;39284.60715392849;35461;35618.643813561925;35661.10847228821;35715;35725.82137089317;6789.660516974156;6937.583744975318;6944.062551555551;6947.235804061549;6958.582485050888;6860.55406398585;6956.721731130749;6958.060661810667;6962.060121883557;6964.268751781066;7437;7519.473636845423;7523.059617547807;7523.811904702371;7532.246775322451;7395.8151046224;7558.546487210785;7561.735339263127;7569.697212111509;7578.317951384402;7332.633368331615;7477.439192060563;7550.886736698954;7559.735409260705;7564.1679415264825;37659.24681506355;37881;38033.23933521342;38050.42924356109;38086.619133808585;3476.2178509835085;3541.8937431877084;3544.9645503544893;3561.4835848802036;3564.803935783531;31163.84418077918;31419.05742827719;31422.057338279887;31463.213419664462;31488;4596.609288210506;4750.95249047512;4755.857324280277;4759.738214398207;4759.976200118977;179905;182347;186371;188453;195168;46562;46929;46978;46985.5301446988;47119.764401177774;48680.26979595309;48794.512054879706;48877.51122488801;48925.266121008215;49112;15915.522534323989;16007.919960400357;16160.83839161617;16280.755788662942;16441.506754797374;13566.186028838301;13573.253471059186;13574.864251357558;13576.049676522549;13582.117162384413;14122.435102595986;14174.22041787691;14234.572962811133;14256;14392.928035359757;5677.716114194273;5712.914306285409;5744.195812586241;5813.360530341659;5852.531797456193;962.5235508423375;977.0864241933815;984.6209209454412;997.5162046407487;1003.1322905686675;22021.559568808534;22151;22449.663255051186;22470.43823904383;22629;1078.5038882114316;1095.5015467962057;1096.8464414981909;1111.7109551516503;1114.7046032801313;11855.525778968744;11871.643850684493;11930.761384772255;11991.340476273888;12083.818742718866;211210;211322;211765;211945;211958;48486.75756621265;48529.544113676646;49160;49173;49844;1436.346462359624;1462.4919950158148;1470.3603932289489;1488.1071357185817;1490.3308294709777;21903.233386831384;22010.229641962454;22335.32485063594;22378;22417.77582224157;36021.63978360183;36055.09862253465;36117.819410902775;36193.27613447663;36232.81883590565;192670;193045;193251;193763;194160;29898;30123.54814677738;32522.83738581292;33288.50067248945;33457.33085338231;40796.79601601973;42205.36691949562;42507.3623895648;42868.35697464478;42885.1422971545;27830.330180189252;28095.510793516096;30315.848420757757;30849.845750771103;30912.227194320323;30621.08136755901;30889.382212356075;31457.685423145474;31652.841735791175;32009.359812803148;35149.47275790916;36083.81958090193;36239.63760362468;36425.45361819522;36430;30863.845680771454;31738.206544836565;31997.200069998435;32475.35049299048;32929.67070329266;22669.546609068057;23850.88074559616;24320.252242544175;24414.511709766062;24551.75448245566 18:49:10 INFO - PID 18337 | |2;jquery.html;564.2439131563704;569.1377562992068;571.6398668838631;578.5313895744447;588.94405031522;21090.789092109073;22303.77696223037;22308.442288942784;22322.330330090084;22736.43158921028;23270;23997;24016.879915600442;24038.63942040871;24050.278491645236;6259.593126446778;6462.192225971754;6472.223333200022;6472.805815825509;6476.838079048014;6295.496360291166;6479.384458476437;6613.437857782094;6618.635975021371;6623.966880165593;6596.604203747766;6596.736130554772;6597.868042639145;6599.47204223661;6602.075709400688;6554.3117972613145;6580.901286480706;6582.539222254421;6587.374199451045;6593.076969224312;6066.423689749467;6091.969540152315;6103.328633850273;6123.4079139424075;6143.354947730513;28294.15117546477;29423.70576294231;30140.8492957536;30212.697873021207;30455.23861903448;1824.4435447188603;1860.023487668971;1866.393422137797;1873.4286042756953;1878.2674756844706;18397.448076557725;18947.715784263248;18951.336703215322;18977.146028428753;19010.52473688169;2254.199759085534;2335.824813139004;2373.6439534070028;2373.9287821365388;2377.4784138151595;130139;132174.33912830567;132418;133148.33425832907;133841;14308.356123974447;15272.556390977612;15434.922825385802;15589.84410155884;15784.21078946071;22614;23603.40991475227;23643.40891477727;23655.408614784767;23699;10040.64857729976;10173.745656358502;10270;10405.84391234132;10516.631917882838;9306.11591898782;9361.157495825271;9427.198688111588;9434.386764860263;9541.18899893503;9426.387284826464;9464.68115311753;9584.424934503952;9647;9647.951760241294;2765.3131589730247;2806.466771313444;2827.137722994465;2843.4028853940904;2846.957295640567;938.5823308627731;942.6842007927283;954.7135859242338;978.1587834462357;978.6379039755194;19763.60472790536;19814.70277945832;19959.700604490943;20092.196312147644;20738.48153796167;964.1274646444979;996.8106059848606;1020.7448137965508;1021.4484178543503;1051.2746205118444;10568.947155264175;10595.470226488645;10771.082051358924;11118.55525778976;11319.830202546967;538312;543581;551992;554698;567864;113191.43404282926;115183;116810.32758689727;117508;121149;1220.7741567809983;1244.7137158453424;1283.7881749511412;1288.3300683644452;1298.6169080121388;19688.31090911811;20657.58684826325;21040.263590774248;21311.46721331917;21684.24105156312;55016;55146.72426637841;55463.44536554744;56911.71544142253;58234;67526.66236668786;70342.94485582823;70527;70604;71077;14668.413263469341;15245.542633721006;15260.771088433461;15279.694406111594;15280.923595381952;22340.88829555842;23554.175603853782;23643.52712945766;23788.286351409486;23813.642795357737;18927.810721892605;18938.337158199396;19006.429807105807;19037.809621903605;19073.427797166107;14189.716205675622;15107.773383399477;15428.614284642974;16048;16635;18326.17532211027;19289.710654339917;19330;19396.903015485397;19440.2223911042;14432.567022989328;15168.924155379153;15266.770998435255;15269.236538173269;15277.541673749805;18860.434186974413;18861.811381886004;18863;18874.339398121;18905.338313158973 18:49:10 INFO - PID 18337 | |3;mootools.html;1276.8978481721463;1326.4163767942105;1341.4567100324373;1353.3571553512077;1355.6204262806414;13573.7963930541;13972.301384930764;14028.228447435413;14048.016638835286;14183.432662693493;13674.931625341884;14632.122072675647;14673.926630366834;14698.926505367484;14807.185604791732;2684.449687814003;2740.0957683964343;2749.8762555685043;2751.463464624399;2758.3931535062256;2631.2500937232894;2660.946781064378;2691.448253108108;2745.025515941842;2762.2127693607326;2729.7443176139;2758.2828464599247;2760.7101254368204;2761.516734571452;2763.5301998660275;2627.4219671672204;2630.3292660371676;2635.8813853376546;2645.325442012294;2651.6950550686724;2619.5153896529014;2619.89520419183;2646.1664575658797;2646.298730836311;2646.4574762173706;13888.375023123983;14216.218108004055;14264.500742474067;14278.714425711427;14284.428622855074;7526.661300241502;7782.299593036654;7790.415718821055;7794.922050779476;7799.805004874866;4937.21004639256;5098.688249247361;5130;5211.374635043781;5232.764525596357;1834.220456306078;1851.685213513706;1869.8971556564384;1874.8031456696988;1876.6152938647544;23353.649695254586;23577;23603.527929441316;23627.29118126459;23633;6392.84017899547;6570.310117437696;6615.569987950767;6734.0572319875255;6787.1176747023555;15933.601659958362;18608.906955465405;18895.81104188968;18996.24015039383;19092.140853661618;7924.049114106344;8212.917870821215;8216.055153657286;8218.424710270223;8218.671253149927;7102.076730025064;7155.964220178866;7291.08861392326;7319.670614822346;7403.555786652818;5463.31708536433;5624.100143976944;5627.831165065055;5639.407862174413;5681.204631351614;1726.66330065636;1773.7073382891679;1777.5733823882176;1780.7328900664745;1809.4209852846964;815.2214635023538;819.4059307002494;823.9629216685264;845.6532821543137;861.5778268648318;6524.380183882524;6796.592204467748;6838.418734407631;7859.803504912423;7956.164602716747;921.801812610292;927.1423932862076;954.4941181173989;984.2126298960802;1000.7047920863363;4525.864224073283;4605.447346318396;4727.787249573777;4773.427188737373;4938.308636790852;17898.194581243875;18113.637727245383;18207.27170913175;18336.174872130785;18942.43172704821;17409.738853917203;17508.912455437643;17928.193231304624;17946.730799038025;17998.190081446366;10551.314164579278;10619.09737672291;10720.3031802931;10755.731106722395;10759.139268858473;6628.436582890508;7309.853802923805;7337.926620733938;7493.43799215072;7533.811654708456;15494.84505154934;16353.264103115627;16623.83376166223;16655.3337866484;16853.494395168163;16206;16325.755113673542;16373.738179787108;16745.832541674914;16747.832521674627;11318;11473.598424055119;11480.540778369106;11513.539458421905;11526.59656912004;12888.22670639727;12934.676633083871;13040.54358097462;13045.412956416794;13075.869241307466;9986.101250887164;10237.74405639865;10526.842097368393;10732.248742587944;10967.945160274148;9966.202703783825;10097.798044038931;10187.898121018992;10249.538770755185;10419.479026048819;8672.609732562176;8869.423487473294;8871.556422178994;8874.06822283651;8892.466452012899;6464;6537.346265373425;6665.50008749336;6687.866242675022;6878.037074809431;6559.180102487189;6667.899981500378;6700.966495167493;6848.760293389708;6939.340762627542 18:49:10 INFO - PID 18337 | |4;prototype.html;494.5583623736807;503.65499632751556;522.6367674466245;529.7721979548793;530.0995929592411;6097.390260973901;6115.816525504242;6124.785632502863;6188;6242.005116725294;5829.708514574265;5990.700464976745;6007.8197654070445;6031.969840150793;6062.545309101813;4865.172920603488;4892.804287828491;4893.41279046515;4896.828610998616;4897.632677549181;4738.5261473852515;4868.659193856432;4881.219004959207;4914.11545921734;4926.45808961014;4725.976370118145;4786.736729479877;4802.183628783097;4852.636052296074;4867.780949857247;4821.566059054684;4824.155772739774;4833.734144622044;4839.951600483985;4895.975520122377;4302.806373713159;4324.589164029412;4360.345948107777;4373.737575745466;4385.9692972151515;5909.1727158197455;5919.792807251769;5925.288965324189;5956.553258505586;5973.581849270553;5545.500904918576;5601.859953501195;5635.408282130399;5636.943630563683;5661.264035675377;6338.746450141989;6345.587536810092;6429.614223146579;6435.935640643627;6468;4791.113643975876;4798.352222449995;4806.831760888387;4849.636277279218;4850.878728031792;6768.661566921634;6814.96733953391;6874.9656251718925;6889.138857642794;6913.619750913697;4931.731403554405;4941.901161976813;4948.882204211323;4961.305417241589;4983.526564976321;5004.449510553836;5036.949630503721;5041.621878359138;5045.747712614355;5074.5686616637995;5570.777168913279;5652.123920792284;5652.547796176296;5668.971655141698;5672.829815105553;6440.8389790255615;6458.868573370776;6489.772857949949;6506.739730410731;6610.2398224204835;1648.3736180251428;1697.4652984309903;1708.5557754983793;1723.172877019038;1737.7567140600327;1203.5667159822458;1204.6386084174887;1207.1127721124967;1220.3166226912956;1234.21010553246;5705.914411283834;5734.483896449339;5758.568107391962;5764.365919748824;5806.158107074535;6578.5395022347975;6598.063861581551;6630.370114839083;6660.167479065117;6754.425873800684;5579.972100139474;5670.710987627166;5714.942850571524;5728.914066289009;5751.769929202868;3522.295540891832;3571.6964058054837;3582.373084710165;3592.1558433768046;3605.8737944172353;6331.176946996861;6521.9673901630185;6574.704138313788;6576.177977752781;6587.9670601646685;6800.863982720417;6801.605670837466;6809.591424514545;6851.383375496229;6869.7595584154315;6423.022157827534;6472.838179045468;6479.967600161969;6513.478921686254;6523.641199733966;6714.362135597111;6715.395614394728;6720.622272434041;6724.260331363644;6783.219929708147;6629.03878937561;6641.601503909781;6692.787462018161;6693.163354580677;6701.108191020485;6513.1532900722605;6515.511336649865;6522;6556.18047744032;6567.146270984741;4910.140725373117;4929.309896614405;4953.1579631463455;4976.2038073908;4996.3005179274205;6696.698648560924;6708.563943343667;6744.831379215362;6753.15585551806;6784.233401608593;6437.678116094083;6439.291677915519;6536.248331441945;6564.343565643398;6582.288604962649;6479.287278399278;6483.189601299838;6505.739770409131;6517.891958367184;6534.379233972765;6061.6666083365835;6235.194162626927;6274.780382686584;6313.08460273267;6391.238527297193;6436.517261205335;6455.548111632141;6490.350964903472;6522.673866306761;6545.410913017851;6196.349383314868;6219.782307619212;6221.346758590464;6360.173177486897;6370.58591191571 18:49:10 INFO - PID 18337 | |5;yui.html;900.1088921967255;906.9274458043355;911.1207684584375;915.3455279475174;925.4586067150716;16898;17691.29234830607;17723.64552708945;17733.55666108348;17767.46697599071;19807;21060.684089738665;21175.57648847026;21321.36035918925;21407.6788848167;1035.927485076045;1061.3207547169818;1063.7712891728277;1066.8293073108305;1069.7753471770936;975.3416443900375;1050.4117694091333;1058.5289546151967;1062.0441602557682;1069.6149386220955;1113.6436340371085;1116.9050630696402;1117.5641499815079;1117.804384232756;1118.2563595209176;1100.6202860013282;1106.5186643809968;1106.6458733205377;1107.4075369677225;1108.3073079325422;809.8177909970268;810.509641666789;811.7240138352988;811.9188081191893;815.1563132158248;18555.350562730375;19453.708194377097;19689.704654430196;19707.80292197074;19867.105980230925;19329.613407731908;19540.413787586396;19638.803611963842;20188.798112018987;20197.19211231549;15338.156401397919;15469.303881325368;15567.143807090606;15666.530004099895;16522;3577.731670124751;3579.266250418658;3593.568771747381;3601.963980360189;3605.080704420382;111091;112477.43761281141;116162.41918790436;118555.99999999914;118884;15412.537623871078;15690.137042462546;15768.842311576738;15779.763303550455;15800.92099539518;28061.719382806317;28705.56941645877;28778.568321475195;28790.424191516053;28795.136145915658;8962.596683149273;9009.279257659371;9036.774080648036;9086.409383390059;9224.30817688676;4254.170436764863;4325.84859529915;4371.584699453547;4375.146846364928;4400.955990440055;4730.62155027597;4907.754612269372;4910.90178196434;5546.362168350611;5720.942790572041;1029.6550655530482;1059.782744537368;1071.6677829872608;1074.8065348237392;1074.8334008228737;638.7636574467476;658.7595527632476;668.2081733146238;670.088679396021;686.1491750229779;10692.518836652369;10931.781364372668;11010.559577616967;11498;11990.340531270864;649.4804156674642;658.1969996604136;658.7826017414337;671.9204063423696;680.6256558892688;5141.640085194001;5240.868978275497;5319.28189694394;5396.865078372994;5424.186372044146;97739;98234.50882745684;98660;99027;102576.48711756543;83364;89029.55485222532;89196.5540172295;90179.54910225538;90435.54782226047;71359.57280854354;74889.6255518719;75392.62303688447;78812;79679.60160199278;11764.941175294069;11779.528818847493;11804.17370784037;12238.632841014783;12300.446479908247;32870.34259314848;33680.49479257764;34979.82510087433;36397.45403818998;36987;43054.56945430631;45086.32370514379;45326.54673453223;45544;46167;18800.905995469937;19153.61692766165;19165.425037248904;19517.316893908646;19563.51091222731;20039.899800501487;20090.89954550218;20221.69667455019;20370.490737731674;20597.79402206019;17472.82527174712;17632.206550705505;17739;17841.910790445963;17849.107544622457;17807.643847123243;17925.014124223293;18182.181801819213;18483.630327393108;18802.811971880106;17220.655586888442;18852.151653175915;19021.71467427962;19480.415587532396;19755;11718.589849355232;12845;13103.475860965837;13349.399277032751;14026.579202623938;13360;13818.861811381757;14223.288835558387;14492;14999.400023998918 18:49:10 INFO - PID 18337 | __end_tp_report 18:49:10 INFO - PID 18337 | __start_cc_report 18:49:10 INFO - PID 18337 | _x_x_mozilla_cycle_collect,369 18:49:10 INFO - PID 18337 | __end_cc_report 18:49:10 INFO - PID 18337 | __startTimestamp1501552150625__endTimestamp 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | ------- Summary: start ------- 18:49:10 INFO - PID 18337 | Number of tests: 6 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | [#0] dojo.html Cycles:165 Average:6124.26 Median:6408.90 stddev:712.94 (11.1%) stddev-sans-first:674.67 18:49:10 INFO - PID 18337 | Values: 3106.4 3172.6 3193.9 3195.0 3197.7 6107.7 6169.7 6183.8 6183.9 6250.6 6180.6 6197.8 6215.8 6218.9 6241.5 5707.5 5712.1 5713.5 5718.3 5771.1 5698.4 5779.2 5779.7 5806.5 5806.8 5619.8 5715.5 5724.7 5734.3 5784.5 5570.6 5580.5 5631.4 5656.3 5680.5 5619.9 5629.4 5670.0 5681.8 5685.0 6095.6 6102.4 6126.5 6220.7 6245.5 6527.8 6620.2 6626.7 6636.3 6695.2 6647.1 6692.6 6696.3 6699.1 6715.9 6157.7 6187.5 6199.2 6200.2 6201.6 6764.5 6818.8 6843.0 6853.3 6853.6 6474.4 6494.1 6509.6 6520.3 6527.3 6567.5 6617.7 6652.3 6722.6 6747.6 6559.4 6579.5 6581.5 6588.4 6603.1 6599.0 6603.9 6618.9 6623.0 6647.5 5340.1 5365.8 5365.9 5388.4 5398.1 4643.5 4663.0 4710.8 4759.9 4778.4 5691.9 5745.0 5757.9 5796.5 5843.0 6655.2 6661.3 6662.3 6665.5 6668.1 5602.3 5610.1 5666.2 5677.9 5724.6 5503.9 5790.1 5851.8 5863.7 6017.1 6403.1 6418.4 6497.5 6497.6 6552.9 6607.0 6690.9 6704.3 6716.8 6792.7 6424.1 6426.1 6431.5 6434.5 6439.0 6440.7 6463.4 6522.8 6532.2 6553.6 6651.9 6681.4 6688.0 6695.6 6748.5 6523.1 6529.6 6611.1 6619.2 6626.8 6332.4 6434.1 6486.7 6521.8 6610.5 6407.2 6408.9 6441.4 6449.2 6467.4 6511.1 6559.6 6573.8 6578.4 6591.3 6286.5 6333.9 6359.7 6364.6 6433.5 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | [#1] ext.html Cycles:180 Average:36077.55 Median:19511.24 stddev:51056.90 (261.7%) stddev-sans-first:51131.46 18:49:10 INFO - PID 18337 | Values: 813.2 850.7 879.2 899.9 905.2 38339.8 39102.0 39182.2 39212.0 39284.6 35461.0 35618.6 35661.1 35715.0 35725.8 6789.7 6937.6 6944.1 6947.2 6958.6 6860.6 6956.7 6958.1 6962.1 6964.3 7437.0 7519.5 7523.1 7523.8 7532.2 7395.8 7558.5 7561.7 7569.7 7578.3 7332.6 7477.4 7550.9 7559.7 7564.2 37659.2 37881.0 38033.2 38050.4 38086.6 3476.2 3541.9 3545.0 3561.5 3564.8 31163.8 31419.1 31422.1 31463.2 31488.0 4596.6 4751.0 4755.9 4759.7 4760.0 179905.0 182347.0 186371.0 188453.0 195168.0 46562.0 46929.0 46978.0 46985.5 47119.8 48680.3 48794.5 48877.5 48925.3 49112.0 15915.5 16007.9 16160.8 16280.8 16441.5 13566.2 13573.3 13574.9 13576.0 13582.1 14122.4 14174.2 14234.6 14256.0 14392.9 5677.7 5712.9 5744.2 5813.4 5852.5 962.5 977.1 984.6 997.5 1003.1 22021.6 22151.0 22449.7 22470.4 22629.0 1078.5 1095.5 1096.8 1111.7 1114.7 11855.5 11871.6 11930.8 11991.3 12083.8 211210.0 211322.0 211765.0 211945.0 211958.0 48486.8 48529.5 49160.0 49173.0 49844.0 1436.3 1462.5 1470.4 1488.1 1490.3 21903.2 22010.2 22335.3 22378.0 22417.8 36021.6 36055.1 36117.8 36193.3 36232.8 192670.0 193045.0 193251.0 193763.0 194160.0 29898.0 30123.5 32522.8 33288.5 33457.3 40796.8 42205.4 42507.4 42868.4 42885.1 27830.3 28095.5 30315.8 30849.8 30912.2 30621.1 30889.4 31457.7 31652.8 32009.4 35149.5 36083.8 36239.6 36425.5 36430.0 30863.8 31738.2 31997.2 32475.4 32929.7 22669.5 23850.9 24320.3 24414.5 24551.8 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | [#2] jquery.html Cycles:180 Average:36394.28 Median:23003.22 stddev:91913.65 (399.6%) stddev-sans-first:92132.12 18:49:10 INFO - PID 18337 | Values: 564.2 569.1 571.6 578.5 588.9 21090.8 22303.8 22308.4 22322.3 22736.4 23270.0 23997.0 24016.9 24038.6 24050.3 6259.6 6462.2 6472.2 6472.8 6476.8 6295.5 6479.4 6613.4 6618.6 6624.0 6596.6 6596.7 6597.9 6599.5 6602.1 6554.3 6580.9 6582.5 6587.4 6593.1 6066.4 6092.0 6103.3 6123.4 6143.4 28294.2 29423.7 30140.8 30212.7 30455.2 1824.4 1860.0 1866.4 1873.4 1878.3 18397.4 18947.7 18951.3 18977.1 19010.5 2254.2 2335.8 2373.6 2373.9 2377.5 130139.0 132174.3 132418.0 133148.3 133841.0 14308.4 15272.6 15434.9 15589.8 15784.2 22614.0 23603.4 23643.4 23655.4 23699.0 10040.6 10173.7 10270.0 10405.8 10516.6 9306.1 9361.2 9427.2 9434.4 9541.2 9426.4 9464.7 9584.4 9647.0 9648.0 2765.3 2806.5 2827.1 2843.4 2847.0 938.6 942.7 954.7 978.2 978.6 19763.6 19814.7 19959.7 20092.2 20738.5 964.1 996.8 1020.7 1021.4 1051.3 10568.9 10595.5 10771.1 11118.6 11319.8 538312.0 543581.0 551992.0 554698.0 567864.0 113191.4 115183.0 116810.3 117508.0 121149.0 1220.8 1244.7 1283.8 1288.3 1298.6 19688.3 20657.6 21040.3 21311.5 21684.2 55016.0 55146.7 55463.4 56911.7 58234.0 67526.7 70342.9 70527.0 70604.0 71077.0 14668.4 15245.5 15260.8 15279.7 15280.9 22340.9 23554.2 23643.5 23788.3 23813.6 18927.8 18938.3 19006.4 19037.8 19073.4 14189.7 15107.8 15428.6 16048.0 16635.0 18326.2 19289.7 19330.0 19396.9 19440.2 14432.6 15168.9 15266.8 15269.2 15277.5 18860.4 18861.8 18863.0 18874.3 18905.3 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | [#3] mootools.html Cycles:180 Average:8649.29 Median:2645.75 stddev:5900.15 (223.0%) stddev-sans-first:5890.70 18:49:10 INFO - PID 18337 | Values: 1276.9 1326.4 1341.5 1353.4 1355.6 13573.8 13972.3 14028.2 14048.0 14183.4 13674.9 14632.1 14673.9 14698.9 14807.2 2684.4 2740.1 2749.9 2751.5 2758.4 2631.3 2660.9 2691.4 2745.0 2762.2 2729.7 2758.3 2760.7 2761.5 2763.5 2627.4 2630.3 2635.9 2645.3 2651.7 2619.5 2619.9 2646.2 2646.3 2646.5 13888.4 14216.2 14264.5 14278.7 14284.4 7526.7 7782.3 7790.4 7794.9 7799.8 4937.2 5098.7 5130.0 5211.4 5232.8 1834.2 1851.7 1869.9 1874.8 1876.6 23353.6 23577.0 23603.5 23627.3 23633.0 6392.8 6570.3 6615.6 6734.1 6787.1 15933.6 18608.9 18895.8 18996.2 19092.1 7924.0 8212.9 8216.1 8218.4 8218.7 7102.1 7156.0 7291.1 7319.7 7403.6 5463.3 5624.1 5627.8 5639.4 5681.2 1726.7 1773.7 1777.6 1780.7 1809.4 815.2 819.4 824.0 845.7 861.6 6524.4 6796.6 6838.4 7859.8 7956.2 921.8 927.1 954.5 984.2 1000.7 4525.9 4605.4 4727.8 4773.4 4938.3 17898.2 18113.6 18207.3 18336.2 18942.4 17409.7 17508.9 17928.2 17946.7 17998.2 10551.3 10619.1 10720.3 10755.7 10759.1 6628.4 7309.9 7337.9 7493.4 7533.8 15494.8 16353.3 16623.8 16655.3 16853.5 16206.0 16325.8 16373.7 16745.8 16747.8 11318.0 11473.6 11480.5 11513.5 11526.6 12888.2 12934.7 13040.5 13045.4 13075.9 9986.1 10237.7 10526.8 10732.2 10967.9 9966.2 10097.8 10187.9 10249.5 10419.5 8672.6 8869.4 8871.6 8874.1 8892.5 6464.0 6537.3 6665.5 6687.9 6878.0 6559.2 6667.9 6701.0 6848.8 6939.3 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | [#4] prototype.html Cycles:180 Average:5451.29 Median:5982.14 stddev:1540.80 (25.8%) stddev-sans-first:1499.53 18:49:10 INFO - PID 18337 | Values: 494.6 503.7 522.6 529.8 530.1 6097.4 6115.8 6124.8 6188.0 6242.0 5829.7 5990.7 6007.8 6032.0 6062.5 4865.2 4892.8 4893.4 4896.8 4897.6 4738.5 4868.7 4881.2 4914.1 4926.5 4726.0 4786.7 4802.2 4852.6 4867.8 4821.6 4824.2 4833.7 4840.0 4896.0 4302.8 4324.6 4360.3 4373.7 4386.0 5909.2 5919.8 5925.3 5956.6 5973.6 5545.5 5601.9 5635.4 5636.9 5661.3 6338.7 6345.6 6429.6 6435.9 6468.0 4791.1 4798.4 4806.8 4849.6 4850.9 6768.7 6815.0 6875.0 6889.1 6913.6 4931.7 4941.9 4948.9 4961.3 4983.5 5004.4 5036.9 5041.6 5045.7 5074.6 5570.8 5652.1 5652.5 5669.0 5672.8 6440.8 6458.9 6489.8 6506.7 6610.2 1648.4 1697.5 1708.6 1723.2 1737.8 1203.6 1204.6 1207.1 1220.3 1234.2 5705.9 5734.5 5758.6 5764.4 5806.2 6578.5 6598.1 6630.4 6660.2 6754.4 5580.0 5670.7 5714.9 5728.9 5751.8 3522.3 3571.7 3582.4 3592.2 3605.9 6331.2 6522.0 6574.7 6576.2 6588.0 6800.9 6801.6 6809.6 6851.4 6869.8 6423.0 6472.8 6480.0 6513.5 6523.6 6714.4 6715.4 6720.6 6724.3 6783.2 6629.0 6641.6 6692.8 6693.2 6701.1 6513.2 6515.5 6522.0 6556.2 6567.1 4910.1 4929.3 4953.2 4976.2 4996.3 6696.7 6708.6 6744.8 6753.2 6784.2 6437.7 6439.3 6536.2 6564.3 6582.3 6479.3 6483.2 6505.7 6517.9 6534.4 6061.7 6235.2 6274.8 6313.1 6391.2 6436.5 6455.5 6490.4 6522.7 6545.4 6196.3 6219.8 6221.3 6360.2 6370.6 18:49:10 INFO - PID 18337 | 18:49:10 INFO - PID 18337 | [#5] yui.html Cycles:180 Average:21598.99 Median:19731.40 stddev:28313.58 (143.5%) stddev-sans-first:28350.34 18:49:10 INFO - PID 18337 | Values: 900.1 906.9 911.1 915.3 925.5 16898.0 17691.3 17723.6 17733.6 17767.5 19807.0 21060.7 21175.6 21321.4 21407.7 1035.9 1061.3 1063.8 1066.8 1069.8 975.3 1050.4 1058.5 1062.0 1069.6 1113.6 1116.9 1117.6 1117.8 1118.3 1100.6 1106.5 1106.6 1107.4 1108.3 809.8 810.5 811.7 811.9 815.2 18555.4 19453.7 19689.7 19707.8 19867.1 19329.6 19540.4 19638.8 20188.8 20197.2 15338.2 15469.3 15567.1 15666.5 16522.0 3577.7 3579.3 3593.6 3602.0 3605.1 111091.0 112477.4 116162.4 118556.0 118884.0 15412.5 15690.1 15768.8 15779.8 15800.9 28061.7 28705.6 28778.6 28790.4 28795.1 8962.6 9009.3 9036.8 9086.4 9224.3 4254.2 4325.8 4371.6 4375.1 4401.0 4730.6 4907.8 4910.9 5546.4 5720.9 1029.7 1059.8 1071.7 1074.8 1074.8 638.8 658.8 668.2 670.1 686.1 10692.5 10931.8 11010.6 11498.0 11990.3 649.5 658.2 658.8 671.9 680.6 5141.6 5240.9 5319.3 5396.9 5424.2 97739.0 98234.5 98660.0 99027.0 102576.5 83364.0 89029.6 89196.6 90179.5 90435.5 71359.6 74889.6 75392.6 78812.0 79679.6 11764.9 11779.5 11804.2 12238.6 12300.4 32870.3 33680.5 34979.8 36397.5 36987.0 43054.6 45086.3 45326.5 45544.0 46167.0 18800.9 19153.6 19165.4 19517.3 19563.5 20039.9 20090.9 20221.7 20370.5 20597.8 17472.8 17632.2 17739.0 17841.9 17849.1 17807.6 17925.0 18182.2 18483.6 18802.8 17220.7 18852.2 19021.7 19480.4 19755.0 11718.6 12845.0 13103.5 13349.4 14026.6 13360.0 13818.9 14223.3 14492.0 14999.4 18:49:10 INFO - PID 18337 | -------- Summary: end -------- 18:49:10 INFO - PID 18337 | 18:49:11 INFO - TEST-INFO | 18337: exit 0 18:49:11 INFO - TEST-OK | dromaeo_css | took 1113600ms 18:49:11 INFO - TEST-START | kraken 18:49:11 INFO - Initialising browser for kraken test... 18:49:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35526/getInfo.html -profile /tmp/tmpppeVnd/profile 18:49:11 INFO - TEST-INFO | started process 18713 (/builds/slave/test/build/application/firefox/firefox http://localhost:35526/getInfo.html) 18:49:17 INFO - TEST-INFO | 18713: exit 0 18:49:17 INFO - Browser initialized. 18:49:17 INFO - Running cycle 1/1 for kraken test... 18:49:17 INFO - TEST-INFO | started process 18938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppeVnd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:18 INFO - PID 18938 | 18:49:18 INFO - PID 18938 | (/builds/slave/test/build/application/firefox/firefox:18992): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:49:18 INFO - PID 18938 | 18:49:28 INFO - PID 18938 | RSS: Main: 174301184 18:49:28 INFO - PID 18938 | 18:49:31 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35526/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:32 INFO - PID 18938 | RSS: Main: 179580928 18:49:32 INFO - PID 18938 | 18:49:35 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35526/tests/kraken/driver.html?testName=audio-dft) 18:49:35 INFO - PID 18938 | RSS: Main: 180023296 18:49:35 INFO - PID 18938 | 18:49:38 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35526/tests/kraken/driver.html?testName=audio-fft) 18:49:39 INFO - PID 18938 | RSS: Main: 174870528 18:49:39 INFO - PID 18938 | 18:49:41 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35526/tests/kraken/driver.html?testName=audio-oscillator) 18:49:42 INFO - PID 18938 | RSS: Main: 175190016 18:49:42 INFO - PID 18938 | 18:49:44 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:45 INFO - PID 18938 | RSS: Main: 175341568 18:49:45 INFO - PID 18938 | 18:49:48 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35526/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:48 INFO - PID 18938 | RSS: Main: 177655808 18:49:48 INFO - PID 18938 | 18:49:52 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35526/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:53 INFO - PID 18938 | RSS: Main: 177180672 18:49:53 INFO - PID 18938 | 18:49:56 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35526/tests/kraken/driver.html?testName=json-parse-financial) 18:49:56 INFO - PID 18938 | RSS: Main: 178507776 18:49:56 INFO - PID 18938 | 18:49:58 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:59 INFO - PID 18938 | RSS: Main: 178483200 18:49:59 INFO - PID 18938 | 18:50:00 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:50:01 INFO - PID 18938 | RSS: Main: 175669248 18:50:01 INFO - PID 18938 | 18:50:03 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:04 INFO - PID 18938 | RSS: Main: 175497216 18:50:04 INFO - PID 18938 | 18:50:07 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:08 INFO - PID 18938 | RSS: Main: 176082944 18:50:08 INFO - PID 18938 | 18:50:11 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:11 INFO - PID 18938 | RSS: Main: 175517696 18:50:11 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | Cycle 1(1): loaded http://localhost:35526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35526/tests/kraken/driver.html?testName=ai-astar) 18:50:13 INFO - PID 18938 | RSS: Main: 177491968 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | __start_tp_report 18:50:13 INFO - PID 18938 | _x_x_mozilla_page_load 18:50:13 INFO - PID 18938 | _x_x_mozilla_page_load_details 18:50:13 INFO - PID 18938 | |i|pagename|runs| 18:50:13 INFO - PID 18938 | |0;ai-astar;99;113;106;108;110;112;111;101;108;107 18:50:13 INFO - PID 18938 | |1;audio-beat-detection;153;119;156;177;125;144;146;119;188;120 18:50:13 INFO - PID 18938 | |2;audio-dft;170;166;164;163;164;174;169;167;162;167 18:50:13 INFO - PID 18938 | |3;audio-fft;77;75;75;172;76;76;76;73;178;82 18:50:13 INFO - PID 18938 | |4;audio-oscillator;79;78;137;78;87;87;128;87;78;128 18:50:13 INFO - PID 18938 | |5;imaging-gaussian-blur;113;120;114;122;122;114;114;116;116;120 18:50:13 INFO - PID 18938 | |6;imaging-darkroom;151;151;158;152;155;151;150;153;151;157 18:50:13 INFO - PID 18938 | |7;imaging-desaturate;94;95;99;98;99;99;94;96;94;95 18:50:13 INFO - PID 18938 | |8;json-parse-financial;57;62;55;58;56;56;56;57;56;57 18:50:13 INFO - PID 18938 | |9;json-stringify-tinderbox;54;53;59;54;59;59;54;56;60;56 18:50:13 INFO - PID 18938 | |10;stanford-crypto-aes;81;79;80;81;86;92;79;79;81;91 18:50:13 INFO - PID 18938 | |11;stanford-crypto-ccm;140;139;135;139;139;134;137;137;129;178 18:50:13 INFO - PID 18938 | |12;stanford-crypto-pbkdf2;182;184;185;192;185;185;179;182;177;187 18:50:13 INFO - PID 18938 | |13;stanford-crypto-sha256-iterative;69;70;74;70;66;68;66;74;68;66 18:50:13 INFO - PID 18938 | __end_tp_report 18:50:13 INFO - PID 18938 | __start_cc_report 18:50:13 INFO - PID 18938 | _x_x_mozilla_cycle_collect,998 18:50:13 INFO - PID 18938 | __end_cc_report 18:50:13 INFO - PID 18938 | __startTimestamp1501552213916__endTimestamp 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | ------- Summary: start ------- 18:50:13 INFO - PID 18938 | Number of tests: 14 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#0] ai-astar Cycles:10 Average:107.50 Median:110.50 stddev:4.55 (4.1%) stddev-sans-first:3.64 18:50:13 INFO - PID 18938 | Values: 99.0 113.0 106.0 108.0 110.0 112.0 111.0 101.0 108.0 107.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:149.50 stddev:24.58 (16.4%) stddev-sans-first:25.88 18:50:13 INFO - PID 18938 | Values: 153.0 119.0 156.0 177.0 125.0 144.0 146.0 119.0 188.0 120.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#2] audio-dft Cycles:10 Average:166.60 Median:167.00 stddev:3.66 (2.2%) stddev-sans-first:3.67 18:50:13 INFO - PID 18938 | Values: 170.0 166.0 164.0 163.0 164.0 174.0 169.0 167.0 162.0 167.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:41.72 (54.9%) stddev-sans-first:43.68 18:50:13 INFO - PID 18938 | Values: 77.0 75.0 75.0 172.0 76.0 76.0 76.0 73.0 178.0 82.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:78.50 stddev:24.10 (30.7%) stddev-sans-first:24.70 18:50:13 INFO - PID 18938 | Values: 79.0 78.0 137.0 78.0 87.0 87.0 128.0 87.0 78.0 128.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:118.00 stddev:3.54 (3.0%) stddev-sans-first:3.43 18:50:13 INFO - PID 18938 | Values: 113.0 120.0 114.0 122.0 122.0 114.0 114.0 116.0 116.0 120.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#6] imaging-darkroom Cycles:10 Average:152.90 Median:152.50 stddev:2.81 (1.8%) stddev-sans-first:2.89 18:50:13 INFO - PID 18938 | Values: 151.0 151.0 158.0 152.0 155.0 151.0 150.0 153.0 151.0 157.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:2.21 (2.3%) stddev-sans-first:2.19 18:50:13 INFO - PID 18938 | Values: 94.0 95.0 99.0 98.0 99.0 99.0 94.0 96.0 94.0 95.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.94 (3.4%) stddev-sans-first:2.06 18:50:13 INFO - PID 18938 | Values: 57.0 62.0 55.0 58.0 56.0 56.0 56.0 57.0 56.0 57.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:57.50 stddev:2.63 (4.6%) stddev-sans-first:2.65 18:50:13 INFO - PID 18938 | Values: 54.0 53.0 59.0 54.0 59.0 59.0 54.0 56.0 60.0 56.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:81.00 stddev:4.98 (6.1%) stddev-sans-first:5.23 18:50:13 INFO - PID 18938 | Values: 81.0 79.0 80.0 81.0 86.0 92.0 79.0 79.0 81.0 91.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.00 stddev:13.51 (9.7%) stddev-sans-first:14.32 18:50:13 INFO - PID 18938 | Values: 140.0 139.0 135.0 139.0 139.0 134.0 137.0 137.0 129.0 178.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:185.00 stddev:4.18 (2.3%) stddev-sans-first:4.39 18:50:13 INFO - PID 18938 | Values: 182.0 184.0 185.0 192.0 185.0 185.0 179.0 182.0 177.0 187.0 18:50:13 INFO - PID 18938 | 18:50:13 INFO - PID 18938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:3.00 (4.3%) stddev-sans-first:3.18 18:50:13 INFO - PID 18938 | Values: 69.0 70.0 74.0 70.0 66.0 68.0 66.0 74.0 68.0 66.0 18:50:13 INFO - PID 18938 | -------- Summary: end -------- 18:50:13 INFO - PID 18938 | 18:50:14 INFO - PID 18938 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:50:14 INFO - TEST-INFO | 18938: exit 0 18:50:14 INFO - TEST-OK | kraken | took 63256ms 18:50:14 INFO - SUITE-END | took 1176s 18:50:15 INFO - Completed test suite (00:19:37) 18:50:15 INFO - javascript benchmark 18:50:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8364.14726067341, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.4408406486837, 3172.5875636167293, 3193.8722451101958, 3194.9840250798748, 3197.6962188592092, 6107.694615269235, 6169.722362493687, 6183.845403864906, 6183.907241391383, 6250.624962502253, 6180.629162250269, 6197.814065578029, 6215.782447614334, 6218.906716399247, 6241.531885108624, 5707.5148612368, 5712.143178523234, 5713.514351280146, 5718.342390625069, 5771.105478650816, 5698.43015698431, 5779.1620215069, 5779.653220806744, 5806.535477161817, 5806.82579522615, 5619.831405057835, 5715.5427565794635, 5724.742386592613, 5734.311882574076, 5784.537237021049, 5570.610057295991, 5580.469855363734, 5631.408702086263, 5656.2929633795775, 5680.517156041741, 5619.887602247933, 5629.3526244482, 5670.0, 5681.7727290908315, 5684.971575142098, 6095.573309868311, 6102.389761023906, 6126.509879209697, 6220.720067596969, 6245.531585131088, 6527.771527996498, 6620.205575330943, 6626.668666566652, 6636.30318816527, 6695.163104611924, 6647.069410282565, 6692.63190524521, 6696.263411024784, 6699.062131301622, 6715.899261511081, 6157.7229024694, 6187.504999600022, 6199.194104766397, 6200.224971878515, 6201.596896201778, 6764.4926630502905, 6818.829529261808, 6843.0419741236265, 6853.348931851466, 6853.623050732258, 6474.384933431316, 6494.090827284184, 6509.609423434609, 6520.315366886503, 6527.281998980204, 6567.474602031826, 6617.735290588323, 6652.301508341651, 6722.563033402813, 6747.628880411527, 6559.442447392025, 6579.47364210862, 6581.539292249592, 6588.4070433660245, 6603.141591593062, 6598.967005164944, 6603.867922641521, 6618.86762264752, 6622.966885165543, 6647.468202543785, 5340.092184328673, 5365.839024829262, 5365.892682146336, 5388.407275199725, 5398.13629819227, 4643.466001409881, 4663.0, 4710.788014539354, 4759.928601070987, 4778.37881075458, 5691.9146212806845, 5745.0397463357485, 5757.913631295534, 5796.536277097822, 5843.0066888629035, 6655.23464801554, 6661.3338666132995, 6662.333766623396, 6665.533412661067, 6668.099806526154, 5602.299712535933, 5610.13042978339, 5666.150077488327, 5677.858053548694, 5724.599278050497, 5503.862403439946, 5790.10253410722, 5851.795187168429, 5863.677497737665, 6017.1275165100815, 6403.071554624554, 6418.358164183544, 6497.480201583862, 6497.64262965532, 6552.901706474407, 6606.966965165144, 6690.899636505554, 6704.329567043452, 6716.83207919806, 6792.72829086831, 6424.068510065921, 6426.068220108152, 6431.517636177399, 6434.517411194086, 6438.967805160944, 6440.677966101583, 6463.385978332239, 6522.771702990372, 6532.248791389051, 6553.574017688835, 6651.900221496779, 6681.365270299314, 6688.030235615905, 6695.598264104169, 6748.493862960199, 6523.054157147282, 6529.575577587441, 6611.074449576967, 6619.205695316593, 6626.768063117768, 6332.398422149889, 6434.099226108255, 6486.6756662167645, 6521.771737989147, 6610.4711623071, 6407.16706828128, 6408.9038664421005, 6441.355864413521, 6449.193850768654, 6467.417932386108, 6511.055896894829, 6559.639219842955, 6573.835654108494, 6578.407943285128, 6591.274959754519, 6286.497080233479, 6333.936660633335, 6359.713812878339, 6364.586301890362, 6433.517486188648], "value": 6071.702069568623, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.2477458351027, 850.6767428377216, 879.1516186879662, 899.8605216191488, 905.2260317428598, 38339.80830095849, 39102.0, 39182.21635567287, 39212.0, 39284.60715392849, 35461.0, 35618.643813561925, 35661.10847228821, 35715.0, 35725.82137089317, 6789.660516974156, 6937.583744975318, 6944.062551555551, 6947.235804061549, 6958.582485050888, 6860.55406398585, 6956.721731130749, 6958.060661810667, 6962.060121883557, 6964.268751781066, 7437.0, 7519.473636845423, 7523.059617547807, 7523.811904702371, 7532.246775322451, 7395.8151046224, 7558.546487210785, 7561.735339263127, 7569.697212111509, 7578.317951384402, 7332.633368331615, 7477.439192060563, 7550.886736698954, 7559.735409260705, 7564.1679415264825, 37659.24681506355, 37881.0, 38033.23933521342, 38050.42924356109, 38086.619133808585, 3476.2178509835085, 3541.8937431877084, 3544.9645503544893, 3561.4835848802036, 3564.803935783531, 31163.84418077918, 31419.05742827719, 31422.057338279887, 31463.213419664462, 31488.0, 4596.609288210506, 4750.95249047512, 4755.857324280277, 4759.738214398207, 4759.976200118977, 179905.0, 182347.0, 186371.0, 188453.0, 195168.0, 46562.0, 46929.0, 46978.0, 46985.5301446988, 47119.764401177774, 48680.26979595309, 48794.512054879706, 48877.51122488801, 48925.266121008215, 49112.0, 15915.522534323989, 16007.919960400357, 16160.83839161617, 16280.755788662942, 16441.506754797374, 13566.186028838301, 13573.253471059186, 13574.864251357558, 13576.049676522549, 13582.117162384413, 14122.435102595986, 14174.22041787691, 14234.572962811133, 14256.0, 14392.928035359757, 5677.716114194273, 5712.914306285409, 5744.195812586241, 5813.360530341659, 5852.531797456193, 962.5235508423375, 977.0864241933815, 984.6209209454412, 997.5162046407487, 1003.1322905686675, 22021.559568808534, 22151.0, 22449.663255051186, 22470.43823904383, 22629.0, 1078.5038882114316, 1095.5015467962057, 1096.8464414981909, 1111.7109551516503, 1114.7046032801313, 11855.525778968744, 11871.643850684493, 11930.761384772255, 11991.340476273888, 12083.818742718866, 211210.0, 211322.0, 211765.0, 211945.0, 211958.0, 48486.75756621265, 48529.544113676646, 49160.0, 49173.0, 49844.0, 1436.346462359624, 1462.4919950158148, 1470.3603932289489, 1488.1071357185817, 1490.3308294709777, 21903.233386831384, 22010.229641962454, 22335.32485063594, 22378.0, 22417.77582224157, 36021.63978360183, 36055.09862253465, 36117.819410902775, 36193.27613447663, 36232.81883590565, 192670.0, 193045.0, 193251.0, 193763.0, 194160.0, 29898.0, 30123.54814677738, 32522.83738581292, 33288.50067248945, 33457.33085338231, 40796.79601601973, 42205.36691949562, 42507.3623895648, 42868.35697464478, 42885.1422971545, 27830.330180189252, 28095.510793516096, 30315.848420757757, 30849.845750771103, 30912.227194320323, 30621.08136755901, 30889.382212356075, 31457.685423145474, 31652.841735791175, 32009.359812803148, 35149.47275790916, 36083.81958090193, 36239.63760362468, 36425.45361819522, 36430.0, 30863.845680771454, 31738.206544836565, 31997.200069998435, 32475.35049299048, 32929.67070329266, 22669.546609068057, 23850.88074559616, 24320.252242544175, 24414.511709766062, 24551.75448245566], "value": 16628.664544174248, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2439131563704, 569.1377562992068, 571.6398668838631, 578.5313895744447, 588.94405031522, 21090.789092109073, 22303.77696223037, 22308.442288942784, 22322.330330090084, 22736.43158921028, 23270.0, 23997.0, 24016.879915600442, 24038.63942040871, 24050.278491645236, 6259.593126446778, 6462.192225971754, 6472.223333200022, 6472.805815825509, 6476.838079048014, 6295.496360291166, 6479.384458476437, 6613.437857782094, 6618.635975021371, 6623.966880165593, 6596.604203747766, 6596.736130554772, 6597.868042639145, 6599.47204223661, 6602.075709400688, 6554.3117972613145, 6580.901286480706, 6582.539222254421, 6587.374199451045, 6593.076969224312, 6066.423689749467, 6091.969540152315, 6103.328633850273, 6123.4079139424075, 6143.354947730513, 28294.15117546477, 29423.70576294231, 30140.8492957536, 30212.697873021207, 30455.23861903448, 1824.4435447188603, 1860.023487668971, 1866.393422137797, 1873.4286042756953, 1878.2674756844706, 18397.448076557725, 18947.715784263248, 18951.336703215322, 18977.146028428753, 19010.52473688169, 2254.199759085534, 2335.824813139004, 2373.6439534070028, 2373.9287821365388, 2377.4784138151595, 130139.0, 132174.33912830567, 132418.0, 133148.33425832907, 133841.0, 14308.356123974447, 15272.556390977612, 15434.922825385802, 15589.84410155884, 15784.21078946071, 22614.0, 23603.40991475227, 23643.40891477727, 23655.408614784767, 23699.0, 10040.64857729976, 10173.745656358502, 10270.0, 10405.84391234132, 10516.631917882838, 9306.11591898782, 9361.157495825271, 9427.198688111588, 9434.386764860263, 9541.18899893503, 9426.387284826464, 9464.68115311753, 9584.424934503952, 9647.0, 9647.951760241294, 2765.3131589730247, 2806.466771313444, 2827.137722994465, 2843.4028853940904, 2846.957295640567, 938.5823308627731, 942.6842007927283, 954.7135859242338, 978.1587834462357, 978.6379039755194, 19763.60472790536, 19814.70277945832, 19959.700604490943, 20092.196312147644, 20738.48153796167, 964.1274646444979, 996.8106059848606, 1020.7448137965508, 1021.4484178543503, 1051.2746205118444, 10568.947155264175, 10595.470226488645, 10771.082051358924, 11118.55525778976, 11319.830202546967, 538312.0, 543581.0, 551992.0, 554698.0, 567864.0, 113191.43404282926, 115183.0, 116810.32758689727, 117508.0, 121149.0, 1220.7741567809983, 1244.7137158453424, 1283.7881749511412, 1288.3300683644452, 1298.6169080121388, 19688.31090911811, 20657.58684826325, 21040.263590774248, 21311.46721331917, 21684.24105156312, 55016.0, 55146.72426637841, 55463.44536554744, 56911.71544142253, 58234.0, 67526.66236668786, 70342.94485582823, 70527.0, 70604.0, 71077.0, 14668.413263469341, 15245.542633721006, 15260.771088433461, 15279.694406111594, 15280.923595381952, 22340.88829555842, 23554.175603853782, 23643.52712945766, 23788.286351409486, 23813.642795357737, 18927.810721892605, 18938.337158199396, 19006.429807105807, 19037.809621903605, 19073.427797166107, 14189.716205675622, 15107.773383399477, 15428.614284642974, 16048.0, 16635.0, 18326.17532211027, 19289.710654339917, 19330.0, 19396.903015485397, 19440.2223911042, 14432.567022989328, 15168.924155379153, 15266.770998435255, 15269.236538173269, 15277.541673749805, 18860.434186974413, 18861.811381886004, 18863.0, 18874.339398121, 18905.338313158973], "value": 12050.936286992519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.8978481721463, 1326.4163767942105, 1341.4567100324373, 1353.3571553512077, 1355.6204262806414, 13573.7963930541, 13972.301384930764, 14028.228447435413, 14048.016638835286, 14183.432662693493, 13674.931625341884, 14632.122072675647, 14673.926630366834, 14698.926505367484, 14807.185604791732, 2684.449687814003, 2740.0957683964343, 2749.8762555685043, 2751.463464624399, 2758.3931535062256, 2631.2500937232894, 2660.946781064378, 2691.448253108108, 2745.025515941842, 2762.2127693607326, 2729.7443176139, 2758.2828464599247, 2760.7101254368204, 2761.516734571452, 2763.5301998660275, 2627.4219671672204, 2630.3292660371676, 2635.8813853376546, 2645.325442012294, 2651.6950550686724, 2619.5153896529014, 2619.89520419183, 2646.1664575658797, 2646.298730836311, 2646.4574762173706, 13888.375023123983, 14216.218108004055, 14264.500742474067, 14278.714425711427, 14284.428622855074, 7526.661300241502, 7782.299593036654, 7790.415718821055, 7794.922050779476, 7799.805004874866, 4937.21004639256, 5098.688249247361, 5130.0, 5211.374635043781, 5232.764525596357, 1834.220456306078, 1851.685213513706, 1869.8971556564384, 1874.8031456696988, 1876.6152938647544, 23353.649695254586, 23577.0, 23603.527929441316, 23627.29118126459, 23633.0, 6392.84017899547, 6570.310117437696, 6615.569987950767, 6734.0572319875255, 6787.1176747023555, 15933.601659958362, 18608.906955465405, 18895.81104188968, 18996.24015039383, 19092.140853661618, 7924.049114106344, 8212.917870821215, 8216.055153657286, 8218.424710270223, 8218.671253149927, 7102.076730025064, 7155.964220178866, 7291.08861392326, 7319.670614822346, 7403.555786652818, 5463.31708536433, 5624.100143976944, 5627.831165065055, 5639.407862174413, 5681.204631351614, 1726.66330065636, 1773.7073382891679, 1777.5733823882176, 1780.7328900664745, 1809.4209852846964, 815.2214635023538, 819.4059307002494, 823.9629216685264, 845.6532821543137, 861.5778268648318, 6524.380183882524, 6796.592204467748, 6838.418734407631, 7859.803504912423, 7956.164602716747, 921.801812610292, 927.1423932862076, 954.4941181173989, 984.2126298960802, 1000.7047920863363, 4525.864224073283, 4605.447346318396, 4727.787249573777, 4773.427188737373, 4938.308636790852, 17898.194581243875, 18113.637727245383, 18207.27170913175, 18336.174872130785, 18942.43172704821, 17409.738853917203, 17508.912455437643, 17928.193231304624, 17946.730799038025, 17998.190081446366, 10551.314164579278, 10619.09737672291, 10720.3031802931, 10755.731106722395, 10759.139268858473, 6628.436582890508, 7309.853802923805, 7337.926620733938, 7493.43799215072, 7533.811654708456, 15494.84505154934, 16353.264103115627, 16623.83376166223, 16655.3337866484, 16853.494395168163, 16206.0, 16325.755113673542, 16373.738179787108, 16745.832541674914, 16747.832521674627, 11318.0, 11473.598424055119, 11480.540778369106, 11513.539458421905, 11526.59656912004, 12888.22670639727, 12934.676633083871, 13040.54358097462, 13045.412956416794, 13075.869241307466, 9986.101250887164, 10237.74405639865, 10526.842097368393, 10732.248742587944, 10967.945160274148, 9966.202703783825, 10097.798044038931, 10187.898121018992, 10249.538770755185, 10419.479026048819, 8672.609732562176, 8869.423487473294, 8871.556422178994, 8874.06822283651, 8892.466452012899, 6464.0, 6537.346265373425, 6665.50008749336, 6687.866242675022, 6878.037074809431, 6559.180102487189, 6667.899981500378, 6700.966495167493, 6848.760293389708, 6939.340762627542], "value": 6347.02741073688, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.5583623736807, 503.65499632751556, 522.6367674466245, 529.7721979548793, 530.0995929592411, 6097.390260973901, 6115.816525504242, 6124.785632502863, 6188.0, 6242.005116725294, 5829.708514574265, 5990.700464976745, 6007.8197654070445, 6031.969840150793, 6062.545309101813, 4865.172920603488, 4892.804287828491, 4893.41279046515, 4896.828610998616, 4897.632677549181, 4738.5261473852515, 4868.659193856432, 4881.219004959207, 4914.11545921734, 4926.45808961014, 4725.976370118145, 4786.736729479877, 4802.183628783097, 4852.636052296074, 4867.780949857247, 4821.566059054684, 4824.155772739774, 4833.734144622044, 4839.951600483985, 4895.975520122377, 4302.806373713159, 4324.589164029412, 4360.345948107777, 4373.737575745466, 4385.9692972151515, 5909.1727158197455, 5919.792807251769, 5925.288965324189, 5956.553258505586, 5973.581849270553, 5545.500904918576, 5601.859953501195, 5635.408282130399, 5636.943630563683, 5661.264035675377, 6338.746450141989, 6345.587536810092, 6429.614223146579, 6435.935640643627, 6468.0, 4791.113643975876, 4798.352222449995, 4806.831760888387, 4849.636277279218, 4850.878728031792, 6768.661566921634, 6814.96733953391, 6874.9656251718925, 6889.138857642794, 6913.619750913697, 4931.731403554405, 4941.901161976813, 4948.882204211323, 4961.305417241589, 4983.526564976321, 5004.449510553836, 5036.949630503721, 5041.621878359138, 5045.747712614355, 5074.5686616637995, 5570.777168913279, 5652.123920792284, 5652.547796176296, 5668.971655141698, 5672.829815105553, 6440.8389790255615, 6458.868573370776, 6489.772857949949, 6506.739730410731, 6610.2398224204835, 1648.3736180251428, 1697.4652984309903, 1708.5557754983793, 1723.172877019038, 1737.7567140600327, 1203.5667159822458, 1204.6386084174887, 1207.1127721124967, 1220.3166226912956, 1234.21010553246, 5705.914411283834, 5734.483896449339, 5758.568107391962, 5764.365919748824, 5806.158107074535, 6578.5395022347975, 6598.063861581551, 6630.370114839083, 6660.167479065117, 6754.425873800684, 5579.972100139474, 5670.710987627166, 5714.942850571524, 5728.914066289009, 5751.769929202868, 3522.295540891832, 3571.6964058054837, 3582.373084710165, 3592.1558433768046, 3605.8737944172353, 6331.176946996861, 6521.9673901630185, 6574.704138313788, 6576.177977752781, 6587.9670601646685, 6800.863982720417, 6801.605670837466, 6809.591424514545, 6851.383375496229, 6869.7595584154315, 6423.022157827534, 6472.838179045468, 6479.967600161969, 6513.478921686254, 6523.641199733966, 6714.362135597111, 6715.395614394728, 6720.622272434041, 6724.260331363644, 6783.219929708147, 6629.03878937561, 6641.601503909781, 6692.787462018161, 6693.163354580677, 6701.108191020485, 6513.1532900722605, 6515.511336649865, 6522.0, 6556.18047744032, 6567.146270984741, 4910.140725373117, 4929.309896614405, 4953.1579631463455, 4976.2038073908, 4996.3005179274205, 6696.698648560924, 6708.563943343667, 6744.831379215362, 6753.15585551806, 6784.233401608593, 6437.678116094083, 6439.291677915519, 6536.248331441945, 6564.343565643398, 6582.288604962649, 6479.287278399278, 6483.189601299838, 6505.739770409131, 6517.891958367184, 6534.379233972765, 6061.6666083365835, 6235.194162626927, 6274.780382686584, 6313.08460273267, 6391.238527297193, 6436.517261205335, 6455.548111632141, 6490.350964903472, 6522.673866306761, 6545.410913017851, 6196.349383314868, 6219.782307619212, 6221.346758590464, 6360.173177486897, 6370.58591191571], "value": 4999.676668282895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.1088921967255, 906.9274458043355, 911.1207684584375, 915.3455279475174, 925.4586067150716, 16898.0, 17691.29234830607, 17723.64552708945, 17733.55666108348, 17767.46697599071, 19807.0, 21060.684089738665, 21175.57648847026, 21321.36035918925, 21407.6788848167, 1035.927485076045, 1061.3207547169818, 1063.7712891728277, 1066.8293073108305, 1069.7753471770936, 975.3416443900375, 1050.4117694091333, 1058.5289546151967, 1062.0441602557682, 1069.6149386220955, 1113.6436340371085, 1116.9050630696402, 1117.5641499815079, 1117.804384232756, 1118.2563595209176, 1100.6202860013282, 1106.5186643809968, 1106.6458733205377, 1107.4075369677225, 1108.3073079325422, 809.8177909970268, 810.509641666789, 811.7240138352988, 811.9188081191893, 815.1563132158248, 18555.350562730375, 19453.708194377097, 19689.704654430196, 19707.80292197074, 19867.105980230925, 19329.613407731908, 19540.413787586396, 19638.803611963842, 20188.798112018987, 20197.19211231549, 15338.156401397919, 15469.303881325368, 15567.143807090606, 15666.530004099895, 16522.0, 3577.731670124751, 3579.266250418658, 3593.568771747381, 3601.963980360189, 3605.080704420382, 111091.0, 112477.43761281141, 116162.41918790436, 118555.99999999914, 118884.0, 15412.537623871078, 15690.137042462546, 15768.842311576738, 15779.763303550455, 15800.92099539518, 28061.719382806317, 28705.56941645877, 28778.568321475195, 28790.424191516053, 28795.136145915658, 8962.596683149273, 9009.279257659371, 9036.774080648036, 9086.409383390059, 9224.30817688676, 4254.170436764863, 4325.84859529915, 4371.584699453547, 4375.146846364928, 4400.955990440055, 4730.62155027597, 4907.754612269372, 4910.90178196434, 5546.362168350611, 5720.942790572041, 1029.6550655530482, 1059.782744537368, 1071.6677829872608, 1074.8065348237392, 1074.8334008228737, 638.7636574467476, 658.7595527632476, 668.2081733146238, 670.088679396021, 686.1491750229779, 10692.518836652369, 10931.781364372668, 11010.559577616967, 11498.0, 11990.340531270864, 649.4804156674642, 658.1969996604136, 658.7826017414337, 671.9204063423696, 680.6256558892688, 5141.640085194001, 5240.868978275497, 5319.28189694394, 5396.865078372994, 5424.186372044146, 97739.0, 98234.50882745684, 98660.0, 99027.0, 102576.48711756543, 83364.0, 89029.55485222532, 89196.5540172295, 90179.54910225538, 90435.54782226047, 71359.57280854354, 74889.6255518719, 75392.62303688447, 78812.0, 79679.60160199278, 11764.941175294069, 11779.528818847493, 11804.17370784037, 12238.632841014783, 12300.446479908247, 32870.34259314848, 33680.49479257764, 34979.82510087433, 36397.45403818998, 36987.0, 43054.56945430631, 45086.32370514379, 45326.54673453223, 45544.0, 46167.0, 18800.905995469937, 19153.61692766165, 19165.425037248904, 19517.316893908646, 19563.51091222731, 20039.899800501487, 20090.89954550218, 20221.69667455019, 20370.490737731674, 20597.79402206019, 17472.82527174712, 17632.206550705505, 17739.0, 17841.910790445963, 17849.107544622457, 17807.643847123243, 17925.014124223293, 18182.181801819213, 18483.630327393108, 18802.811971880106, 17220.655586888442, 18852.151653175915, 19021.71467427962, 19480.415587532396, 19755.0, 11718.589849355232, 12845.0, 13103.475860965837, 13349.399277032751, 14026.579202623938, 13360.0, 13818.861811381757, 14223.288835558387, 14492.0, 14999.400023998918], "value": 8867.53093524653, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 106.0, 108.0, 110.0, 112.0, 111.0, 101.0, 108.0, 107.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 156.0, 177.0, 125.0, 144.0, 146.0, 119.0, 188.0, 120.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 164.0, 163.0, 164.0, 174.0, 169.0, 167.0, 162.0, 167.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 172.0, 76.0, 76.0, 76.0, 73.0, 178.0, 82.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 137.0, 78.0, 87.0, 87.0, 128.0, 87.0, 78.0, 128.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 114.0, 122.0, 122.0, 114.0, 114.0, 116.0, 116.0, 120.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 158.0, 152.0, 155.0, 151.0, 150.0, 153.0, 151.0, 157.0], "value": 152.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 99.0, 98.0, 99.0, 99.0, 94.0, 96.0, 94.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 55.0, 58.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 59.0, 54.0, 59.0, 59.0, 54.0, 56.0, 60.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 81.0, 86.0, 92.0, 79.0, 79.0, 81.0, 91.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 135.0, 139.0, 139.0, 134.0, 137.0, 137.0, 129.0, 178.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 185.0, 192.0, 185.0, 185.0, 179.0, 182.0, 177.0, 187.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 74.0, 70.0, 66.0, 68.0, 66.0, 74.0, 68.0, 66.0], "value": 69.1, "unit": "score"}]}]} 18:50:15 INFO - Return code: 0 18:50:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:15 INFO - # TBPL SUCCESS # 18:50:15 INFO - Running post-action listener: _package_coverage_data 18:50:15 INFO - Running post-action listener: _resource_record_post_action 18:50:15 INFO - [mozharness: 2017-08-01 01:50:15.199866Z] Finished run-tests step (success) 18:50:15 INFO - Running post-run listener: _resource_record_post_run 18:50:15 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431476736; Read time: 16; Write time: 308704 18:50:15 INFO - TinderboxPrint: CPU usage
13.2% 18:50:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:50:15 INFO - TinderboxPrint: I/O write bytes / time
431,476,736 / 308,704 18:50:15 INFO - TinderboxPrint: CPU idle
8,279.4 (86.8%) 18:50:15 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 18:50:15 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109596672; Read time: 0; Write time: 115752 18:50:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:50:15 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 321466368; Read time: 0; Write time: 192928 18:50:15 INFO - Running post-run listener: _upload_blobber_files 18:50:15 INFO - Blob upload gear active. 18:50:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:15 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 18:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:50:16 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:50:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:16 INFO - (blobuploader) - INFO - Done attempting. 18:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:17 INFO - (blobuploader) - INFO - Done attempting. 18:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:18 INFO - (blobuploader) - INFO - Done attempting. 18:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:25 INFO - (blobuploader) - INFO - Done attempting. 18:50:25 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:25 INFO - Return code: 0 18:50:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd48988ba572613efd411f1628a3074945bd21c60d1563bfe916c4b7cdf6310153b241f163d11d9577f69d1db8210ca790c97150acd7b0e2380f0071a812b5e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1f1e3268bdf230fd4b669705f37ad42bf569fed41f89c6bd6002fd5512d4d96d6d12cccdbb64292d41a09dc067bb69be7a1120302742870546257b5971d14e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef63b5c405491f7da3f12caa333ff3d9cb5490cee17557f6452fddd8e34c9f8b691e20c6e7d1537547489e094d984851594d730eeb0966a5251d98a9d0c186ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c15130dd6a1c8e4d01a58fbca45840df6f7e656fb39d4dbb37ceaef0d4239afe314e09082ca2b861043297892be7173ebc55e97dbd3cbff3d3e435368699afa"} 18:50:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:25 INFO - Contents: 18:50:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd48988ba572613efd411f1628a3074945bd21c60d1563bfe916c4b7cdf6310153b241f163d11d9577f69d1db8210ca790c97150acd7b0e2380f0071a812b5e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1f1e3268bdf230fd4b669705f37ad42bf569fed41f89c6bd6002fd5512d4d96d6d12cccdbb64292d41a09dc067bb69be7a1120302742870546257b5971d14e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef63b5c405491f7da3f12caa333ff3d9cb5490cee17557f6452fddd8e34c9f8b691e20c6e7d1537547489e094d984851594d730eeb0966a5251d98a9d0c186ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c15130dd6a1c8e4d01a58fbca45840df6f7e656fb39d4dbb37ceaef0d4239afe314e09082ca2b861043297892be7173ebc55e97dbd3cbff3d3e435368699afa"} 18:50:25 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:25 INFO - Copying logs to upload dir... 18:50:25 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.118033 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-31 18:50:25.825381) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 18:50:25.829175) ========= 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=523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd48988ba572613efd411f1628a3074945bd21c60d1563bfe916c4b7cdf6310153b241f163d11d9577f69d1db8210ca790c97150acd7b0e2380f0071a812b5e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1f1e3268bdf230fd4b669705f37ad42bf569fed41f89c6bd6002fd5512d4d96d6d12cccdbb64292d41a09dc067bb69be7a1120302742870546257b5971d14e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef63b5c405491f7da3f12caa333ff3d9cb5490cee17557f6452fddd8e34c9f8b691e20c6e7d1537547489e094d984851594d730eeb0966a5251d98a9d0c186ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c15130dd6a1c8e4d01a58fbca45840df6f7e656fb39d4dbb37ceaef0d4239afe314e09082ca2b861043297892be7173ebc55e97dbd3cbff3d3e435368699afa"} build_url:https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/ZbeB3PV6RPy_XbcR57i83g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd48988ba572613efd411f1628a3074945bd21c60d1563bfe916c4b7cdf6310153b241f163d11d9577f69d1db8210ca790c97150acd7b0e2380f0071a812b5e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1f1e3268bdf230fd4b669705f37ad42bf569fed41f89c6bd6002fd5512d4d96d6d12cccdbb64292d41a09dc067bb69be7a1120302742870546257b5971d14e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef63b5c405491f7da3f12caa333ff3d9cb5490cee17557f6452fddd8e34c9f8b691e20c6e7d1537547489e094d984851594d730eeb0966a5251d98a9d0c186ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c15130dd6a1c8e4d01a58fbca45840df6f7e656fb39d4dbb37ceaef0d4239afe314e09082ca2b861043297892be7173ebc55e97dbd3cbff3d3e435368699afa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 18:50:25.853619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:50:25.853921) ========= 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=523ca41ca1e0623de333ad52000001bf-1501549509.291491-329337034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004742 ========= master_lag: 0.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 18:50:26.217755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 18:50:26.218065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 18:50:26.218687) ========= ========= Total master_lag: 0.43 =========