builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1506973261.59 results: success (0) revision: 37d18f6628dcecba2f3f59a3d853071b7ca799e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.586454) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.586861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.587129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.661929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.662211) ========= 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=199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 12:41:01-- 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% 53.7M=0s 2017-10-02 12:41:01 (53.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106650 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.830766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.831054) ========= 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=199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019772 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.886735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:01.887051) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 37d18f6628dcecba2f3f59a3d853071b7ca799e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 37d18f6628dcecba2f3f59a3d853071b7ca799e0 --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=199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 12:41:01,964 truncating revision to first 12 chars 2017-10-02 12:41:01,964 Setting DEBUG logging. 2017-10-02 12:41:01,964 attempt 1/10 2017-10-02 12:41:01,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/37d18f6628dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 12:41:02,388 unpacking tar archive at: mozilla-beta-37d18f6628dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705595 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:02.619140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:02.619491) ========= script_repo_revision: 37d18f6628dcecba2f3f59a3d853071b7ca799e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:02.619931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:02.620232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 12:41:02.642729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-10-02 12:41:02.642996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:41:02 INFO - MultiFileLogger online at 20171002 12:41:02 in /builds/slave/test 12:41:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 12:41:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:41:02 INFO - {'append_to_log': False, 12:41:02 INFO - 'base_work_dir': '/builds/slave/test', 12:41:02 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:41:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:41:02 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:41:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:41:02 INFO - 'code_coverage': False, 12:41:02 INFO - 'config_files': ('talos/linux_config.py',), 12:41:02 INFO - 'default_actions': ('clobber', 12:41:02 INFO - 'read-buildbot-config', 12:41:02 INFO - 'download-and-extract', 12:41:02 INFO - 'populate-webroot', 12:41:02 INFO - 'create-virtualenv', 12:41:02 INFO - 'install', 12:41:02 INFO - 'setup-mitmproxy', 12:41:02 INFO - 'run-tests'), 12:41:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:41:02 INFO - 'disable_ccov_upload': False, 12:41:02 INFO - 'disable_stylo': False, 12:41:02 INFO - 'download_minidump_stackwalk': True, 12:41:02 INFO - 'download_symbols': 'ondemand', 12:41:02 INFO - 'enable_stylo': False, 12:41:02 INFO - 'enable_webrender': False, 12:41:02 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:41:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:41:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:41:02 INFO - 'gecko_profile': False, 12:41:02 INFO - 'gecko_profile_interval': 0, 12:41:02 INFO - 'installer_path': 'installer.exe', 12:41:02 INFO - 'log_level': 'info', 12:41:02 INFO - 'log_name': 'talos', 12:41:02 INFO - 'log_to_console': True, 12:41:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:41:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:41:02 INFO - 'opt_config_files': (), 12:41:02 INFO - 'pip_index': False, 12:41:02 INFO - 'suite': 'dromaeojs-e10s', 12:41:02 INFO - 'system_bits': '32', 12:41:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:41:02 INFO - 'title': 'talos-linux64-ix-072', 12:41:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:41:02 INFO - 'use_talos_json': True, 12:41:02 INFO - 'verify': 'False', 12:41:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:41:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:41:02 INFO - 'work_dir': 'build'} 12:41:02 INFO - [mozharness: 2017-10-02 19:41:02.858488Z] Running clobber step. 12:41:02 INFO - Running pre-action listener: _resource_record_pre_action 12:41:02 INFO - Running main action method: clobber 12:41:02 INFO - rmtree: /builds/slave/test/build 12:41:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:41:04 INFO - Running post-action listener: _resource_record_post_action 12:41:04 INFO - [mozharness: 2017-10-02 19:41:04.375447Z] Finished clobber step (success) 12:41:04 INFO - [mozharness: 2017-10-02 19:41:04.375545Z] Running read-buildbot-config step. 12:41:04 INFO - Running pre-action listener: _resource_record_pre_action 12:41:04 INFO - Running main action method: read_buildbot_config 12:41:04 INFO - Using buildbot properties: 12:41:04 INFO - { 12:41:04 INFO - "project": "", 12:41:04 INFO - "product": "firefox", 12:41:04 INFO - "who": "ryanvm@gmail.com", 12:41:04 INFO - "installer_path": "public/build/target.tar.bz2", 12:41:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:41:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 12:41:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 12:41:04 INFO - "stage_platform": "linux64", 12:41:04 INFO - "basedir": "/builds/slave/test", 12:41:04 INFO - "buildnumber": 149, 12:41:04 INFO - "platform": "ubuntu64_hw", 12:41:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:41:04 INFO - "slavebuilddir": "test", 12:41:04 INFO - "taskId": "Q-a_a262SvGsTriz6vhQYA", 12:41:04 INFO - "branch": "mozilla-beta", 12:41:04 INFO - "script_repo_revision": "production", 12:41:04 INFO - "revision": "37d18f6628dcecba2f3f59a3d853071b7ca799e0", 12:41:04 INFO - "slavename": "talos-linux64-ix-072", 12:41:04 INFO - "repo_path": "releases/mozilla-beta" 12:41:04 INFO - } 12:41:04 INFO - Finding installer, test and symbols from parent task. 12:41:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-a_a262SvGsTriz6vhQYA'}, attempt #1 12:41:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-a_a262SvGsTriz6vhQYA'}, attempt #1 12:41:05 INFO - Task dependencies: EBOOpXnDSySSY5KUwVu83A 12:41:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A'}, attempt #1 12:41:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2 12:41:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.test_packages.json 12:41:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.crashreporter-symbols.zip 12:41:05 INFO - Running post-action listener: _resource_record_post_action 12:41:05 INFO - [mozharness: 2017-10-02 19:41:05.886544Z] Finished read-buildbot-config step (success) 12:41:05 INFO - [mozharness: 2017-10-02 19:41:05.886762Z] Running download-and-extract step. 12:41:05 INFO - Running pre-action listener: _resource_record_pre_action 12:41:05 INFO - Running main action method: download_and_extract 12:41:05 INFO - mkdir: /builds/slave/test/build/tests 12:41: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')]} 12:41:05 INFO - trying https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.test_packages.json 12:41:05 INFO - Downloading https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:41:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:41:06 INFO - Downloaded 989 bytes. 12:41:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:41:06 INFO - Using the following test package requirements: 12:41:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:41:06 INFO - u'common': [u'target.common.tests.zip'], 12:41:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:41:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:41:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:41:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:41:06 INFO - u'mozbase': [u'target.common.tests.zip'], 12:41:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:41:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:41:06 INFO - u'web-platform': [u'target.common.tests.zip', 12:41:06 INFO - u'target.web-platform.tests.tar.gz'], 12:41:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:41:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:41:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.common.tests.zip 12:41:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:41:06 INFO - Fetch https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.common.tests.zip into memory 12:41:08 INFO - Content-Length response header: 55181424 12:41:08 INFO - Bytes received: 55181424 12:41:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.talos.tests.zip 12:41:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:41:18 INFO - Fetch https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.talos.tests.zip into memory 12:41:20 INFO - Content-Length response header: 14509184 12:41:20 INFO - Bytes received: 14509184 12:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:20 INFO - trying https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2 12:41:20 INFO - Downloading https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:41:22 INFO - Downloaded 53552522 bytes. 12:41:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2 12:41:22 INFO - mkdir: /builds/slave/test/properties 12:41:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:41:22 INFO - Writing to file /builds/slave/test/properties/build_url 12:41:22 INFO - Contents: 12:41:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2 12:41:22 INFO - Running post-action listener: _resource_record_post_action 12:41:22 INFO - Running post-action listener: find_tests_for_verification 12:41:22 INFO - Running post-action listener: set_extra_try_arguments 12:41:22 INFO - [mozharness: 2017-10-02 19:41:22.581943Z] Finished download-and-extract step (success) 12:41:22 INFO - [mozharness: 2017-10-02 19:41:22.582041Z] Running populate-webroot step. 12:41:22 INFO - Running pre-action listener: _resource_record_pre_action 12:41:22 INFO - Running main action method: populate_webroot 12:41:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:41:22 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['tresize', 12:41:22 INFO - 'tcanvasmark']}, 12:41:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:41:22 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['dromaeo_css', 12:41:22 INFO - 'kraken']}, 12:41:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:41:22 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:41:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'tests': ['damp', 'tps']}, 12:41:22 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['damp', 'tps']}, 12:41:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:41:22 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['dromaeo_dom']}, 12:41:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:41:22 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['basic_compositor_video', 12:41:22 INFO - 'glvideo']}, 12:41:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:41:22 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['ts_paint_webext', 12:41:22 INFO - 'tp5o_webext']}, 12:41:22 INFO - 'other-e10s': {'tests': ['a11yr', 12:41:22 INFO - 'ts_paint', 12:41:22 INFO - 'tpaint', 12:41:22 INFO - 'sessionrestore', 12:41:22 INFO - 'sessionrestore_many_windows', 12:41:22 INFO - 'sessionrestore_no_auto_restore', 12:41:22 INFO - 'tabpaint']}, 12:41:22 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['a11yr', 12:41:22 INFO - 'ts_paint', 12:41:22 INFO - 'tpaint', 12:41:22 INFO - 'sessionrestore', 12:41:22 INFO - 'sessionrestore_many_windows', 12:41:22 INFO - 'sessionrestore_no_auto_restore', 12:41:22 INFO - 'tabpaint']}, 12:41:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:41:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:41:22 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['perf_reftest_singletons']}, 12:41:22 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['bloom_basic']}, 12:41:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:41:22 INFO - 'tsvgr_opacity', 12:41:22 INFO - 'tart', 12:41:22 INFO - 'tscrollx', 12:41:22 INFO - 'tsvg_static']}, 12:41:22 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['tsvgx', 12:41:22 INFO - 'tsvgr_opacity', 12:41:22 INFO - 'tart', 12:41:22 INFO - 'tscrollx', 12:41:22 INFO - 'tsvg_static']}, 12:41:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:41:22 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'talos_options': ['--disable-stylo'], 12:41:22 INFO - 'tests': ['tp5o']}, 12:41:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:41:22 INFO - 'talos_options': ['--mitmproxy', 12:41:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:41:22 INFO - '--firstNonBlankPaint'], 12:41:22 INFO - 'tests': ['tp6_google', 12:41:22 INFO - 'tp6_youtube', 12:41:22 INFO - 'tp6_amazon', 12:41:22 INFO - 'tp6_facebook']}, 12:41:22 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:41:22 INFO - 'talos_options': ['--disable-stylo', 12:41:22 INFO - '--mitmproxy', 12:41:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:41:22 INFO - '--firstNonBlankPaint'], 12:41:22 INFO - 'tests': ['tp6_google', 12:41:22 INFO - 'tp6_youtube', 12:41:22 INFO - 'tp6_amazon', 12:41:22 INFO - 'tp6_facebook']}, 12:41:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:41:22 INFO - 'talos_options': ['--stylo-threads=1', 12:41:22 INFO - '--mitmproxy', 12:41:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:41:22 INFO - '--firstNonBlankPaint'], 12:41:22 INFO - 'tests': ['tp6_google', 12:41:22 INFO - 'tp6_youtube', 12:41:22 INFO - 'tp6_amazon', 12:41:22 INFO - 'tp6_facebook']}, 12:41:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'talos_options': ['--xperf_path', 12:41:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:41:22 INFO - 'tests': ['tp5n']}, 12:41:22 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:41:22 INFO - 'talos_options': ['--disable-stylo', 12:41:22 INFO - '--xperf_path', 12:41:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:41:22 INFO - 'tests': ['tp5n']}}} 12:41:22 INFO - Running post-action listener: _resource_record_post_action 12:41:22 INFO - [mozharness: 2017-10-02 19:41:22.596932Z] Finished populate-webroot step (success) 12:41:22 INFO - [mozharness: 2017-10-02 19:41:22.597022Z] Running create-virtualenv step. 12:41:22 INFO - Running pre-action listener: _resource_record_pre_action 12:41:22 INFO - Running main action method: create_virtualenv 12:41:22 INFO - Creating virtualenv /builds/slave/test/build/venv 12:41:22 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:41:22 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:41:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:41:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:41:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:41:23 INFO - Installing distribute.............................................................................................................................................................................................done. 12:41:23 INFO - Installing pip...............done. 12:41:23 INFO - Return code: 0 12:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:41:23 INFO - Reading from file tmpfile_stdout 12:41:23 INFO - Output received: 12:41:23 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:41:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:41:23 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')]} 12:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:23 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')]} 12:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:23 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:23 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 12:41:23 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 12:41:23 INFO - Using env: {'DISPLAY': ':0', 12:41:23 INFO - 'HOME': '/home/cltbld', 12:41:23 INFO - 'LANG': 'en_US.UTF-8', 12:41:23 INFO - 'LANGUAGE': 'en_US:en', 12:41:23 INFO - 'LOGNAME': 'cltbld', 12:41:23 INFO - 'MAIL': '/var/mail/cltbld', 12:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:23 INFO - 'MOZ_NO_REMOTE': '1', 12:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:23 INFO - 'NO_EM_RESTART': '1', 12:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:23 INFO - 'PWD': '/builds/slave/test', 12:41:23 INFO - 'SHELL': '/bin/bash', 12:41:23 INFO - 'SHLVL': '1', 12:41:23 INFO - 'TERM': 'linux', 12:41:23 INFO - 'TMOUT': '86400', 12:41:23 INFO - 'USER': 'cltbld', 12:41:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:23 INFO - '_': '/tools/buildbot/bin/python'} 12:41:25 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:41:25 INFO - Downloading/unpacking pip>=1.5 12:41:25 INFO - Running setup.py egg_info for package pip 12:41:25 INFO - warning: no files found matching 'pip/cacert.pem' 12:41:25 INFO - warning: no files found matching '*.html' under directory 'docs' 12:41:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:41:25 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:41:25 INFO - Installing collected packages: pip 12:41:25 INFO - Found existing installation: pip 1.1 12:41:25 INFO - Uninstalling pip: 12:41:25 INFO - Successfully uninstalled pip 12:41:25 INFO - Running setup.py install for pip 12:41:25 INFO - warning: no files found matching 'pip/cacert.pem' 12:41:25 INFO - warning: no files found matching '*.html' under directory 'docs' 12:41:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:41:25 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:41:25 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:41:25 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:41:25 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:41:25 INFO - Successfully installed pip 12:41:25 INFO - Cleaning up... 12:41:25 INFO - Return code: 0 12:41:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:25 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:25 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 12:41:25 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 12:41:25 INFO - Using env: {'DISPLAY': ':0', 12:41:25 INFO - 'HOME': '/home/cltbld', 12:41:25 INFO - 'LANG': 'en_US.UTF-8', 12:41:25 INFO - 'LANGUAGE': 'en_US:en', 12:41:25 INFO - 'LOGNAME': 'cltbld', 12:41:25 INFO - 'MAIL': '/var/mail/cltbld', 12:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:25 INFO - 'MOZ_NO_REMOTE': '1', 12:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:25 INFO - 'NO_EM_RESTART': '1', 12:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:25 INFO - 'PWD': '/builds/slave/test', 12:41:25 INFO - 'SHELL': '/bin/bash', 12:41:25 INFO - 'SHLVL': '1', 12:41:25 INFO - 'TERM': 'linux', 12:41:25 INFO - 'TMOUT': '86400', 12:41:25 INFO - 'USER': 'cltbld', 12:41:25 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:25 INFO - '_': '/tools/buildbot/bin/python'} 12:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:25 INFO - Downloading/unpacking psutil>=3.1.1 12:41:25 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 12:41:25 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 12:41:25 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 12:41:25 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 12:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:41:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:41:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:41:26 INFO - Installing collected packages: psutil 12:41:26 INFO - Running setup.py install for psutil 12:41:26 INFO - building 'psutil._psutil_linux' extension 12:41:26 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 12:41:26 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 12:41:26 INFO - building 'psutil._psutil_posix' extension 12:41:26 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 12:41:26 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 12:41:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:41:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:41:26 INFO - Successfully installed psutil 12:41:26 INFO - Cleaning up... 12:41:26 INFO - Return code: 0 12:41:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:41:26 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')]} 12:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:26 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')]} 12:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:26 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:26 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 12:41:26 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 12:41:26 INFO - Using env: {'DISPLAY': ':0', 12:41:26 INFO - 'HOME': '/home/cltbld', 12:41:26 INFO - 'LANG': 'en_US.UTF-8', 12:41:26 INFO - 'LANGUAGE': 'en_US:en', 12:41:26 INFO - 'LOGNAME': 'cltbld', 12:41:26 INFO - 'MAIL': '/var/mail/cltbld', 12:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:26 INFO - 'MOZ_NO_REMOTE': '1', 12:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:26 INFO - 'NO_EM_RESTART': '1', 12:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:26 INFO - 'PWD': '/builds/slave/test', 12:41:26 INFO - 'SHELL': '/bin/bash', 12:41:26 INFO - 'SHLVL': '1', 12:41:26 INFO - 'TERM': 'linux', 12:41:26 INFO - 'TMOUT': '86400', 12:41:26 INFO - 'USER': 'cltbld', 12:41:26 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:26 INFO - '_': '/tools/buildbot/bin/python'} 12:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:41:27 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 12:41:27 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 12:41:27 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 12:41:27 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 12:41:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:41:28 INFO - Installing collected packages: mozsystemmonitor 12:41:28 INFO - Running setup.py install for mozsystemmonitor 12:41:29 INFO - Successfully installed mozsystemmonitor 12:41:29 INFO - Cleaning up... 12:41:29 INFO - Return code: 0 12:41:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:41:29 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')]} 12:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:29 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')]} 12:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:29 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:29 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 12:41:29 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 12:41:29 INFO - Using env: {'DISPLAY': ':0', 12:41:29 INFO - 'HOME': '/home/cltbld', 12:41:29 INFO - 'LANG': 'en_US.UTF-8', 12:41:29 INFO - 'LANGUAGE': 'en_US:en', 12:41:29 INFO - 'LOGNAME': 'cltbld', 12:41:29 INFO - 'MAIL': '/var/mail/cltbld', 12:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:29 INFO - 'MOZ_NO_REMOTE': '1', 12:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:29 INFO - 'NO_EM_RESTART': '1', 12:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:29 INFO - 'PWD': '/builds/slave/test', 12:41:29 INFO - 'SHELL': '/bin/bash', 12:41:29 INFO - 'SHLVL': '1', 12:41:29 INFO - 'TERM': 'linux', 12:41:29 INFO - 'TMOUT': '86400', 12:41:29 INFO - 'USER': 'cltbld', 12:41:29 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:29 INFO - '_': '/tools/buildbot/bin/python'} 12:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:29 INFO - Downloading/unpacking jsonschema==2.5.1 12:41:29 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 12:41:29 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 12:41:29 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 12:41:29 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 12:41:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:41:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:41:30 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 12:41:30 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 12:41:30 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 12:41:30 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 12:41:30 INFO - Downloading functools32-3.2.3-2.tar.gz 12:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:41:30 INFO - warning: no files found matching '*.txt' 12:41:30 INFO - no previously-included directories found matching 'build' 12:41:30 INFO - no previously-included directories found matching 'dist' 12:41:30 INFO - no previously-included directories found matching '.git*' 12:41:30 INFO - Installing collected packages: jsonschema, functools32 12:41:30 INFO - Running setup.py install for functools32 12:41:31 INFO - warning: no files found matching '*.txt' 12:41:31 INFO - no previously-included directories found matching 'build' 12:41:31 INFO - no previously-included directories found matching 'dist' 12:41:31 INFO - no previously-included directories found matching '.git*' 12:41:31 INFO - Successfully installed jsonschema functools32 12:41:31 INFO - Cleaning up... 12:41:31 INFO - Return code: 0 12:41:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:41:31 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')]} 12:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:31 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')]} 12:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:31 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:31 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 12:41:31 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 12:41:31 INFO - Using env: {'DISPLAY': ':0', 12:41:31 INFO - 'HOME': '/home/cltbld', 12:41:31 INFO - 'LANG': 'en_US.UTF-8', 12:41:31 INFO - 'LANGUAGE': 'en_US:en', 12:41:31 INFO - 'LOGNAME': 'cltbld', 12:41:31 INFO - 'MAIL': '/var/mail/cltbld', 12:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:31 INFO - 'MOZ_NO_REMOTE': '1', 12:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:31 INFO - 'NO_EM_RESTART': '1', 12:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:31 INFO - 'PWD': '/builds/slave/test', 12:41:31 INFO - 'SHELL': '/bin/bash', 12:41:31 INFO - 'SHLVL': '1', 12:41:31 INFO - 'TERM': 'linux', 12:41:31 INFO - 'TMOUT': '86400', 12:41:31 INFO - 'USER': 'cltbld', 12:41:31 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:31 INFO - '_': '/tools/buildbot/bin/python'} 12:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:41:31 INFO - Cleaning up... 12:41:31 INFO - Return code: 0 12:41:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:41:31 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')]} 12:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:31 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')]} 12:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:31 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:31 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 12:41:31 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 12:41:31 INFO - Using env: {'DISPLAY': ':0', 12:41:31 INFO - 'HOME': '/home/cltbld', 12:41:31 INFO - 'LANG': 'en_US.UTF-8', 12:41:31 INFO - 'LANGUAGE': 'en_US:en', 12:41:31 INFO - 'LOGNAME': 'cltbld', 12:41:31 INFO - 'MAIL': '/var/mail/cltbld', 12:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:31 INFO - 'MOZ_NO_REMOTE': '1', 12:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:31 INFO - 'NO_EM_RESTART': '1', 12:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:31 INFO - 'PWD': '/builds/slave/test', 12:41:31 INFO - 'SHELL': '/bin/bash', 12:41:31 INFO - 'SHLVL': '1', 12:41:31 INFO - 'TERM': 'linux', 12:41:31 INFO - 'TMOUT': '86400', 12:41:31 INFO - 'USER': 'cltbld', 12:41:31 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:31 INFO - '_': '/tools/buildbot/bin/python'} 12:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:31 INFO - Downloading/unpacking blobuploader==1.2.4 12:41:31 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 12:41:31 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 12:41:31 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 12:41:31 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 12:41:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:41:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:41:32 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 12:41:32 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 12:41:32 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 12:41:32 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 12:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:41:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:41:33 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 12:41:33 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 12:41:33 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 12:41:33 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 12:41:33 INFO - Downloading docopt-0.6.1.tar.gz 12:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:41:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:41:33 INFO - Running setup.py install for blobuploader 12:41:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:41:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:41:33 INFO - Running setup.py install for requests 12:41:33 INFO - Running setup.py install for docopt 12:41:33 INFO - Successfully installed blobuploader requests docopt 12:41:33 INFO - Cleaning up... 12:41:33 INFO - Return code: 0 12:41:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:33 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')]} 12:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:33 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')]} 12:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:33 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:33 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 12:41:33 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 12:41:33 INFO - Using env: {'DISPLAY': ':0', 12:41:33 INFO - 'HOME': '/home/cltbld', 12:41:33 INFO - 'LANG': 'en_US.UTF-8', 12:41:33 INFO - 'LANGUAGE': 'en_US:en', 12:41:33 INFO - 'LOGNAME': 'cltbld', 12:41:33 INFO - 'MAIL': '/var/mail/cltbld', 12:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:33 INFO - 'MOZ_NO_REMOTE': '1', 12:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:33 INFO - 'NO_EM_RESTART': '1', 12:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:33 INFO - 'PWD': '/builds/slave/test', 12:41:33 INFO - 'SHELL': '/bin/bash', 12:41:33 INFO - 'SHLVL': '1', 12:41:33 INFO - 'TERM': 'linux', 12:41:33 INFO - 'TMOUT': '86400', 12:41:33 INFO - 'USER': 'cltbld', 12:41:33 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:33 INFO - '_': '/tools/buildbot/bin/python'} 12:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:41:34 INFO - Running setup.py (path:/tmp/pip-XIN1Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:41:34 INFO - Running setup.py (path:/tmp/pip-29b2R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:41:34 INFO - Running setup.py (path:/tmp/pip-QU1QJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:41:34 INFO - Running setup.py (path:/tmp/pip-piwC02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:41:34 INFO - Running setup.py (path:/tmp/pip-Wnhr_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:41:34 INFO - Running setup.py (path:/tmp/pip-xQ4uEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:41:34 INFO - Running setup.py (path:/tmp/pip-HAIX9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:41:34 INFO - Running setup.py (path:/tmp/pip-3skJni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:41:34 INFO - Running setup.py (path:/tmp/pip-3WUvRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:41:34 INFO - Running setup.py (path:/tmp/pip-Gq9Lpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:41:34 INFO - Running setup.py (path:/tmp/pip-yODlPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:41:34 INFO - Running setup.py (path:/tmp/pip-Y7OTeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:41:34 INFO - Running setup.py (path:/tmp/pip-SFio1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:34 INFO - Running setup.py (path:/tmp/pip-DzxvZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:35 INFO - Running setup.py (path:/tmp/pip-5yq_S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:35 INFO - Running setup.py (path:/tmp/pip-syWW9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:35 INFO - Running setup.py (path:/tmp/pip-v3zyAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:41:35 INFO - Running setup.py install for manifestparser 12:41:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:41:35 INFO - Running setup.py install for mozcrash 12:41:35 INFO - Running setup.py install for mozdebug 12:41:35 INFO - Running setup.py install for mozdevice 12:41:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:41:35 INFO - Running setup.py install for mozfile 12:41:35 INFO - Running setup.py install for mozhttpd 12:41:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:41:35 INFO - Running setup.py install for mozinfo 12:41:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:41:35 INFO - Running setup.py install for mozInstall 12:41:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Running setup.py install for mozleak 12:41:36 INFO - Running setup.py install for mozlog 12:41:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Running setup.py install for moznetwork 12:41:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Running setup.py install for mozprocess 12:41:36 INFO - Running setup.py install for mozprofile 12:41:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Running setup.py install for mozrunner 12:41:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:41:36 INFO - Running setup.py install for mozscreenshot 12:41:36 INFO - Running setup.py install for moztest 12:41:36 INFO - Running setup.py install for mozversion 12:41:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:41:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:41:37 INFO - Cleaning up... 12:41:37 INFO - Return code: 0 12:41:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41: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')]} 12:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41: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')]} 12:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:37 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:37 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 12:41:37 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 12:41:37 INFO - Using env: {'DISPLAY': ':0', 12:41:37 INFO - 'HOME': '/home/cltbld', 12:41:37 INFO - 'LANG': 'en_US.UTF-8', 12:41:37 INFO - 'LANGUAGE': 'en_US:en', 12:41:37 INFO - 'LOGNAME': 'cltbld', 12:41:37 INFO - 'MAIL': '/var/mail/cltbld', 12:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:37 INFO - 'MOZ_NO_REMOTE': '1', 12:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:37 INFO - 'NO_EM_RESTART': '1', 12:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:37 INFO - 'PWD': '/builds/slave/test', 12:41:37 INFO - 'SHELL': '/bin/bash', 12:41:37 INFO - 'SHLVL': '1', 12:41:37 INFO - 'TERM': 'linux', 12:41:37 INFO - 'TMOUT': '86400', 12:41:37 INFO - 'USER': 'cltbld', 12:41:37 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:37 INFO - '_': '/tools/buildbot/bin/python'} 12:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:41:37 INFO - Running setup.py (path:/tmp/pip-HkHTlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:41:37 INFO - Running setup.py (path:/tmp/pip-K615FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:41:37 INFO - Running setup.py (path:/tmp/pip-84cbYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:41:37 INFO - Running setup.py (path:/tmp/pip-vExN6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:41:37 INFO - Running setup.py (path:/tmp/pip-ciSVyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:41:37 INFO - Running setup.py (path:/tmp/pip-zIaXXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:41:37 INFO - Running setup.py (path:/tmp/pip-LlqCTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:41:37 INFO - Running setup.py (path:/tmp/pip-2_MvKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:41:37 INFO - Running setup.py (path:/tmp/pip-lj23Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:41:37 INFO - Running setup.py (path:/tmp/pip-FSDMo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:41:37 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)) 12:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:41:37 INFO - Running setup.py (path:/tmp/pip-u4R2tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:41:38 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)) 12:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:41:38 INFO - Running setup.py (path:/tmp/pip-5CjitC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:41:38 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)) 12:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:41:38 INFO - Running setup.py (path:/tmp/pip-kNCh6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:38 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)) 12:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:38 INFO - Running setup.py (path:/tmp/pip-mb3kTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:38 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)) 12:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:38 INFO - Running setup.py (path:/tmp/pip-VGbsIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:38 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)) 12:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:38 INFO - Running setup.py (path:/tmp/pip-ZzqLpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:38 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)) 12:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:38 INFO - Running setup.py (path:/tmp/pip-FMeaAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:38 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)) 12:41:38 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)) 12:41:38 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)) 12:41:38 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)) 12:41:38 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)) 12:41:38 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)) 12:41:38 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)) 12:41:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:41:38 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 12:41:38 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 12:41:38 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 12:41:38 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 12:41:39 INFO - Downloading blessings-1.6.tar.gz 12:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:41:39 INFO - Installing collected packages: blessings 12:41:39 INFO - Running setup.py install for blessings 12:41:39 INFO - Successfully installed blessings 12:41:39 INFO - Cleaning up... 12:41:39 INFO - Return code: 0 12:41:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:41:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:40 INFO - Reading from file tmpfile_stdout 12:41:40 INFO - Current package versions: 12:41:40 INFO - argparse == 1.2.1 12:41:40 INFO - blessings == 1.6 12:41:40 INFO - blobuploader == 1.2.4 12:41:40 INFO - docopt == 0.6.1 12:41:40 INFO - functools32 == 3.2.3-2 12:41:40 INFO - jsonschema == 2.5.1 12:41:40 INFO - manifestparser == 1.1 12:41:40 INFO - mozInstall == 1.13 12:41:40 INFO - mozcrash == 1.0 12:41:40 INFO - mozdebug == 0.1 12:41:40 INFO - mozdevice == 0.51 12:41:40 INFO - mozfile == 1.2 12:41:40 INFO - mozhttpd == 0.7 12:41:40 INFO - mozinfo == 0.10 12:41:40 INFO - mozleak == 0.1 12:41:40 INFO - mozlog == 3.5 12:41:40 INFO - moznetwork == 0.27 12:41:40 INFO - mozprocess == 0.25 12:41:40 INFO - mozprofile == 0.28 12:41:40 INFO - mozrunner == 6.13 12:41:40 INFO - mozscreenshot == 0.1 12:41:40 INFO - mozsystemmonitor == 0.3 12:41:40 INFO - moztest == 0.8 12:41:40 INFO - mozversion == 1.4 12:41:40 INFO - psutil == 3.1.1 12:41:40 INFO - requests == 1.2.3 12:41:40 INFO - wsgiref == 0.1.2 12:41:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:40 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:40 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 12:41:40 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 12:41:40 INFO - Using env: {'DISPLAY': ':0', 12:41:40 INFO - 'HOME': '/home/cltbld', 12:41:40 INFO - 'LANG': 'en_US.UTF-8', 12:41:40 INFO - 'LANGUAGE': 'en_US:en', 12:41:40 INFO - 'LOGNAME': 'cltbld', 12:41:40 INFO - 'MAIL': '/var/mail/cltbld', 12:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:40 INFO - 'MOZ_NO_REMOTE': '1', 12:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:40 INFO - 'NO_EM_RESTART': '1', 12:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:40 INFO - 'PWD': '/builds/slave/test', 12:41:40 INFO - 'SHELL': '/bin/bash', 12:41:40 INFO - 'SHLVL': '1', 12:41:40 INFO - 'TERM': 'linux', 12:41:40 INFO - 'TMOUT': '86400', 12:41:40 INFO - 'USER': 'cltbld', 12:41:40 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:40 INFO - '_': '/tools/buildbot/bin/python'} 12:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 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)) 12:41:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:41:40 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 12:41:40 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 12:41:40 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 12:41:40 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 12:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:41:41 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)) 12:41:41 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)) 12:41:41 INFO - Installing collected packages: simplejson 12:41:41 INFO - Running setup.py install for simplejson 12:41:41 INFO - building 'simplejson._speedups' extension 12:41:41 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 12:41:42 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 12:41:42 INFO - Successfully installed simplejson 12:41:42 INFO - Cleaning up... 12:41:42 INFO - Return code: 0 12:41:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:42 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 0x23ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2592a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, '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': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', '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 12:41:42 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 12:41:42 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 12:41:42 INFO - Using env: {'DISPLAY': ':0', 12:41:42 INFO - 'HOME': '/home/cltbld', 12:41:42 INFO - 'LANG': 'en_US.UTF-8', 12:41:42 INFO - 'LANGUAGE': 'en_US:en', 12:41:42 INFO - 'LOGNAME': 'cltbld', 12:41:42 INFO - 'MAIL': '/var/mail/cltbld', 12:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:42 INFO - 'MOZ_NO_REMOTE': '1', 12:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:42 INFO - 'NO_EM_RESTART': '1', 12:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:42 INFO - 'PWD': '/builds/slave/test', 12:41:42 INFO - 'SHELL': '/bin/bash', 12:41:42 INFO - 'SHLVL': '1', 12:41:42 INFO - 'TERM': 'linux', 12:41:42 INFO - 'TMOUT': '86400', 12:41:42 INFO - 'USER': 'cltbld', 12:41:42 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:42 INFO - '_': '/tools/buildbot/bin/python'} 12:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:41:42 INFO - Cleaning up... 12:41:42 INFO - Return code: 0 12:41:42 INFO - Running post-action listener: _resource_record_post_action 12:41:42 INFO - Running post-action listener: _start_resource_monitoring 12:41:42 INFO - Starting resource monitoring. 12:41:42 INFO - [mozharness: 2017-10-02 19:41:42.730084Z] Finished create-virtualenv step (success) 12:41:42 INFO - [mozharness: 2017-10-02 19:41:42.730599Z] Running install step. 12:41:42 INFO - Running pre-action listener: _resource_record_pre_action 12:41:42 INFO - Running main action method: install 12:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:42 INFO - Reading from file tmpfile_stdout 12:41:42 INFO - Detecting whether we're running mozinstall >=1.0... 12:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:41:43 INFO - Reading from file tmpfile_stdout 12:41:43 INFO - Output received: 12:41:43 INFO - Usage: mozinstall [options] installer 12:41:43 INFO - Options: 12:41:43 INFO - -h, --help show this help message and exit 12:41:43 INFO - -d DEST, --destination=DEST 12:41:43 INFO - Directory to install application into. [default: 12:41:43 INFO - "/builds/slave/test"] 12:41:43 INFO - --app=APP Application being installed. [default: firefox] 12:41:43 INFO - mkdir: /builds/slave/test/build/application 12:41:43 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'] 12:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:41:57 INFO - Reading from file tmpfile_stdout 12:41:57 INFO - Output received: 12:41:57 INFO - /builds/slave/test/build/application/firefox/firefox 12:41:57 INFO - Running post-action listener: _resource_record_post_action 12:41:57 INFO - [mozharness: 2017-10-02 19:41:57.695967Z] Finished install step (success) 12:41:57 INFO - [mozharness: 2017-10-02 19:41:57.696216Z] Running setup-mitmproxy step. 12:41:57 INFO - Running pre-action listener: _resource_record_pre_action 12:41:57 INFO - Running main action method: setup_mitmproxy 12:41:57 INFO - Skipping: mitmproxy is not required 12:41:57 INFO - Running post-action listener: _resource_record_post_action 12:41:57 INFO - [mozharness: 2017-10-02 19:41:57.697428Z] Finished setup-mitmproxy step (success) 12:41:57 INFO - [mozharness: 2017-10-02 19:41:57.697661Z] Running run-tests step. 12:41:57 INFO - Running pre-action listener: _resource_record_pre_action 12:41:57 INFO - Running pre-action listener: _set_gcov_prefix 12:41:57 INFO - Running main action method: run_tests 12:41:57 WARNING - Try message not found. 12:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:41:57 INFO - Python 2.7.3 12:41:57 INFO - Return code: 0 12:41:57 INFO - grabbing minidump binary from tooltool 12:41:57 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')]} 12:41:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2739090>, '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 0x2739d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2733f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:41:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 12:41:57 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:41:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 12:41:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:41:57 INFO - Return code: 0 12:41:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:41:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:41:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:41:57 INFO - ENV: RUST_BACKTRACE is now full 12:41:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:41:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 12:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 12:41:57 INFO - Using env: {'DISPLAY': ':0', 12:41:57 INFO - 'HOME': '/home/cltbld', 12:41:57 INFO - 'LANG': 'en_US.UTF-8', 12:41:57 INFO - 'LANGUAGE': 'en_US:en', 12:41:57 INFO - 'LOGNAME': 'cltbld', 12:41:57 INFO - 'MAIL': '/var/mail/cltbld', 12:41:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:41:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:57 INFO - 'MOZ_NO_REMOTE': '1', 12:41:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:57 INFO - 'NO_EM_RESTART': '1', 12:41:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:57 INFO - 'PWD': '/builds/slave/test', 12:41:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:41:57 INFO - 'RUST_BACKTRACE': 'full', 12:41:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:41:57 INFO - 'SHELL': '/bin/bash', 12:41:57 INFO - 'SHLVL': '1', 12:41:57 INFO - 'TERM': 'linux', 12:41:57 INFO - 'TMOUT': '86400', 12:41:57 INFO - 'USER': 'cltbld', 12:41:57 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:57 INFO - '_': '/tools/buildbot/bin/python'} 12:41:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 12:41:58 INFO - mozversion application_buildid: 20171002181526 12:41:58 INFO - mozversion application_changeset: 37d18f6628dcecba2f3f59a3d853071b7ca799e0 12:41:58 INFO - mozversion application_display_name: Firefox 12:41:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:41:58 INFO - mozversion application_name: Firefox 12:41:58 INFO - mozversion application_remotingname: firefox 12:41:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:41:58 INFO - mozversion application_vendor: Mozilla 12:41:58 INFO - mozversion application_version: 57.0 12:41:58 INFO - mozversion platform_buildid: 20171002181526 12:41:58 INFO - mozversion platform_changeset: 37d18f6628dcecba2f3f59a3d853071b7ca799e0 12:41:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:41:58 INFO - mozversion platform_version: 57.0 12:41:58 INFO - using testdate: 1506973318 12:41:58 INFO - actual date: 1506973318 12:41:58 INFO - starting webserver on 'localhost:33445' 12:41:58 INFO - SUITE-START | Running 2 tests 12:41:58 INFO - TEST-START | dromaeo_css 12:41:58 INFO - Initialising browser for dromaeo_css test... 12:41:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33445/getInfo.html -profile /tmp/tmpGaY1CT/profile 12:41:58 INFO - TEST-INFO | started process 30012 (/builds/slave/test/build/application/firefox/firefox http://localhost:33445/getInfo.html) 12:42:03 INFO - TEST-INFO | 30012: exit 0 12:42:03 INFO - Browser initialized. 12:42:03 INFO - Running cycle 1/1 for dromaeo_css test... 12:42:03 INFO - Using env: {'DISPLAY': ':0', 12:42:03 INFO - 'HOME': '/home/cltbld', 12:42:03 INFO - 'JSGC_DISABLE_POISONING': '1', 12:42:03 INFO - 'LANG': 'en_US.UTF-8', 12:42:03 INFO - 'LANGUAGE': 'en_US:en', 12:42:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:42:03 INFO - 'LOGNAME': 'cltbld', 12:42:03 INFO - 'MAIL': '/var/mail/cltbld', 12:42:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:42:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:42:03 INFO - 'MOZ_CRASHREPORTER': '1', 12:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:42:03 INFO - 'MOZ_NO_REMOTE': '1', 12:42:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:03 INFO - 'NO_EM_RESTART': '1', 12:42:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:03 INFO - 'PWD': '/builds/slave/test', 12:42:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:42:03 INFO - 'RUST_BACKTRACE': 'full', 12:42:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:42:03 INFO - 'SHELL': '/bin/bash', 12:42:03 INFO - 'SHLVL': '1', 12:42:03 INFO - 'TERM': 'linux', 12:42:03 INFO - 'TMOUT': '86400', 12:42:03 INFO - 'USER': 'cltbld', 12:42:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 12:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:03 INFO - '_': '/tools/buildbot/bin/python'} 12:42:03 INFO - TEST-INFO | started process 30247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGaY1CT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:04 INFO - PID 30247 | 12:42:04 INFO - PID 30247 | (/builds/slave/test/build/application/firefox/firefox:30295): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:42:04 INFO - PID 30247 | 12:42:14 INFO - PID 30247 | RSS: Main: 141262848 12:42:14 INFO - PID 30247 | 12:45:12 INFO - PID 30247 | Cycle 1(1): loaded http://localhost:33445/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33445/tests/dromaeo/cssquery-ext.html) 12:45:13 INFO - PID 30247 | RSS: Main: 145092608 12:45:13 INFO - PID 30247 | 12:48:14 INFO - PID 30247 | Cycle 1(1): loaded http://localhost:33445/tests/dromaeo/cssquery-ext.html (next: http://localhost:33445/tests/dromaeo/cssquery-jquery.html) 12:48:15 INFO - PID 30247 | RSS: Main: 143982592 12:48:15 INFO - PID 30247 | 12:51:16 INFO - PID 30247 | Cycle 1(1): loaded http://localhost:33445/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33445/tests/dromaeo/cssquery-mootools.html) 12:51:17 INFO - PID 30247 | RSS: Main: 144547840 12:51:17 INFO - PID 30247 | 12:54:18 INFO - PID 30247 | Cycle 1(1): loaded http://localhost:33445/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33445/tests/dromaeo/cssquery-prototype.html) 12:54:19 INFO - PID 30247 | RSS: Main: 144793600 12:54:19 INFO - PID 30247 | 12:57:22 INFO - PID 30247 | Cycle 1(1): loaded http://localhost:33445/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33445/tests/dromaeo/cssquery-yui.html) 12:57:22 INFO - PID 30247 | RSS: Main: 146071552 12:57:22 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | Cycle 1(1): loaded http://localhost:33445/tests/dromaeo/cssquery-yui.html (next: http://localhost:33445/tests/dromaeo/cssquery-dojo.html) 13:00:24 INFO - PID 30247 | RSS: Main: 148865024 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | __start_tp_report 13:00:24 INFO - PID 30247 | _x_x_mozilla_page_load 13:00:24 INFO - PID 30247 | _x_x_mozilla_page_load_details 13:00:24 INFO - PID 30247 | |i|pagename|runs| 13:00:24 INFO - PID 30247 | |0;dojo.html;4021.2560676274893;4026.738262012969;4045.1909618076374;4070.979645101774;4079.0822065035354;6537;6620.702068406921;6647.833804154899;6671.199456065279;6681.26506084331;6604.108445359875;6606.471482281418;6695.732170713166;6699.464042876558;6704.765333213339;5927.792527261558;5952.285725712921;6029.547783916224;6063.242094738158;6064.241969753781;5950.672713000783;6022.096685497188;6024.2770867495965;6025.367336429677;6101.481374083208;5931.139984702238;5999.700014999255;6004.579679422421;6014;6015.879682406349;5823.708814559255;5936.584439089265;5948.613340132878;6009.1587177795145;6035.124906888498;5774.711264436762;5866.325372582165;5897.587168898179;5954.8809023819285;5960.552958528127;6525.93474065258;6611.735530578771;6624.735010599618;6631.171103612049;6700;7135.82160445993;7164.677589508485;7169.318914703095;7235.746748863817;7257.165425976027;7143.607101609461;7164.140303163602;7204.783856484314;7209.747658831916;7209.747658831968;6609.272979972151;6618.834529136762;6632.237292711352;6635.601863888182;6711.496637752188;7383.446241531799;7401.222871598405;7441.479096463304;7486.288802563748;7496.287852653989;7072.257412971564;7082.079329687211;7094.53885497441;7168.964155179191;7177.856442871218;7120.465965052642;7201.387882030086;7223.205447400782;7301.123865136217;7304.707811687579;7115.608641524663;7118.394936430358;7198.100237470317;7198.892016619755;7209.927900721031;7134;7143.321384468467;7227.096612923385;7229.277072292729;7232.0959880015;5286.867828304246;5292.708901010481;5326.094563924142;5349.518543331119;5381.865453363697;4783.473817880031;4818.903621927542;4853.635977301646;4887;4893.143699852511;6663.800085997428;6665.233498147678;6756.864862702719;6767.864642707217;6767.93232067673;6909.170899492093;7004.824879377954;7124.323189297009;7266.019087423236;7280.745173918887;6651.434628056572;6725.865482690417;6726.764563240361;6739.5619284746335;6748.460123190133;5961.761529538857;5979.611325263844;6042.456178943916;6077.513798896078;6080.969595151996;7107.928920710727;7443.367313778282;7451.888221676679;7509.849803003909;7543.207963163789;7109.407417653036;7182.748603798842;7301.488895777245;7304.452166087671;7309.817254568466;7396.593187374746;7401.185869554452;7418.109826820601;7425.740099096506;7506.699732010658;6794.694238759366;7089.7873063808165;7142.071530700976;7151.892721609284;7209.6034718091005;7109.111361079865;7250.564966102051;7287.963560182166;7315.378192853667;7326.9267307326245;6968.930310697031;6984.546004509691;6991.056207412138;7058.788236352918;7062.964685176541;6829.69266383004;6959.095317608679;6961.477889158232;7047.295270472911;7067.611281379368;6876.037354770437;6877.105976223259;6896.7586134485055;6900.378965893094;6901.75843845463;6987.755428559976;6989.930100698928;7027.508074434741;7042.542234754725;7056.823579410556;6737.59574425536;6770.5599136056;6815.114035175396;6842.384185423336;6869.313068693091 13:00:24 INFO - PID 30247 | |1;ext.html;969.2778879734599;979.4857699707652;1011.0445628880708;1032.3135115148427;1041.3283432186236;44228;46250.537494625125;46251.30623040653;46265.7686711566;46520.76739616301;43733.56266437335;43752;43820;43868.341974870404;43944.78027609865;8064.758057258292;8191.631376588038;8216.21945915137;8228.876566851503;8236.958815205915;8054.556999365032;8072.394570407214;8146.918530814675;8151.836963260761;8152.18478152186;8717.259032982203;8919.286457083417;8931.151540603632;8937.731868043937;8958.417702849294;8841.38110332277;8885.067067957836;8886.422382545179;8899.288056955427;8909.242714369255;8772.254358379545;8822.647094116228;8829.867551986725;8838;8840.955795220983;43414.782926085485;43795.343069853974;43813.34279985771;43826.12347753027;43880.3417948731;3380.8647654093807;3438.346714124308;3440.2431465077893;3441.1397150712323;3458.6714262145056;35223.823880880685;35229.823850880835;35256.471152932725;35257.82371088128;35308.64691353079;4841.661083724141;4868;4877.780499877478;4922.33548470959;4927.728974906378;232494;233663;233799;233936;234646;53790.46209537933;53807.73096134494;54023.18965215525;54071;54078.459215408126;57937.4206257932;57997.13004304939;58081.419185808445;58125;58221.126683099785;18767.90616046938;19002.71495927562;19042.143103560375;19118.71321930172;19123.043847807556;15576.766348504781;15609.3756249751;15665.373385064699;15803.209839508208;15820.129892856003;15040.247987600576;15155.545333640008;15173.620659483602;15260.465883694018;15507.612309692122;6017.247844019497;6130.846728831726;6139.355367686418;6261.342559031236;6325.9051114233325;1133.7392399748105;1137.089052026814;1144.2905398652888;1151.7005578549638;1158.2760774515928;26528.867355663097;26548.734512654628;26759.598606020925;26920.057797976977;27004.594931076048;1237.8947789437998;1273.7388835288743;1274.8278982337265;1277.067740549404;1284.0177264392746;13882.305884705926;14150.150990940576;14216.857831421761;14301.57095287143;14363.497277595234;300847;315667;321770;326498;326652;64467.67766161233;64599.35400645933;64986.35013649803;65358.673206634616;65459;1559.5633222697663;1563.7263478891148;1582.082392212537;1588.7140314743458;1590.5784966983526;32272.677273226967;32410.513842292858;32693;32730;33127.503087453224;43859.12281754411;44181.77909110434;44194.11611767682;44229.77885110554;44270.77864610656;276291;276588;277729;278013;279809;38402.23195536018;38834.223315534095;38851.6114838848;39158;39209;48980.75509622429;50388.74805625949;50842.74578627231;51420;51488.742556286976;36003.27993440064;36241.63758362383;36478.27043459169;36638;37268.81365593263;35957.64042359543;36017.45973810447;36667.63332366749;36823.26353472862;36851.447228292134;41940.37089443722;43041;43117.784411078996;43197;43786;34948.12629684278;35358.292834143685;35436.82281588575;35470.29059418849;36583.26833463262;26264.8686756565;26589.202323930313;26597.468050639265;26909.461810764067;27218.047368342013 13:00:24 INFO - PID 30247 | |2;jquery.html;619.2197830733278;633.4520639646702;646.6152639179686;651.9282878883323;660.2704012066665;23681.881590592024;24404.877975610118;25070.749292507047;25073.49853002941;25075.37311567212;25148.74851251487;26062.73937260627;26159.607605885878;26320.473590528178;26344;6697.397234248917;7013;7141.2501687322865;7194.604296763676;7202.891956620655;6846.110005699252;6901.792946211596;6921.100256966587;6922.653867306614;6929.09921710177;6813;6815.284395138513;6837.247902730695;6846.075779769742;6882.449404047689;6835.14560679915;6845.315468453165;6869.553479023873;6886.380225779654;6889.7588584399555;6397;6418.5507014509;6428.228612566475;6441.742330306782;6448.581312111328;30884.8455757722;31256.21859453509;31799.682003179903;32013.359732805446;32020.519692204634;1997.990010049955;2009.4674911148556;2020.1616329223355;2040.4082815983347;2042.0096253317129;19450.610987780165;19776.40670779879;19879.701804472945;19910.80089199104;19945.700814487795;2088.791120887914;2206.4042708468783;2250.718660167479;2257.4356410897276;2274.4882401459704;146036;150927;155188;163539;170318;15843.920780396254;15970.76043859343;16090.597735056717;16161.59596010109;17315.740263896052;26817;26957;26978.86510567474;27083;27097.322566935985;11454.14093942941;11716.062714982781;11760.176787624956;11815.586454474053;11909.22590031645;10859.83710244347;10863.83704244437;10874.782504349869;10915.617953371593;11030.944845275722;9781.46201958885;9941.502924853872;10018.699439016842;10053.944335844777;10137;2802.5936239245193;2810.4800611886867;2899.7233126567266;2949.5428208627695;2975.479291124088;1051.4900273367412;1079.816431206681;1081.2647399768234;1083.875354334246;1086.32104934416;22086.558268834535;22269;22285.44286392821;22326.776732232796;22845.31464056081;1125.352922069813;1129.853119094529;1135.137295655308;1141.14414189358;1143.4682872464177;12001.759964800654;12134.635960921187;12179.269243845398;12285;12393.752124957451;597951;616946;617341;618880;626282;128004;131239.34380328038;132868;133394;134306;1142.7714457108445;1247.5009996001672;1260.4517035089766;1280.1998750780763;1310.1549500572269;23186.304410867702;23229.883850580638;23431.179908703114;23534.646980294965;23550.175743848882;64058;64144;64731.67634161799;66023;67036;79588.60205698934;79870.60064699639;80223;80260;81250.18749812426;16170.110643914228;16354;16494.505164845075;16529.33882644729;16613.418530351864;25145.24564263075;25247.49505009853;25402.237932862045;25459.490810184063;25463.36341591475;20448.59102817965;20609.175632974515;20830.583388332452;20902.895485522477;21114.472138196666;18257.178426970553;18317.450476485727;18620.16209270559;18673.253069877053;18830.811691883453;20582.27962021322;20785.376438706862;20822.27122050721;20926.37220883376;21000.36998890036;15909.52271431859;15942.60143496422;15976.121313327414;15984.881058325805;16041.438549650706;20391.79608203899;20502.487437814176;20629;20714.275000375517;20800.47998800042 13:00:24 INFO - PID 30247 | |3;mootools.html;1431.2986636548092;1463.7584798508246;1471.1386353542364;1494.7608382658777;1495.4317359403428;17196.91401542992;17782.199801008952;17806;17820.108994550268;17869.64260714785;17494.65010699785;17533.736993945102;17599.296028158857;17630.82369176308;17632.294708211688;3153.3062726200315;3196.824174670392;3267.2158681916408;3268.8365581720936;3270.296886169473;3034.5599888016222;3091.381723655267;3107.471729805927;3107.580476635659;3111.6888311168814;3072.0015994801665;3133.7493000559903;3255.5604993325833;3256;3257.315963647625;3170.492721164614;3180.586523751909;3185.824779637119;3199.7760156789036;3219.3400352927592;3058.571799948009;3059.4187104450084;3079.1224501017327;3083.753299736016;3084.167274835804;16958.830411695973;17320.220590073477;17358.3056677734;17404;17423.73864392035;8945.821083578358;9352.345335826494;9405.529723513866;9407.20038796703;9436.905630943671;5884.440978107073;6044.909326360108;6187.845303867394;6189.876202475925;6206.348333425016;1869.1775618727715;1912.7322174895526;1920.4142736465371;1952.463072655017;1965.4496740912568;31817.204569885707;31833.84083079593;32094.518582221284;32228.838855805807;32239.194020149684;7713.3443657288635;7801.2198780121535;7846.9215307847335;8025.916501272371;8300.543470109202;20513.48716282075;20540.07569659369;20547.075381607865;20553.38339849807;20580.897095514425;8923.286137109015;9054.411463254868;9059;9065.77335566616;9067.637294508279;8062.475939064059;8256.669733210725;8263.132371101068;8308.916910830936;8327.791805204919;6139.171211886427;6361.777337793155;6374.362563743589;6490.967545162244;6615.040819081206;1711.5036639374441;1746.1705689797245;1774.9556261093317;1827.2782251010776;1890.0360815983947;913.55235934393;935.3966691483955;939.7462685075128;947.4362754161263;949.4872768704822;10169.23730720199;10319.587216511405;10364.896351036545;10373.377597344184;10477.31897426665;1080.2762149359949;1117.1732917640886;1117.4859564600213;1123.07346439188;1123.9438028098562;5206.8437946860895;5239.685618862881;5248.527632513092;5600.635958662674;6271.153394291712;26143.477130457286;26438.074667386933;26472.8676356617;26571;26860;25406;26874.5968810468;26900.59649105265;26912.865435673088;27027.189184324503;12184.208026478427;12297.754044919231;12323.445444955;12413.93793031029;12414.75170496585;9854.901450985399;9914.851277230991;9947.353422027545;9984.201263898725;10160.847587286049;22274.55450890941;22275.888620556794;22429.32712018642;22655.88672056629;22846.200382986517;22723.772762272827;22796;22847.771522284565;23025.424364391023;23167.6524852124;12693.111482196158;12973.870261297643;12976.221426714428;13001.089923705627;13024.283664398548;15952.042877427391;16052.117133557766;16123.596910077342;16182.757258640895;16233.51299461018;12871.09902306867;12954.352282386031;13118.803217951547;13334.39995200199;13340.733185336045;12659.367031648197;12712.110152289251;12756.972111553785;12802.935985320013;13237.602871913858;11165.218434709492;11256.324620522468;11320.660380188607;11333.206675532634;11334.149938754792;8340.79058536521;8421.32629389635;8427.283680887193;8472.703455379033;8602.39783215169;8623;8702.738917832476;8732.270828972862;8735.388522803343;8937.28501719848 13:00:24 INFO - PID 30247 | |4;prototype.html;561.9157126431037;568.9800856970007;589.6609449566499;602.3344204653857;617.2315467243283;6350.333215012421;6353.777617783378;6359.71381287842;6423.9721644536885;6477.287498375175;6325.83708145927;6419.454346380563;6420.229572451301;6454.806355809334;6484;5154.737089413099;5415.404305526389;5416.187571864212;5426.372088373492;5434.673919564839;5222.556082732972;5225.947740522584;5249.816256431026;5264.42091369949;5266.157414813631;5177.974110129444;5190.636655434121;5210.296609957645;5244.1347177715825;5247.816326428557;5149;5191.818286359997;5207.583393328525;5227.085260079471;5236.764345604419;4725.31482934976;4804.327394164819;4817.7591120444185;4817.927731084036;4827.637927155442;6338.714757835908;6424.678766061678;6444.388902774306;6450.709718062699;6550.279469258426;6023.969880150615;6056.788012419544;6072.696365181723;6119.908201376983;6148.508119350441;6902.758403455855;6910.067140935959;6915.412189963859;6933.72265109395;6953.756618518328;5026.220935754964;5276.419593844674;5293.947060529384;5311.867203319909;5334.893302133935;7000.474964377692;7030.156381234285;7151.642417879085;7265.1645060818155;7269.236730143311;5431.701256430934;5456.454354564591;5465.262189604353;5466.180072989084;5475.616706830484;5514.255575497336;5566.66600003993;5571.498565129158;5579.107342825128;5603.943960560424;6123.050927106306;6143.754249829957;6149.754009839557;6171.166892469549;6188.783392581238;6962.512624116364;7022.438204943593;7029.4376449883885;7036.753713619999;7039.788806335818;1857.8420834229241;1892.2714754819494;1909.7039958806408;1914.7510823592843;1917.2618541861204;1326.3368315842079;1363.584106847421;1364.5428781358355;1381.281733498575;1383.2392184298596;6453.257875344396;6521.11964884744;6527.967360163168;6530.444912182517;6572.4084832365315;6914.204866440323;6932.306769323028;6938.410235130071;7045.365917067488;7063.223045464994;6418.807435776934;6492.35076492347;6504.674766261668;6551.639659818756;6572.441342485847;3664;3698;3713.350163721338;3715.7213209009433;3737.4020156775327;7224.530405523729;7311.939768733504;7375.336219740249;7410.703571857173;7415.5179913305465;7208.4593655475;7278.851054898657;7301.926980730231;7316.268373162641;7317.817054573678;7266.237045110187;7328.377087947478;7336.743213987592;7359.926400735924;7385.8153546161775;7005.509614326948;7023.789286321418;7071.328223818729;7081.858362832818;7132.251113632994;6954.965225173842;6996;7000.8949865753075;7021.279786452147;7055;7190.96404517974;7205.891911621225;7216.494845360774;7263.201047884623;7298.744543941149;5419.918701219406;5461.808836690697;5467.1958253775365;5471.8084867029465;5511.393746687781;6789.966050169717;6851.691673874588;7040.929590704232;7044.295570442915;7044.647767611701;6798.898016529657;6837.213720422215;6877.518573699993;6882.139732533434;6885.173779146535;6616.503762217949;6656.434203092791;6744.325567443217;6803;6828.556143850832;6516.934830651633;6565.638889860912;6599.142111525471;6723.562968407038;6726.8990965136545;6714.731410743516;6717.328267173243;6780.38976492118;6829.93170068293;6879.759208427681;6468.773592924225;6500.837479063061;6520.902186467112;6678.966605166943;6683.298253683488 13:00:24 INFO - PID 30247 | |5;yui.html;873.292632967297;876.2508055612456;885.1635204731529;896.6368620708611;902.941308814927;20759;21316.89341553292;21352.8932355338;21594.568108637817;21631;20383;20387.796122038777;21099.36701898942;21437.249696260635;21499.140034398606;1052.978940421193;1081.010875049329;1082.8484012238293;1083.9891601084007;1084.3927400655657;1064.4784055812675;1094.4473041114227;1098.2092893116942;1099.1591432554062;1102.509383324421;1181.651412833212;1183.769165012823;1184.567632814021;1185.1822242652586;1189.2151180221056;1170.1867202294452;1177.8704342522315;1179.9351035693032;1180.2741314091857;1181.8227265910095;865.0182043380745;866.0257210638032;869.3132425383939;870.277669534285;871.7123349294718;20646.793532064636;21172.25897093594;21325.786742132692;21415.678764818542;22205.666914996287;23697.526049478915;23697.881510592335;23771.524569508514;24115.397115072086;24120.87939560291;18923.337683181162;18967.81032189674;18979.145938432805;19071.90464047685;19183.808161918343;3744.4944932434046;3805.752626079324;3806.2958352704563;3814.408766641175;3814.4278358246206;161832.95417614537;162070.1896490522;162231.18884405622;162714;163139.1843040789;15975.12136832462;16226.513204603882;16240;16276.26756795947;16276.918615406847;33694.3261134776;35454.29091418157;35642;35767.64232357643;35794.82102589471;8668.91331086681;9126.771830704285;9203.953980230055;9231.938327092335;9238.214751746176;4907.312976183337;4982.950170498321;5000.849974500771;5003.074431230234;5017.573506251936;6429.678516074177;6493.2857385688485;6508.186476690414;6528.37980391862;6541.443977261986;1243.1670780577035;1249.175544140881;1267.6767424306743;1271.0340141492347;1274.388293619068;675.6284043775904;680.829792551862;693.9132608423947;695.401954319285;699.6641612026256;13295;14045.058858196022;14087;14731;14960.551183464513;664.3622122762106;665.6205962601367;666.2038863558001;667.5727534378002;680.8365992161945;6508.707108180143;6605.636689982001;6623.966880165568;6686.99695045747;6703.530752847351;148923;154162;154624.22687886714;159993.20003399908;160296;128251;130163.69836301706;130438;132306;136639;111503;112423;112437;114356;115520.42239788748;12538.310392928477;12592.370381480707;12624.11631185845;12629.684257893627;12706.428210730355;52301.47698522966;52809;53539.73230133824;53807.192892105864;53916.730416347666;67809.66095169492;69328.65335673289;70268;70804.64597676978;74125;18028.54928626795;18227.179776910336;18319.633607327512;18453.72319415183;18476.722849157006;18684.813151868308;18858.24567017304;18871.528211794815;18952.147153377857;18992.620147596695;18002.729959050364;18104.275828966693;18143;18362.724559131355;18516.16677249554;17275.568110796827;17525.21136548833;17614.207360669057;17730.73403898917;17883;17870.821291786917;18115.184816683017;18139.36512222119;18144.45566633003;18261.634767304313;13235.338233088114;13249;13434.395452204479;13439.328033598476;13526;13497.932510337385;13645.11306765057;13696.246706431242;13719.245441500812;13883.236421996484 13:00:24 INFO - PID 30247 | __end_tp_report 13:00:24 INFO - PID 30247 | __start_cc_report 13:00:24 INFO - PID 30247 | _x_x_mozilla_cycle_collect,253 13:00:24 INFO - PID 30247 | __end_cc_report 13:00:24 INFO - PID 30247 | __startTimestamp1506974424500__endTimestamp 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | ------- Summary: start ------- 13:00:24 INFO - PID 30247 | Number of tests: 6 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | [#0] dojo.html Cycles:165 Average:6632.92 Median:6876.04 stddev:774.85 (11.3%) stddev-sans-first:749.65 13:00:24 INFO - PID 30247 | Values: 4021.3 4026.7 4045.2 4071.0 4079.1 6537.0 6620.7 6647.8 6671.2 6681.3 6604.1 6606.5 6695.7 6699.5 6704.8 5927.8 5952.3 6029.5 6063.2 6064.2 5950.7 6022.1 6024.3 6025.4 6101.5 5931.1 5999.7 6004.6 6014.0 6015.9 5823.7 5936.6 5948.6 6009.2 6035.1 5774.7 5866.3 5897.6 5954.9 5960.6 6525.9 6611.7 6624.7 6631.2 6700.0 7135.8 7164.7 7169.3 7235.7 7257.2 7143.6 7164.1 7204.8 7209.7 7209.7 6609.3 6618.8 6632.2 6635.6 6711.5 7383.4 7401.2 7441.5 7486.3 7496.3 7072.3 7082.1 7094.5 7169.0 7177.9 7120.5 7201.4 7223.2 7301.1 7304.7 7115.6 7118.4 7198.1 7198.9 7209.9 7134.0 7143.3 7227.1 7229.3 7232.1 5286.9 5292.7 5326.1 5349.5 5381.9 4783.5 4818.9 4853.6 4887.0 4893.1 6663.8 6665.2 6756.9 6767.9 6767.9 6909.2 7004.8 7124.3 7266.0 7280.7 6651.4 6725.9 6726.8 6739.6 6748.5 5961.8 5979.6 6042.5 6077.5 6081.0 7107.9 7443.4 7451.9 7509.8 7543.2 7109.4 7182.7 7301.5 7304.5 7309.8 7396.6 7401.2 7418.1 7425.7 7506.7 6794.7 7089.8 7142.1 7151.9 7209.6 7109.1 7250.6 7288.0 7315.4 7326.9 6968.9 6984.5 6991.1 7058.8 7063.0 6829.7 6959.1 6961.5 7047.3 7067.6 6876.0 6877.1 6896.8 6900.4 6901.8 6987.8 6989.9 7027.5 7042.5 7056.8 6737.6 6770.6 6815.1 6842.4 6869.3 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | [#1] ext.html Cycles:180 Average:46479.49 Median:36837.36 stddev:72627.75 (197.2%) stddev-sans-first:72751.10 13:00:24 INFO - PID 30247 | Values: 969.3 979.5 1011.0 1032.3 1041.3 44228.0 46250.5 46251.3 46265.8 46520.8 43733.6 43752.0 43820.0 43868.3 43944.8 8064.8 8191.6 8216.2 8228.9 8237.0 8054.6 8072.4 8146.9 8151.8 8152.2 8717.3 8919.3 8931.2 8937.7 8958.4 8841.4 8885.1 8886.4 8899.3 8909.2 8772.3 8822.6 8829.9 8838.0 8841.0 43414.8 43795.3 43813.3 43826.1 43880.3 3380.9 3438.3 3440.2 3441.1 3458.7 35223.8 35229.8 35256.5 35257.8 35308.6 4841.7 4868.0 4877.8 4922.3 4927.7 232494.0 233663.0 233799.0 233936.0 234646.0 53790.5 53807.7 54023.2 54071.0 54078.5 57937.4 57997.1 58081.4 58125.0 58221.1 18767.9 19002.7 19042.1 19118.7 19123.0 15576.8 15609.4 15665.4 15803.2 15820.1 15040.2 15155.5 15173.6 15260.5 15507.6 6017.2 6130.8 6139.4 6261.3 6325.9 1133.7 1137.1 1144.3 1151.7 1158.3 26528.9 26548.7 26759.6 26920.1 27004.6 1237.9 1273.7 1274.8 1277.1 1284.0 13882.3 14150.2 14216.9 14301.6 14363.5 300847.0 315667.0 321770.0 326498.0 326652.0 64467.7 64599.4 64986.4 65358.7 65459.0 1559.6 1563.7 1582.1 1588.7 1590.6 32272.7 32410.5 32693.0 32730.0 33127.5 43859.1 44181.8 44194.1 44229.8 44270.8 276291.0 276588.0 277729.0 278013.0 279809.0 38402.2 38834.2 38851.6 39158.0 39209.0 48980.8 50388.7 50842.7 51420.0 51488.7 36003.3 36241.6 36478.3 36638.0 37268.8 35957.6 36017.5 36667.6 36823.3 36851.4 41940.4 43041.0 43117.8 43197.0 43786.0 34948.1 35358.3 35436.8 35470.3 36583.3 26264.9 26589.2 26597.5 26909.5 27218.0 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | [#2] jquery.html Cycles:180 Average:40827.37 Median:22177.78 stddev:103036.49 (464.6%) stddev-sans-first:103281.31 13:00:24 INFO - PID 30247 | Values: 619.2 633.5 646.6 651.9 660.3 23681.9 24404.9 25070.7 25073.5 25075.4 25148.7 26062.7 26159.6 26320.5 26344.0 6697.4 7013.0 7141.3 7194.6 7202.9 6846.1 6901.8 6921.1 6922.7 6929.1 6813.0 6815.3 6837.2 6846.1 6882.4 6835.1 6845.3 6869.6 6886.4 6889.8 6397.0 6418.6 6428.2 6441.7 6448.6 30884.8 31256.2 31799.7 32013.4 32020.5 1998.0 2009.5 2020.2 2040.4 2042.0 19450.6 19776.4 19879.7 19910.8 19945.7 2088.8 2206.4 2250.7 2257.4 2274.5 146036.0 150927.0 155188.0 163539.0 170318.0 15843.9 15970.8 16090.6 16161.6 17315.7 26817.0 26957.0 26978.9 27083.0 27097.3 11454.1 11716.1 11760.2 11815.6 11909.2 10859.8 10863.8 10874.8 10915.6 11030.9 9781.5 9941.5 10018.7 10053.9 10137.0 2802.6 2810.5 2899.7 2949.5 2975.5 1051.5 1079.8 1081.3 1083.9 1086.3 22086.6 22269.0 22285.4 22326.8 22845.3 1125.4 1129.9 1135.1 1141.1 1143.5 12001.8 12134.6 12179.3 12285.0 12393.8 597951.0 616946.0 617341.0 618880.0 626282.0 128004.0 131239.3 132868.0 133394.0 134306.0 1142.8 1247.5 1260.5 1280.2 1310.2 23186.3 23229.9 23431.2 23534.6 23550.2 64058.0 64144.0 64731.7 66023.0 67036.0 79588.6 79870.6 80223.0 80260.0 81250.2 16170.1 16354.0 16494.5 16529.3 16613.4 25145.2 25247.5 25402.2 25459.5 25463.4 20448.6 20609.2 20830.6 20902.9 21114.5 18257.2 18317.5 18620.2 18673.3 18830.8 20582.3 20785.4 20822.3 20926.4 21000.4 15909.5 15942.6 15976.1 15984.9 16041.4 20391.8 20502.5 20629.0 20714.3 20800.5 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | [#3] mootools.html Cycles:180 Average:10982.22 Median:26715.50 stddev:8080.12 (30.2%) stddev-sans-first:8070.92 13:00:24 INFO - PID 30247 | Values: 1431.3 1463.8 1471.1 1494.8 1495.4 17196.9 17782.2 17806.0 17820.1 17869.6 17494.7 17533.7 17599.3 17630.8 17632.3 3153.3 3196.8 3267.2 3268.8 3270.3 3034.6 3091.4 3107.5 3107.6 3111.7 3072.0 3133.7 3255.6 3256.0 3257.3 3170.5 3180.6 3185.8 3199.8 3219.3 3058.6 3059.4 3079.1 3083.8 3084.2 16958.8 17320.2 17358.3 17404.0 17423.7 8945.8 9352.3 9405.5 9407.2 9436.9 5884.4 6044.9 6187.8 6189.9 6206.3 1869.2 1912.7 1920.4 1952.5 1965.4 31817.2 31833.8 32094.5 32228.8 32239.2 7713.3 7801.2 7846.9 8025.9 8300.5 20513.5 20540.1 20547.1 20553.4 20580.9 8923.3 9054.4 9059.0 9065.8 9067.6 8062.5 8256.7 8263.1 8308.9 8327.8 6139.2 6361.8 6374.4 6491.0 6615.0 1711.5 1746.2 1775.0 1827.3 1890.0 913.6 935.4 939.7 947.4 949.5 10169.2 10319.6 10364.9 10373.4 10477.3 1080.3 1117.2 1117.5 1123.1 1123.9 5206.8 5239.7 5248.5 5600.6 6271.2 26143.5 26438.1 26472.9 26571.0 26860.0 25406.0 26874.6 26900.6 26912.9 27027.2 12184.2 12297.8 12323.4 12413.9 12414.8 9854.9 9914.9 9947.4 9984.2 10160.8 22274.6 22275.9 22429.3 22655.9 22846.2 22723.8 22796.0 22847.8 23025.4 23167.7 12693.1 12973.9 12976.2 13001.1 13024.3 15952.0 16052.1 16123.6 16182.8 16233.5 12871.1 12954.4 13118.8 13334.4 13340.7 12659.4 12712.1 12757.0 12802.9 13237.6 11165.2 11256.3 11320.7 11333.2 11334.1 8340.8 8421.3 8427.3 8472.7 8602.4 8623.0 8702.7 8732.3 8735.4 8937.3 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | [#4] prototype.html Cycles:180 Average:5875.23 Median:6480.64 stddev:1629.77 (25.1%) stddev-sans-first:1584.79 13:00:24 INFO - PID 30247 | Values: 561.9 569.0 589.7 602.3 617.2 6350.3 6353.8 6359.7 6424.0 6477.3 6325.8 6419.5 6420.2 6454.8 6484.0 5154.7 5415.4 5416.2 5426.4 5434.7 5222.6 5225.9 5249.8 5264.4 5266.2 5178.0 5190.6 5210.3 5244.1 5247.8 5149.0 5191.8 5207.6 5227.1 5236.8 4725.3 4804.3 4817.8 4817.9 4827.6 6338.7 6424.7 6444.4 6450.7 6550.3 6024.0 6056.8 6072.7 6119.9 6148.5 6902.8 6910.1 6915.4 6933.7 6953.8 5026.2 5276.4 5293.9 5311.9 5334.9 7000.5 7030.2 7151.6 7265.2 7269.2 5431.7 5456.5 5465.3 5466.2 5475.6 5514.3 5566.7 5571.5 5579.1 5603.9 6123.1 6143.8 6149.8 6171.2 6188.8 6962.5 7022.4 7029.4 7036.8 7039.8 1857.8 1892.3 1909.7 1914.8 1917.3 1326.3 1363.6 1364.5 1381.3 1383.2 6453.3 6521.1 6528.0 6530.4 6572.4 6914.2 6932.3 6938.4 7045.4 7063.2 6418.8 6492.4 6504.7 6551.6 6572.4 3664.0 3698.0 3713.4 3715.7 3737.4 7224.5 7311.9 7375.3 7410.7 7415.5 7208.5 7278.9 7301.9 7316.3 7317.8 7266.2 7328.4 7336.7 7359.9 7385.8 7005.5 7023.8 7071.3 7081.9 7132.3 6955.0 6996.0 7000.9 7021.3 7055.0 7191.0 7205.9 7216.5 7263.2 7298.7 5419.9 5461.8 5467.2 5471.8 5511.4 6790.0 6851.7 7040.9 7044.3 7044.6 6798.9 6837.2 6877.5 6882.1 6885.2 6616.5 6656.4 6744.3 6803.0 6828.6 6516.9 6565.6 6599.1 6723.6 6726.9 6714.7 6717.3 6780.4 6829.9 6879.8 6468.8 6500.8 6520.9 6679.0 6683.3 13:00:24 INFO - PID 30247 | 13:00:24 INFO - PID 30247 | [#5] yui.html Cycles:180 Average:28596.97 Median:18771.53 stddev:42777.46 (227.9%) stddev-sans-first:42846.81 13:00:24 INFO - PID 30247 | Values: 873.3 876.3 885.2 896.6 902.9 20759.0 21316.9 21352.9 21594.6 21631.0 20383.0 20387.8 21099.4 21437.2 21499.1 1053.0 1081.0 1082.8 1084.0 1084.4 1064.5 1094.4 1098.2 1099.2 1102.5 1181.7 1183.8 1184.6 1185.2 1189.2 1170.2 1177.9 1179.9 1180.3 1181.8 865.0 866.0 869.3 870.3 871.7 20646.8 21172.3 21325.8 21415.7 22205.7 23697.5 23697.9 23771.5 24115.4 24120.9 18923.3 18967.8 18979.1 19071.9 19183.8 3744.5 3805.8 3806.3 3814.4 3814.4 161833.0 162070.2 162231.2 162714.0 163139.2 15975.1 16226.5 16240.0 16276.3 16276.9 33694.3 35454.3 35642.0 35767.6 35794.8 8668.9 9126.8 9204.0 9231.9 9238.2 4907.3 4983.0 5000.8 5003.1 5017.6 6429.7 6493.3 6508.2 6528.4 6541.4 1243.2 1249.2 1267.7 1271.0 1274.4 675.6 680.8 693.9 695.4 699.7 13295.0 14045.1 14087.0 14731.0 14960.6 664.4 665.6 666.2 667.6 680.8 6508.7 6605.6 6624.0 6687.0 6703.5 148923.0 154162.0 154624.2 159993.2 160296.0 128251.0 130163.7 130438.0 132306.0 136639.0 111503.0 112423.0 112437.0 114356.0 115520.4 12538.3 12592.4 12624.1 12629.7 12706.4 52301.5 52809.0 53539.7 53807.2 53916.7 67809.7 69328.7 70268.0 70804.6 74125.0 18028.5 18227.2 18319.6 18453.7 18476.7 18684.8 18858.2 18871.5 18952.1 18992.6 18002.7 18104.3 18143.0 18362.7 18516.2 17275.6 17525.2 17614.2 17730.7 17883.0 17870.8 18115.2 18139.4 18144.5 18261.6 13235.3 13249.0 13434.4 13439.3 13526.0 13497.9 13645.1 13696.2 13719.2 13883.2 13:00:24 INFO - PID 30247 | -------- Summary: end -------- 13:00:24 INFO - PID 30247 | 13:00:25 INFO - TEST-INFO | 30247: exit 0 13:00:25 INFO - TEST-OK | dromaeo_css | took 1106972ms 13:00:25 INFO - TEST-START | kraken 13:00:25 INFO - Initialising browser for kraken test... 13:00:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33445/getInfo.html -profile /tmp/tmpJJEWrx/profile 13:00:25 INFO - TEST-INFO | started process 30613 (/builds/slave/test/build/application/firefox/firefox http://localhost:33445/getInfo.html) 13:00:30 INFO - TEST-INFO | 30613: exit 0 13:00:30 INFO - Browser initialized. 13:00:30 INFO - Running cycle 1/1 for kraken test... 13:00:30 INFO - Using env: {'DISPLAY': ':0', 13:00:30 INFO - 'HOME': '/home/cltbld', 13:00:30 INFO - 'JSGC_DISABLE_POISONING': '1', 13:00:30 INFO - 'LANG': 'en_US.UTF-8', 13:00:30 INFO - 'LANGUAGE': 'en_US:en', 13:00:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:00:30 INFO - 'LOGNAME': 'cltbld', 13:00:30 INFO - 'MAIL': '/var/mail/cltbld', 13:00:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:00:30 INFO - 'MOZ_CRASHREPORTER': '1', 13:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:00:30 INFO - 'MOZ_NO_REMOTE': '1', 13:00:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:30 INFO - 'NO_EM_RESTART': '1', 13:00:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:30 INFO - 'PWD': '/builds/slave/test', 13:00:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:30 INFO - 'RUST_BACKTRACE': 'full', 13:00:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:00:30 INFO - 'SHELL': '/bin/bash', 13:00:30 INFO - 'SHLVL': '1', 13:00:30 INFO - 'TERM': 'linux', 13:00:30 INFO - 'TMOUT': '86400', 13:00:30 INFO - 'USER': 'cltbld', 13:00:30 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046', 13:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:30 INFO - '_': '/tools/buildbot/bin/python'} 13:00:30 INFO - TEST-INFO | started process 30849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJEWrx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:31 INFO - PID 30849 | 13:00:31 INFO - PID 30849 | (/builds/slave/test/build/application/firefox/firefox:30898): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:00:31 INFO - PID 30849 | 13:00:41 INFO - PID 30849 | RSS: Main: 141094912 13:00:41 INFO - PID 30849 | 13:00:44 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33445/tests/kraken/driver.html?testName=audio-beat-detection) 13:00:44 INFO - PID 30849 | RSS: Main: 147460096 13:00:44 INFO - PID 30849 | 13:00:47 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33445/tests/kraken/driver.html?testName=audio-dft) 13:00:48 INFO - PID 30849 | RSS: Main: 147513344 13:00:48 INFO - PID 30849 | 13:00:50 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33445/tests/kraken/driver.html?testName=audio-fft) 13:00:51 INFO - PID 30849 | RSS: Main: 149282816 13:00:51 INFO - PID 30849 | 13:00:53 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33445/tests/kraken/driver.html?testName=audio-oscillator) 13:00:54 INFO - PID 30849 | RSS: Main: 149676032 13:00:54 INFO - PID 30849 | 13:00:56 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33445/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:00:56 INFO - PID 30849 | RSS: Main: 149114880 13:00:56 INFO - PID 30849 | 13:00:59 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33445/tests/kraken/driver.html?testName=imaging-darkroom) 13:01:00 INFO - PID 30849 | RSS: Main: 148979712 13:01:00 INFO - PID 30849 | 13:01:03 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33445/tests/kraken/driver.html?testName=imaging-desaturate) 13:01:04 INFO - PID 30849 | RSS: Main: 150573056 13:01:04 INFO - PID 30849 | 13:01:07 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33445/tests/kraken/driver.html?testName=json-parse-financial) 13:01:07 INFO - PID 30849 | RSS: Main: 151511040 13:01:07 INFO - PID 30849 | 13:01:09 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33445/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:01:10 INFO - PID 30849 | RSS: Main: 151580672 13:01:10 INFO - PID 30849 | 13:01:11 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:01:12 INFO - PID 30849 | RSS: Main: 152522752 13:01:12 INFO - PID 30849 | 13:01:14 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:01:14 INFO - PID 30849 | RSS: Main: 149217280 13:01:14 INFO - PID 30849 | 13:01:17 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:01:17 INFO - PID 30849 | RSS: Main: 149024768 13:01:17 INFO - PID 30849 | 13:01:20 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:01:20 INFO - PID 30849 | RSS: Main: 149467136 13:01:20 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | Cycle 1(1): loaded http://localhost:33445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33445/tests/kraken/driver.html?testName=ai-astar) 13:01:22 INFO - PID 30849 | RSS: Main: 150573056 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | __start_tp_report 13:01:22 INFO - PID 30849 | _x_x_mozilla_page_load 13:01:22 INFO - PID 30849 | _x_x_mozilla_page_load_details 13:01:22 INFO - PID 30849 | |i|pagename|runs| 13:01:22 INFO - PID 30849 | |0;ai-astar;105;104;106;105;106;98;107;106;104;106 13:01:22 INFO - PID 30849 | |1;audio-beat-detection;114;114;113;110;112;140;109;113;111;115 13:01:22 INFO - PID 30849 | |2;audio-dft;163;162;162;162;160;162;162;162;162;162 13:01:22 INFO - PID 30849 | |3;audio-fft;76;74;74;73;81;75;74;73;74;73 13:01:22 INFO - PID 30849 | |4;audio-oscillator;78;78;78;77;78;76;77;77;78;84 13:01:22 INFO - PID 30849 | |5;imaging-gaussian-blur;114;115;110;114;114;114;114;114;114;116 13:01:22 INFO - PID 30849 | |6;imaging-darkroom;150;148;149;148;149;149;148;147;148;148 13:01:22 INFO - PID 30849 | |7;imaging-desaturate;100;94;95;95;94;94;95;94;97;93 13:01:22 INFO - PID 30849 | |8;json-parse-financial;45;44;45;43;45;44;43;44;44;44 13:01:22 INFO - PID 30849 | |9;json-stringify-tinderbox;38;37;38;38;37;38;38;37;38;38 13:01:22 INFO - PID 30849 | |10;stanford-crypto-aes;70;73;68;71;69;71;68;70;68;69 13:01:22 INFO - PID 30849 | |11;stanford-crypto-ccm;111;101;103;118;104;102;102;102;101;105 13:01:22 INFO - PID 30849 | |12;stanford-crypto-pbkdf2;145;145;149;152;144;147;145;147;149;149 13:01:22 INFO - PID 30849 | |13;stanford-crypto-sha256-iterative;60;60;59;60;63;59;60;63;62;61 13:01:22 INFO - PID 30849 | __end_tp_report 13:01:22 INFO - PID 30849 | __start_cc_report 13:01:22 INFO - PID 30849 | _x_x_mozilla_cycle_collect,675 13:01:22 INFO - PID 30849 | __end_cc_report 13:01:22 INFO - PID 30849 | __startTimestamp1506974482880__endTimestamp 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | ------- Summary: start ------- 13:01:22 INFO - PID 30849 | Number of tests: 14 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#0] ai-astar Cycles:10 Average:104.70 Median:106.00 stddev:2.54 (2.4%) stddev-sans-first:2.69 13:01:22 INFO - PID 30849 | Values: 105.0 104.0 106.0 105.0 106.0 98.0 107.0 106.0 104.0 106.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:113.50 stddev:8.95 (7.9%) stddev-sans-first:9.48 13:01:22 INFO - PID 30849 | Values: 114.0 114.0 113.0 110.0 112.0 140.0 109.0 113.0 111.0 115.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 13:01:22 INFO - PID 30849 | Values: 163.0 162.0 162.0 162.0 160.0 162.0 162.0 162.0 162.0 162.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#3] audio-fft Cycles:10 Average:74.70 Median:74.00 stddev:2.41 (3.3%) stddev-sans-first:2.51 13:01:22 INFO - PID 30849 | Values: 76.0 74.0 74.0 73.0 81.0 75.0 74.0 73.0 74.0 73.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:2.18 (2.8%) stddev-sans-first:2.32 13:01:22 INFO - PID 30849 | Values: 78.0 78.0 78.0 77.0 78.0 76.0 77.0 77.0 78.0 84.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 13:01:22 INFO - PID 30849 | Values: 114.0 115.0 110.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 13:01:22 INFO - PID 30849 | Values: 150.0 148.0 149.0 148.0 149.0 149.0 148.0 147.0 148.0 148.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:2.02 (2.1%) stddev-sans-first:1.13 13:01:22 INFO - PID 30849 | Values: 100.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 97.0 93.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.00 stddev:0.74 (1.7%) stddev-sans-first:0.71 13:01:22 INFO - PID 30849 | Values: 45.0 44.0 45.0 43.0 45.0 44.0 43.0 44.0 44.0 44.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 13:01:22 INFO - PID 30849 | Values: 38.0 37.0 38.0 38.0 37.0 38.0 38.0 37.0 38.0 38.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#10] stanford-crypto-aes Cycles:10 Average:69.70 Median:70.00 stddev:1.64 (2.3%) stddev-sans-first:1.73 13:01:22 INFO - PID 30849 | Values: 70.0 73.0 68.0 71.0 69.0 71.0 68.0 70.0 68.0 69.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#11] stanford-crypto-ccm Cycles:10 Average:104.90 Median:103.50 stddev:5.47 (5.3%) stddev-sans-first:5.33 13:01:22 INFO - PID 30849 | Values: 111.0 101.0 103.0 118.0 104.0 102.0 102.0 102.0 101.0 105.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:148.00 stddev:2.53 (1.7%) stddev-sans-first:2.55 13:01:22 INFO - PID 30849 | Values: 145.0 145.0 149.0 152.0 144.0 147.0 145.0 147.0 149.0 149.0 13:01:22 INFO - PID 30849 | 13:01:22 INFO - PID 30849 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:60.50 stddev:1.49 (2.5%) stddev-sans-first:1.56 13:01:22 INFO - PID 30849 | Values: 60.0 60.0 59.0 60.0 63.0 59.0 60.0 63.0 62.0 61.0 13:01:22 INFO - PID 30849 | -------- Summary: end -------- 13:01:22 INFO - PID 30849 | 13:01:23 INFO - PID 30849 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:01:23 INFO - TEST-INFO | 30849: exit 0 13:01:23 INFO - TEST-OK | kraken | took 58429ms 13:01:23 INFO - SUITE-END | took 1165s 13:01:23 INFO - Completed test suite (00:19:25) 13:01:23 INFO - javascript benchmark 13:01:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9461.364936138969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4021.2560676274893, 4026.738262012969, 4045.1909618076374, 4070.979645101774, 4079.0822065035354, 6537.0, 6620.702068406921, 6647.833804154899, 6671.199456065279, 6681.26506084331, 6604.108445359875, 6606.471482281418, 6695.732170713166, 6699.464042876558, 6704.765333213339, 5927.792527261558, 5952.285725712921, 6029.547783916224, 6063.242094738158, 6064.241969753781, 5950.672713000783, 6022.096685497188, 6024.2770867495965, 6025.367336429677, 6101.481374083208, 5931.139984702238, 5999.700014999255, 6004.579679422421, 6014.0, 6015.879682406349, 5823.708814559255, 5936.584439089265, 5948.613340132878, 6009.1587177795145, 6035.124906888498, 5774.711264436762, 5866.325372582165, 5897.587168898179, 5954.8809023819285, 5960.552958528127, 6525.93474065258, 6611.735530578771, 6624.735010599618, 6631.171103612049, 6700.0, 7135.82160445993, 7164.677589508485, 7169.318914703095, 7235.746748863817, 7257.165425976027, 7143.607101609461, 7164.140303163602, 7204.783856484314, 7209.747658831916, 7209.747658831968, 6609.272979972151, 6618.834529136762, 6632.237292711352, 6635.601863888182, 6711.496637752188, 7383.446241531799, 7401.222871598405, 7441.479096463304, 7486.288802563748, 7496.287852653989, 7072.257412971564, 7082.079329687211, 7094.53885497441, 7168.964155179191, 7177.856442871218, 7120.465965052642, 7201.387882030086, 7223.205447400782, 7301.123865136217, 7304.707811687579, 7115.608641524663, 7118.394936430358, 7198.100237470317, 7198.892016619755, 7209.927900721031, 7134.0, 7143.321384468467, 7227.096612923385, 7229.277072292729, 7232.0959880015, 5286.867828304246, 5292.708901010481, 5326.094563924142, 5349.518543331119, 5381.865453363697, 4783.473817880031, 4818.903621927542, 4853.635977301646, 4887.0, 4893.143699852511, 6663.800085997428, 6665.233498147678, 6756.864862702719, 6767.864642707217, 6767.93232067673, 6909.170899492093, 7004.824879377954, 7124.323189297009, 7266.019087423236, 7280.745173918887, 6651.434628056572, 6725.865482690417, 6726.764563240361, 6739.5619284746335, 6748.460123190133, 5961.761529538857, 5979.611325263844, 6042.456178943916, 6077.513798896078, 6080.969595151996, 7107.928920710727, 7443.367313778282, 7451.888221676679, 7509.849803003909, 7543.207963163789, 7109.407417653036, 7182.748603798842, 7301.488895777245, 7304.452166087671, 7309.817254568466, 7396.593187374746, 7401.185869554452, 7418.109826820601, 7425.740099096506, 7506.699732010658, 6794.694238759366, 7089.7873063808165, 7142.071530700976, 7151.892721609284, 7209.6034718091005, 7109.111361079865, 7250.564966102051, 7287.963560182166, 7315.378192853667, 7326.9267307326245, 6968.930310697031, 6984.546004509691, 6991.056207412138, 7058.788236352918, 7062.964685176541, 6829.69266383004, 6959.095317608679, 6961.477889158232, 7047.295270472911, 7067.611281379368, 6876.037354770437, 6877.105976223259, 6896.7586134485055, 6900.378965893094, 6901.75843845463, 6987.755428559976, 6989.930100698928, 7027.508074434741, 7042.542234754725, 7056.823579410556, 6737.59574425536, 6770.5599136056, 6815.114035175396, 6842.384185423336, 6869.313068693091], "value": 6580.87228655511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.2778879734599, 979.4857699707652, 1011.0445628880708, 1032.3135115148427, 1041.3283432186236, 44228.0, 46250.537494625125, 46251.30623040653, 46265.7686711566, 46520.76739616301, 43733.56266437335, 43752.0, 43820.0, 43868.341974870404, 43944.78027609865, 8064.758057258292, 8191.631376588038, 8216.21945915137, 8228.876566851503, 8236.958815205915, 8054.556999365032, 8072.394570407214, 8146.918530814675, 8151.836963260761, 8152.18478152186, 8717.259032982203, 8919.286457083417, 8931.151540603632, 8937.731868043937, 8958.417702849294, 8841.38110332277, 8885.067067957836, 8886.422382545179, 8899.288056955427, 8909.242714369255, 8772.254358379545, 8822.647094116228, 8829.867551986725, 8838.0, 8840.955795220983, 43414.782926085485, 43795.343069853974, 43813.34279985771, 43826.12347753027, 43880.3417948731, 3380.8647654093807, 3438.346714124308, 3440.2431465077893, 3441.1397150712323, 3458.6714262145056, 35223.823880880685, 35229.823850880835, 35256.471152932725, 35257.82371088128, 35308.64691353079, 4841.661083724141, 4868.0, 4877.780499877478, 4922.33548470959, 4927.728974906378, 232494.0, 233663.0, 233799.0, 233936.0, 234646.0, 53790.46209537933, 53807.73096134494, 54023.18965215525, 54071.0, 54078.459215408126, 57937.4206257932, 57997.13004304939, 58081.419185808445, 58125.0, 58221.126683099785, 18767.90616046938, 19002.71495927562, 19042.143103560375, 19118.71321930172, 19123.043847807556, 15576.766348504781, 15609.3756249751, 15665.373385064699, 15803.209839508208, 15820.129892856003, 15040.247987600576, 15155.545333640008, 15173.620659483602, 15260.465883694018, 15507.612309692122, 6017.247844019497, 6130.846728831726, 6139.355367686418, 6261.342559031236, 6325.9051114233325, 1133.7392399748105, 1137.089052026814, 1144.2905398652888, 1151.7005578549638, 1158.2760774515928, 26528.867355663097, 26548.734512654628, 26759.598606020925, 26920.057797976977, 27004.594931076048, 1237.8947789437998, 1273.7388835288743, 1274.8278982337265, 1277.067740549404, 1284.0177264392746, 13882.305884705926, 14150.150990940576, 14216.857831421761, 14301.57095287143, 14363.497277595234, 300847.0, 315667.0, 321770.0, 326498.0, 326652.0, 64467.67766161233, 64599.35400645933, 64986.35013649803, 65358.673206634616, 65459.0, 1559.5633222697663, 1563.7263478891148, 1582.082392212537, 1588.7140314743458, 1590.5784966983526, 32272.677273226967, 32410.513842292858, 32693.0, 32730.0, 33127.503087453224, 43859.12281754411, 44181.77909110434, 44194.11611767682, 44229.77885110554, 44270.77864610656, 276291.0, 276588.0, 277729.0, 278013.0, 279809.0, 38402.23195536018, 38834.223315534095, 38851.6114838848, 39158.0, 39209.0, 48980.75509622429, 50388.74805625949, 50842.74578627231, 51420.0, 51488.742556286976, 36003.27993440064, 36241.63758362383, 36478.27043459169, 36638.0, 37268.81365593263, 35957.64042359543, 36017.45973810447, 36667.63332366749, 36823.26353472862, 36851.447228292134, 41940.37089443722, 43041.0, 43117.784411078996, 43197.0, 43786.0, 34948.12629684278, 35358.292834143685, 35436.82281588575, 35470.29059418849, 36583.26833463262, 26264.8686756565, 26589.202323930313, 26597.468050639265, 26909.461810764067, 27218.047368342013], "value": 19681.76534804659, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.2197830733278, 633.4520639646702, 646.6152639179686, 651.9282878883323, 660.2704012066665, 23681.881590592024, 24404.877975610118, 25070.749292507047, 25073.49853002941, 25075.37311567212, 25148.74851251487, 26062.73937260627, 26159.607605885878, 26320.473590528178, 26344.0, 6697.397234248917, 7013.0, 7141.2501687322865, 7194.604296763676, 7202.891956620655, 6846.110005699252, 6901.792946211596, 6921.100256966587, 6922.653867306614, 6929.09921710177, 6813.0, 6815.284395138513, 6837.247902730695, 6846.075779769742, 6882.449404047689, 6835.14560679915, 6845.315468453165, 6869.553479023873, 6886.380225779654, 6889.7588584399555, 6397.0, 6418.5507014509, 6428.228612566475, 6441.742330306782, 6448.581312111328, 30884.8455757722, 31256.21859453509, 31799.682003179903, 32013.359732805446, 32020.519692204634, 1997.990010049955, 2009.4674911148556, 2020.1616329223355, 2040.4082815983347, 2042.0096253317129, 19450.610987780165, 19776.40670779879, 19879.701804472945, 19910.80089199104, 19945.700814487795, 2088.791120887914, 2206.4042708468783, 2250.718660167479, 2257.4356410897276, 2274.4882401459704, 146036.0, 150927.0, 155188.0, 163539.0, 170318.0, 15843.920780396254, 15970.76043859343, 16090.597735056717, 16161.59596010109, 17315.740263896052, 26817.0, 26957.0, 26978.86510567474, 27083.0, 27097.322566935985, 11454.14093942941, 11716.062714982781, 11760.176787624956, 11815.586454474053, 11909.22590031645, 10859.83710244347, 10863.83704244437, 10874.782504349869, 10915.617953371593, 11030.944845275722, 9781.46201958885, 9941.502924853872, 10018.699439016842, 10053.944335844777, 10137.0, 2802.5936239245193, 2810.4800611886867, 2899.7233126567266, 2949.5428208627695, 2975.479291124088, 1051.4900273367412, 1079.816431206681, 1081.2647399768234, 1083.875354334246, 1086.32104934416, 22086.558268834535, 22269.0, 22285.44286392821, 22326.776732232796, 22845.31464056081, 1125.352922069813, 1129.853119094529, 1135.137295655308, 1141.14414189358, 1143.4682872464177, 12001.759964800654, 12134.635960921187, 12179.269243845398, 12285.0, 12393.752124957451, 597951.0, 616946.0, 617341.0, 618880.0, 626282.0, 128004.0, 131239.34380328038, 132868.0, 133394.0, 134306.0, 1142.7714457108445, 1247.5009996001672, 1260.4517035089766, 1280.1998750780763, 1310.1549500572269, 23186.304410867702, 23229.883850580638, 23431.179908703114, 23534.646980294965, 23550.175743848882, 64058.0, 64144.0, 64731.67634161799, 66023.0, 67036.0, 79588.60205698934, 79870.60064699639, 80223.0, 80260.0, 81250.18749812426, 16170.110643914228, 16354.0, 16494.505164845075, 16529.33882644729, 16613.418530351864, 25145.24564263075, 25247.49505009853, 25402.237932862045, 25459.490810184063, 25463.36341591475, 20448.59102817965, 20609.175632974515, 20830.583388332452, 20902.895485522477, 21114.472138196666, 18257.178426970553, 18317.450476485727, 18620.16209270559, 18673.253069877053, 18830.811691883453, 20582.27962021322, 20785.376438706862, 20822.27122050721, 20926.37220883376, 21000.36998890036, 15909.52271431859, 15942.60143496422, 15976.121313327414, 15984.881058325805, 16041.438549650706, 20391.79608203899, 20502.487437814176, 20629.0, 20714.275000375517, 20800.47998800042], "value": 13161.528245388283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.2986636548092, 1463.7584798508246, 1471.1386353542364, 1494.7608382658777, 1495.4317359403428, 17196.91401542992, 17782.199801008952, 17806.0, 17820.108994550268, 17869.64260714785, 17494.65010699785, 17533.736993945102, 17599.296028158857, 17630.82369176308, 17632.294708211688, 3153.3062726200315, 3196.824174670392, 3267.2158681916408, 3268.8365581720936, 3270.296886169473, 3034.5599888016222, 3091.381723655267, 3107.471729805927, 3107.580476635659, 3111.6888311168814, 3072.0015994801665, 3133.7493000559903, 3255.5604993325833, 3256.0, 3257.315963647625, 3170.492721164614, 3180.586523751909, 3185.824779637119, 3199.7760156789036, 3219.3400352927592, 3058.571799948009, 3059.4187104450084, 3079.1224501017327, 3083.753299736016, 3084.167274835804, 16958.830411695973, 17320.220590073477, 17358.3056677734, 17404.0, 17423.73864392035, 8945.821083578358, 9352.345335826494, 9405.529723513866, 9407.20038796703, 9436.905630943671, 5884.440978107073, 6044.909326360108, 6187.845303867394, 6189.876202475925, 6206.348333425016, 1869.1775618727715, 1912.7322174895526, 1920.4142736465371, 1952.463072655017, 1965.4496740912568, 31817.204569885707, 31833.84083079593, 32094.518582221284, 32228.838855805807, 32239.194020149684, 7713.3443657288635, 7801.2198780121535, 7846.9215307847335, 8025.916501272371, 8300.543470109202, 20513.48716282075, 20540.07569659369, 20547.075381607865, 20553.38339849807, 20580.897095514425, 8923.286137109015, 9054.411463254868, 9059.0, 9065.77335566616, 9067.637294508279, 8062.475939064059, 8256.669733210725, 8263.132371101068, 8308.916910830936, 8327.791805204919, 6139.171211886427, 6361.777337793155, 6374.362563743589, 6490.967545162244, 6615.040819081206, 1711.5036639374441, 1746.1705689797245, 1774.9556261093317, 1827.2782251010776, 1890.0360815983947, 913.55235934393, 935.3966691483955, 939.7462685075128, 947.4362754161263, 949.4872768704822, 10169.23730720199, 10319.587216511405, 10364.896351036545, 10373.377597344184, 10477.31897426665, 1080.2762149359949, 1117.1732917640886, 1117.4859564600213, 1123.07346439188, 1123.9438028098562, 5206.8437946860895, 5239.685618862881, 5248.527632513092, 5600.635958662674, 6271.153394291712, 26143.477130457286, 26438.074667386933, 26472.8676356617, 26571.0, 26860.0, 25406.0, 26874.5968810468, 26900.59649105265, 26912.865435673088, 27027.189184324503, 12184.208026478427, 12297.754044919231, 12323.445444955, 12413.93793031029, 12414.75170496585, 9854.901450985399, 9914.851277230991, 9947.353422027545, 9984.201263898725, 10160.847587286049, 22274.55450890941, 22275.888620556794, 22429.32712018642, 22655.88672056629, 22846.200382986517, 22723.772762272827, 22796.0, 22847.771522284565, 23025.424364391023, 23167.6524852124, 12693.111482196158, 12973.870261297643, 12976.221426714428, 13001.089923705627, 13024.283664398548, 15952.042877427391, 16052.117133557766, 16123.596910077342, 16182.757258640895, 16233.51299461018, 12871.09902306867, 12954.352282386031, 13118.803217951547, 13334.39995200199, 13340.733185336045, 12659.367031648197, 12712.110152289251, 12756.972111553785, 12802.935985320013, 13237.602871913858, 11165.218434709492, 11256.324620522468, 11320.660380188607, 11333.206675532634, 11334.149938754792, 8340.79058536521, 8421.32629389635, 8427.283680887193, 8472.703455379033, 8602.39783215169, 8623.0, 8702.738917832476, 8732.270828972862, 8735.388522803343, 8937.28501719848], "value": 7729.479139973275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9157126431037, 568.9800856970007, 589.6609449566499, 602.3344204653857, 617.2315467243283, 6350.333215012421, 6353.777617783378, 6359.71381287842, 6423.9721644536885, 6477.287498375175, 6325.83708145927, 6419.454346380563, 6420.229572451301, 6454.806355809334, 6484.0, 5154.737089413099, 5415.404305526389, 5416.187571864212, 5426.372088373492, 5434.673919564839, 5222.556082732972, 5225.947740522584, 5249.816256431026, 5264.42091369949, 5266.157414813631, 5177.974110129444, 5190.636655434121, 5210.296609957645, 5244.1347177715825, 5247.816326428557, 5149.0, 5191.818286359997, 5207.583393328525, 5227.085260079471, 5236.764345604419, 4725.31482934976, 4804.327394164819, 4817.7591120444185, 4817.927731084036, 4827.637927155442, 6338.714757835908, 6424.678766061678, 6444.388902774306, 6450.709718062699, 6550.279469258426, 6023.969880150615, 6056.788012419544, 6072.696365181723, 6119.908201376983, 6148.508119350441, 6902.758403455855, 6910.067140935959, 6915.412189963859, 6933.72265109395, 6953.756618518328, 5026.220935754964, 5276.419593844674, 5293.947060529384, 5311.867203319909, 5334.893302133935, 7000.474964377692, 7030.156381234285, 7151.642417879085, 7265.1645060818155, 7269.236730143311, 5431.701256430934, 5456.454354564591, 5465.262189604353, 5466.180072989084, 5475.616706830484, 5514.255575497336, 5566.66600003993, 5571.498565129158, 5579.107342825128, 5603.943960560424, 6123.050927106306, 6143.754249829957, 6149.754009839557, 6171.166892469549, 6188.783392581238, 6962.512624116364, 7022.438204943593, 7029.4376449883885, 7036.753713619999, 7039.788806335818, 1857.8420834229241, 1892.2714754819494, 1909.7039958806408, 1914.7510823592843, 1917.2618541861204, 1326.3368315842079, 1363.584106847421, 1364.5428781358355, 1381.281733498575, 1383.2392184298596, 6453.257875344396, 6521.11964884744, 6527.967360163168, 6530.444912182517, 6572.4084832365315, 6914.204866440323, 6932.306769323028, 6938.410235130071, 7045.365917067488, 7063.223045464994, 6418.807435776934, 6492.35076492347, 6504.674766261668, 6551.639659818756, 6572.441342485847, 3664.0, 3698.0, 3713.350163721338, 3715.7213209009433, 3737.4020156775327, 7224.530405523729, 7311.939768733504, 7375.336219740249, 7410.703571857173, 7415.5179913305465, 7208.4593655475, 7278.851054898657, 7301.926980730231, 7316.268373162641, 7317.817054573678, 7266.237045110187, 7328.377087947478, 7336.743213987592, 7359.926400735924, 7385.8153546161775, 7005.509614326948, 7023.789286321418, 7071.328223818729, 7081.858362832818, 7132.251113632994, 6954.965225173842, 6996.0, 7000.8949865753075, 7021.279786452147, 7055.0, 7190.96404517974, 7205.891911621225, 7216.494845360774, 7263.201047884623, 7298.744543941149, 5419.918701219406, 5461.808836690697, 5467.1958253775365, 5471.8084867029465, 5511.393746687781, 6789.966050169717, 6851.691673874588, 7040.929590704232, 7044.295570442915, 7044.647767611701, 6798.898016529657, 6837.213720422215, 6877.518573699993, 6882.139732533434, 6885.173779146535, 6616.503762217949, 6656.434203092791, 6744.325567443217, 6803.0, 6828.556143850832, 6516.934830651633, 6565.638889860912, 6599.142111525471, 6723.562968407038, 6726.8990965136545, 6714.731410743516, 6717.328267173243, 6780.38976492118, 6829.93170068293, 6879.759208427681, 6468.773592924225, 6500.837479063061, 6520.902186467112, 6678.966605166943, 6683.298253683488], "value": 5407.954834675329, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.292632967297, 876.2508055612456, 885.1635204731529, 896.6368620708611, 902.941308814927, 20759.0, 21316.89341553292, 21352.8932355338, 21594.568108637817, 21631.0, 20383.0, 20387.796122038777, 21099.36701898942, 21437.249696260635, 21499.140034398606, 1052.978940421193, 1081.010875049329, 1082.8484012238293, 1083.9891601084007, 1084.3927400655657, 1064.4784055812675, 1094.4473041114227, 1098.2092893116942, 1099.1591432554062, 1102.509383324421, 1181.651412833212, 1183.769165012823, 1184.567632814021, 1185.1822242652586, 1189.2151180221056, 1170.1867202294452, 1177.8704342522315, 1179.9351035693032, 1180.2741314091857, 1181.8227265910095, 865.0182043380745, 866.0257210638032, 869.3132425383939, 870.277669534285, 871.7123349294718, 20646.793532064636, 21172.25897093594, 21325.786742132692, 21415.678764818542, 22205.666914996287, 23697.526049478915, 23697.881510592335, 23771.524569508514, 24115.397115072086, 24120.87939560291, 18923.337683181162, 18967.81032189674, 18979.145938432805, 19071.90464047685, 19183.808161918343, 3744.4944932434046, 3805.752626079324, 3806.2958352704563, 3814.408766641175, 3814.4278358246206, 161832.95417614537, 162070.1896490522, 162231.18884405622, 162714.0, 163139.1843040789, 15975.12136832462, 16226.513204603882, 16240.0, 16276.26756795947, 16276.918615406847, 33694.3261134776, 35454.29091418157, 35642.0, 35767.64232357643, 35794.82102589471, 8668.91331086681, 9126.771830704285, 9203.953980230055, 9231.938327092335, 9238.214751746176, 4907.312976183337, 4982.950170498321, 5000.849974500771, 5003.074431230234, 5017.573506251936, 6429.678516074177, 6493.2857385688485, 6508.186476690414, 6528.37980391862, 6541.443977261986, 1243.1670780577035, 1249.175544140881, 1267.6767424306743, 1271.0340141492347, 1274.388293619068, 675.6284043775904, 680.829792551862, 693.9132608423947, 695.401954319285, 699.6641612026256, 13295.0, 14045.058858196022, 14087.0, 14731.0, 14960.551183464513, 664.3622122762106, 665.6205962601367, 666.2038863558001, 667.5727534378002, 680.8365992161945, 6508.707108180143, 6605.636689982001, 6623.966880165568, 6686.99695045747, 6703.530752847351, 148923.0, 154162.0, 154624.22687886714, 159993.20003399908, 160296.0, 128251.0, 130163.69836301706, 130438.0, 132306.0, 136639.0, 111503.0, 112423.0, 112437.0, 114356.0, 115520.42239788748, 12538.310392928477, 12592.370381480707, 12624.11631185845, 12629.684257893627, 12706.428210730355, 52301.47698522966, 52809.0, 53539.73230133824, 53807.192892105864, 53916.730416347666, 67809.66095169492, 69328.65335673289, 70268.0, 70804.64597676978, 74125.0, 18028.54928626795, 18227.179776910336, 18319.633607327512, 18453.72319415183, 18476.722849157006, 18684.813151868308, 18858.24567017304, 18871.528211794815, 18952.147153377857, 18992.620147596695, 18002.729959050364, 18104.275828966693, 18143.0, 18362.724559131355, 18516.16677249554, 17275.568110796827, 17525.21136548833, 17614.207360669057, 17730.73403898917, 17883.0, 17870.821291786917, 18115.184816683017, 18139.36512222119, 18144.45566633003, 18261.634767304313, 13235.338233088114, 13249.0, 13434.395452204479, 13439.328033598476, 13526.0, 13497.932510337385, 13645.11306765057, 13696.246706431242, 13719.245441500812, 13883.236421996484], "value": 10066.079801885135, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1356.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 106.0, 105.0, 106.0, 98.0, 107.0, 106.0, 104.0, 106.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 110.0, 112.0, 140.0, 109.0, 113.0, 111.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 160.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 73.0, 81.0, 75.0, 74.0, 73.0, 74.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 78.0, 76.0, 77.0, 77.0, 78.0, 84.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 148.0, 149.0, 149.0, 148.0, 147.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 97.0, 93.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 45.0, 43.0, 45.0, 44.0, 43.0, 44.0, 44.0, 44.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 68.0, 71.0, 69.0, 71.0, 68.0, 70.0, 68.0, 69.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 101.0, 103.0, 118.0, 104.0, 102.0, 102.0, 102.0, 101.0, 105.0], "value": 104.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 149.0, 152.0, 144.0, 147.0, 145.0, 147.0, 149.0, 149.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 63.0, 59.0, 60.0, 63.0, 62.0, 61.0], "value": 60.7, "unit": "score"}]}]} 13:01:23 INFO - Return code: 0 13:01:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:01:23 INFO - # TBPL SUCCESS # 13:01:23 INFO - Running post-action listener: _package_coverage_data 13:01:23 INFO - Running post-action listener: _resource_record_post_action 13:01:23 INFO - [mozharness: 2017-10-02 20:01:23.677083Z] Finished run-tests step (success) 13:01:23 INFO - Running post-run listener: _resource_record_post_run 13:01:23 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282365952; Read time: 20; Write time: 133848 13:01:23 INFO - TinderboxPrint: CPU usage
13.0% 13:01:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 13:01:23 INFO - TinderboxPrint: I/O write bytes / time
282,365,952 / 133,848 13:01:23 INFO - TinderboxPrint: CPU idle
8,181.4 (86.9%) 13:01:23 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 13:01:23 INFO - TinderboxPrint: Swap in / out
0 / 0 13:01:23 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8863744; Read time: 0; Write time: 1412 13:01:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:01:23 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 273055744; Read time: 20; Write time: 132412 13:01:24 INFO - Running post-run listener: _upload_blobber_files 13:01:24 INFO - Blob upload gear active. 13:01:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:01:24 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 13:01:24 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:01:24 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:01:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:32 INFO - (blobuploader) - INFO - Done attempting. 13:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:01:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:33 INFO - (blobuploader) - INFO - Done attempting. 13:01:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:01:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:01:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:34 INFO - (blobuploader) - INFO - Done attempting. 13:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:35 INFO - (blobuploader) - INFO - Done attempting. 13:01:35 INFO - (blobuploader) - INFO - Iteration through files over. 13:01:35 INFO - Return code: 0 13:01:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:01:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:01:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/48b6970809f785e45e86301ca5c7ac7bc7f6fd558cfaa42eea8a0ccb18e6198a04a9c2ae6f262afff42d6e84f7375e30906ed1ed0f5f52d5ec61cff33d62b166", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8f54f6ec405bbaed96ecc1eaf38d4771eac0f0b73ddff59917880affbe7f362020d2eb8cb69234f0a71815591d92dffc8e574ac11c3d4508f19011e511ddc61d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3fd6d2178e74184ee80e6a991206ac3cd41683f304207ad524a4940ed142b370fcec5c616923ffcf4c45902866f7a8329104e943a1c27646b9a3e11e0c7eb3a4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/533b1fa41610fcca04ac56897a35ec104007f2cedb3284bb4cfadee504e6b5452ca4284a24073951a0095df286a775cd4b9639f99331c127acc6602d1319520b"} 13:01:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:01:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:01:35 INFO - Contents: 13:01:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/48b6970809f785e45e86301ca5c7ac7bc7f6fd558cfaa42eea8a0ccb18e6198a04a9c2ae6f262afff42d6e84f7375e30906ed1ed0f5f52d5ec61cff33d62b166", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8f54f6ec405bbaed96ecc1eaf38d4771eac0f0b73ddff59917880affbe7f362020d2eb8cb69234f0a71815591d92dffc8e574ac11c3d4508f19011e511ddc61d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3fd6d2178e74184ee80e6a991206ac3cd41683f304207ad524a4940ed142b370fcec5c616923ffcf4c45902866f7a8329104e943a1c27646b9a3e11e0c7eb3a4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/533b1fa41610fcca04ac56897a35ec104007f2cedb3284bb4cfadee504e6b5452ca4284a24073951a0095df286a775cd4b9639f99331c127acc6602d1319520b"} 13:01:35 INFO - Running post-run listener: copy_logs_to_upload_dir 13:01:35 INFO - Copying logs to upload dir... 13:01:35 INFO - mkdir: /builds/slave/test/build/upload/logs 13:01:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.817332 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-10-02 13:01:35.596279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 13:01:35.603912) ========= 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=199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/48b6970809f785e45e86301ca5c7ac7bc7f6fd558cfaa42eea8a0ccb18e6198a04a9c2ae6f262afff42d6e84f7375e30906ed1ed0f5f52d5ec61cff33d62b166", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8f54f6ec405bbaed96ecc1eaf38d4771eac0f0b73ddff59917880affbe7f362020d2eb8cb69234f0a71815591d92dffc8e574ac11c3d4508f19011e511ddc61d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3fd6d2178e74184ee80e6a991206ac3cd41683f304207ad524a4940ed142b370fcec5c616923ffcf4c45902866f7a8329104e943a1c27646b9a3e11e0c7eb3a4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/533b1fa41610fcca04ac56897a35ec104007f2cedb3284bb4cfadee504e6b5452ca4284a24073951a0095df286a775cd4b9639f99331c127acc6602d1319520b"} build_url:https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/EBOOpXnDSySSY5KUwVu83A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/48b6970809f785e45e86301ca5c7ac7bc7f6fd558cfaa42eea8a0ccb18e6198a04a9c2ae6f262afff42d6e84f7375e30906ed1ed0f5f52d5ec61cff33d62b166", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8f54f6ec405bbaed96ecc1eaf38d4771eac0f0b73ddff59917880affbe7f362020d2eb8cb69234f0a71815591d92dffc8e574ac11c3d4508f19011e511ddc61d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3fd6d2178e74184ee80e6a991206ac3cd41683f304207ad524a4940ed142b370fcec5c616923ffcf4c45902866f7a8329104e943a1c27646b9a3e11e0c7eb3a4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/533b1fa41610fcca04ac56897a35ec104007f2cedb3284bb4cfadee504e6b5452ca4284a24073951a0095df286a775cd4b9639f99331c127acc6602d1319520b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 13:01:35.635616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 13:01:35.635957) ========= 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=199fb4c72b90437b990b419b000001c5-1506972612.707458-191462046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 13:01:35.717679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 13:01:35.718011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 13:01:35.718307) ========= ========= Total master_lag: 0.36 =========