builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-004 starttime: 1506119436.21 results: success (0) revision: 61e58a7d800b8a84d3da7c3db977830e206428a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.205434) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.205885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.206154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.223783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.224162) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 15:30:36-- 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% 92.4M=0s 2017-09-22 15:30:36 (92.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.366773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.367180) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016066 ========= master_lag: 0.37 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.755042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:36.755428) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 61e58a7d800b8a84d3da7c3db977830e206428a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 61e58a7d800b8a84d3da7c3db977830e206428a3 --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=c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 15:30:36,703 truncating revision to first 12 chars 2017-09-22 15:30:36,703 Setting DEBUG logging. 2017-09-22 15:30:36,703 attempt 1/10 2017-09-22 15:30:36,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/61e58a7d800b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 15:30:37,120 unpacking tar archive at: mozilla-central-61e58a7d800b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.739800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:37.517924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:37.518326) ========= script_repo_revision: 61e58a7d800b8a84d3da7c3db977830e206428a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:37.518736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:37.518991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 15:30:37.533287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-22 15:30:37.533703) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:37 INFO - MultiFileLogger online at 20170922 15:30:37 in /builds/slave/test 15:30:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:30:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:37 INFO - {'append_to_log': False, 15:30:37 INFO - 'base_work_dir': '/builds/slave/test', 15:30:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:30:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:37 INFO - 'branch': 'Firefox-Non-PGO', 15:30:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:37 INFO - 'code_coverage': False, 15:30:37 INFO - 'config_files': ('talos/linux_config.py',), 15:30:37 INFO - 'default_actions': ('clobber', 15:30:37 INFO - 'read-buildbot-config', 15:30:37 INFO - 'download-and-extract', 15:30:37 INFO - 'populate-webroot', 15:30:37 INFO - 'create-virtualenv', 15:30:37 INFO - 'install', 15:30:37 INFO - 'setup-mitmproxy', 15:30:37 INFO - 'run-tests'), 15:30:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:37 INFO - 'disable_ccov_upload': False, 15:30:37 INFO - 'disable_stylo': False, 15:30:37 INFO - 'download_minidump_stackwalk': True, 15:30:37 INFO - 'download_symbols': 'ondemand', 15:30:37 INFO - 'enable_stylo': False, 15:30:37 INFO - 'enable_webrender': False, 15:30:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:30:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:37 INFO - 'gecko_profile': False, 15:30:37 INFO - 'gecko_profile_interval': 0, 15:30:37 INFO - 'installer_path': 'installer.exe', 15:30:37 INFO - 'log_level': 'info', 15:30:37 INFO - 'log_name': 'talos', 15:30:37 INFO - 'log_to_console': True, 15:30:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:37 INFO - 'opt_config_files': (), 15:30:37 INFO - 'pip_index': False, 15:30:37 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:30:37 INFO - 'system_bits': '32', 15:30:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:37 INFO - 'title': 'talos-linux64-ix-004', 15:30:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:37 INFO - 'use_talos_json': True, 15:30:37 INFO - 'verify': 'False', 15:30:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:37 INFO - 'work_dir': 'build'} 15:30:37 INFO - [mozharness: 2017-09-22 22:30:37.613273Z] Running clobber step. 15:30:37 INFO - Running pre-action listener: _resource_record_pre_action 15:30:37 INFO - Running main action method: clobber 15:30:37 INFO - rmtree: /builds/slave/test/build 15:30:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:38 INFO - Running post-action listener: _resource_record_post_action 15:30:38 INFO - [mozharness: 2017-09-22 22:30:38.672956Z] Finished clobber step (success) 15:30:38 INFO - [mozharness: 2017-09-22 22:30:38.673054Z] Running read-buildbot-config step. 15:30:38 INFO - Running pre-action listener: _resource_record_pre_action 15:30:38 INFO - Running main action method: read_buildbot_config 15:30:38 INFO - Using buildbot properties: 15:30:38 INFO - { 15:30:38 INFO - "project": "", 15:30:38 INFO - "product": "firefox", 15:30:38 INFO - "who": "kwierso@gmail.com", 15:30:38 INFO - "installer_path": "public/build/target.tar.bz2", 15:30:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:30:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:30:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:30:38 INFO - "stage_platform": "linux64", 15:30:38 INFO - "basedir": "/builds/slave/test", 15:30:38 INFO - "buildnumber": 59, 15:30:38 INFO - "platform": "ubuntu64_hw", 15:30:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:30:38 INFO - "slavebuilddir": "test", 15:30:38 INFO - "taskId": "OU2BiC4mTjet2nEIcSkqcg", 15:30:38 INFO - "branch": "mozilla-central", 15:30:38 INFO - "script_repo_revision": "production", 15:30:38 INFO - "revision": "61e58a7d800b8a84d3da7c3db977830e206428a3", 15:30:38 INFO - "slavename": "talos-linux64-ix-004", 15:30:38 INFO - "repo_path": "mozilla-central" 15:30:38 INFO - } 15:30:38 INFO - Finding installer, test and symbols from parent task. 15:30:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OU2BiC4mTjet2nEIcSkqcg'}, attempt #1 15:30:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OU2BiC4mTjet2nEIcSkqcg'}, attempt #1 15:30:39 INFO - Task dependencies: e1Vm0nnPTMG3de0u1_1tzQ 15:30:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ'}, attempt #1 15:30:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2 15:30:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.test_packages.json 15:30:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.crashreporter-symbols.zip 15:30:40 INFO - Running post-action listener: _resource_record_post_action 15:30:40 INFO - [mozharness: 2017-09-22 22:30:40.021486Z] Finished read-buildbot-config step (success) 15:30:40 INFO - [mozharness: 2017-09-22 22:30:40.021705Z] Running download-and-extract step. 15:30:40 INFO - Running pre-action listener: _resource_record_pre_action 15:30:40 INFO - Running main action method: download_and_extract 15:30:40 INFO - mkdir: /builds/slave/test/build/tests 15:30: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')]} 15:30:40 INFO - trying https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.test_packages.json 15:30:40 INFO - Downloading https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:30:40 INFO - Downloaded 989 bytes. 15:30:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:30:40 INFO - Using the following test package requirements: 15:30:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:30:40 INFO - u'common': [u'target.common.tests.zip'], 15:30:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:30:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:30:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:30:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:30:40 INFO - u'mozbase': [u'target.common.tests.zip'], 15:30:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:30:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:30:40 INFO - u'web-platform': [u'target.common.tests.zip', 15:30:40 INFO - u'target.web-platform.tests.tar.gz'], 15:30:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:30:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:30:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.common.tests.zip 15:30:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:30:40 INFO - Fetch https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.common.tests.zip into memory 15:30:41 INFO - Content-Length response header: 54892611 15:30:41 INFO - Bytes received: 54892611 15:30:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.talos.tests.zip 15:30:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:30:52 INFO - Fetch https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.talos.tests.zip into memory 15:30:53 INFO - Content-Length response header: 14513823 15:30:53 INFO - Bytes received: 14513823 15:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:53 INFO - trying https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2 15:30:53 INFO - Downloading https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:30:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:30:54 INFO - Downloaded 61644940 bytes. 15:30:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2 15:30:54 INFO - mkdir: /builds/slave/test/properties 15:30:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:54 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:54 INFO - Contents: 15:30:54 INFO - build_url:https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2 15:30:54 INFO - Running post-action listener: _resource_record_post_action 15:30:54 INFO - Running post-action listener: find_tests_for_verification 15:30:54 INFO - Running post-action listener: set_extra_try_arguments 15:30:54 INFO - [mozharness: 2017-09-22 22:30:54.516790Z] Finished download-and-extract step (success) 15:30:54 INFO - [mozharness: 2017-09-22 22:30:54.516885Z] Running populate-webroot step. 15:30:54 INFO - Running pre-action listener: _resource_record_pre_action 15:30:54 INFO - Running main action method: populate_webroot 15:30:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['tresize', 15:30:54 INFO - 'tcanvasmark']}, 15:30:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['dromaeo_css', 15:30:54 INFO - 'kraken']}, 15:30:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'tests': ['damp', 'tps']}, 15:30:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['damp', 'tps']}, 15:30:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['dromaeo_dom']}, 15:30:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:30:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['basic_compositor_video', 15:30:54 INFO - 'glvideo']}, 15:30:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:30:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['ts_paint_webext', 15:30:54 INFO - 'tp5o_webext']}, 15:30:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_many_windows', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_many_windows', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:30:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:30:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['perf_reftest_singletons']}, 15:30:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['perf_reftest']}, 15:30:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:54 INFO - 'tsvgr_opacity', 15:30:54 INFO - 'tart', 15:30:54 INFO - 'tscrollx', 15:30:54 INFO - 'tsvg_static']}, 15:30:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['tsvgx', 15:30:54 INFO - 'tsvgr_opacity', 15:30:54 INFO - 'tart', 15:30:54 INFO - 'tscrollx', 15:30:54 INFO - 'tsvg_static']}, 15:30:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:30:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-stylo'], 15:30:54 INFO - 'tests': ['tp5o']}, 15:30:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:30:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:30:54 INFO - 'talos_options': ['--mitmproxy', 15:30:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:30:54 INFO - '--firstNonBlankPaint'], 15:30:54 INFO - 'tests': ['tp6_google', 15:30:54 INFO - 'tp6_youtube', 15:30:54 INFO - 'tp6_amazon', 15:30:54 INFO - 'tp6_facebook']}, 15:30:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:30:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:30:54 INFO - 'talos_options': ['--disable-stylo', 15:30:54 INFO - '--mitmproxy', 15:30:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:30:54 INFO - '--firstNonBlankPaint'], 15:30:54 INFO - 'tests': ['tp6_google', 15:30:54 INFO - 'tp6_youtube', 15:30:54 INFO - 'tp6_amazon', 15:30:54 INFO - 'tp6_facebook']}, 15:30:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:30:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:30:54 INFO - 'talos_options': ['--stylo-threads=1', 15:30:54 INFO - '--mitmproxy', 15:30:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:30:54 INFO - '--firstNonBlankPaint'], 15:30:54 INFO - 'tests': ['tp6_google', 15:30:54 INFO - 'tp6_youtube', 15:30:54 INFO - 'tp6_amazon', 15:30:54 INFO - 'tp6_facebook']}, 15:30:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'talos_options': ['--xperf_path', 15:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:54 INFO - 'tests': ['tp5n']}, 15:30:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-stylo', 15:30:54 INFO - '--xperf_path', 15:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:54 INFO - 'tests': ['tp5n']}}} 15:30:54 INFO - Running post-action listener: _resource_record_post_action 15:30:54 INFO - [mozharness: 2017-09-22 22:30:54.532177Z] Finished populate-webroot step (success) 15:30:54 INFO - [mozharness: 2017-09-22 22:30:54.532267Z] Running create-virtualenv step. 15:30:54 INFO - Running pre-action listener: _resource_record_pre_action 15:30:54 INFO - Running main action method: create_virtualenv 15:30:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:30:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:30:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:30:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:55 INFO - Installing pip...............done. 15:30:55 INFO - Return code: 0 15:30:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:30:55 INFO - Reading from file tmpfile_stdout 15:30:55 INFO - Output received: 15:30:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:30:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:55 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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:30:55 INFO - Using env: {'DISPLAY': ':0', 15:30:55 INFO - 'HOME': '/home/cltbld', 15:30:55 INFO - 'LANG': 'en_US.UTF-8', 15:30:55 INFO - 'LANGUAGE': 'en_US:en', 15:30:55 INFO - 'LOGNAME': 'cltbld', 15:30:55 INFO - 'MAIL': '/var/mail/cltbld', 15:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:55 INFO - 'MOZ_NO_REMOTE': '1', 15:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:55 INFO - 'NO_EM_RESTART': '1', 15:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:55 INFO - 'PWD': '/builds/slave/test', 15:30:55 INFO - 'SHELL': '/bin/bash', 15:30:55 INFO - 'SHLVL': '1', 15:30:55 INFO - 'TERM': 'linux', 15:30:55 INFO - 'TMOUT': '86400', 15:30:55 INFO - 'USER': 'cltbld', 15:30:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:55 INFO - '_': '/tools/buildbot/bin/python'} 15:30:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:30:56 INFO - Downloading/unpacking pip>=1.5 15:30:56 INFO - Running setup.py egg_info for package pip 15:30:56 INFO - warning: no files found matching 'pip/cacert.pem' 15:30:56 INFO - warning: no files found matching '*.html' under directory 'docs' 15:30:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:30:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:30:56 INFO - Installing collected packages: pip 15:30:56 INFO - Found existing installation: pip 1.1 15:30:56 INFO - Uninstalling pip: 15:30:56 INFO - Successfully uninstalled pip 15:30:56 INFO - Running setup.py install for pip 15:30:56 INFO - warning: no files found matching 'pip/cacert.pem' 15:30:56 INFO - warning: no files found matching '*.html' under directory 'docs' 15:30:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:30:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:30:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:30:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:30:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:30:56 INFO - Successfully installed pip 15:30:56 INFO - Cleaning up... 15:30:56 INFO - Return code: 0 15:30:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:56 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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:30:56 INFO - Using env: {'DISPLAY': ':0', 15:30:56 INFO - 'HOME': '/home/cltbld', 15:30:56 INFO - 'LANG': 'en_US.UTF-8', 15:30:56 INFO - 'LANGUAGE': 'en_US:en', 15:30:56 INFO - 'LOGNAME': 'cltbld', 15:30:56 INFO - 'MAIL': '/var/mail/cltbld', 15:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:56 INFO - 'MOZ_NO_REMOTE': '1', 15:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:56 INFO - 'NO_EM_RESTART': '1', 15:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:56 INFO - 'PWD': '/builds/slave/test', 15:30:56 INFO - 'SHELL': '/bin/bash', 15:30:56 INFO - 'SHLVL': '1', 15:30:56 INFO - 'TERM': 'linux', 15:30:56 INFO - 'TMOUT': '86400', 15:30:56 INFO - 'USER': 'cltbld', 15:30:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:56 INFO - '_': '/tools/buildbot/bin/python'} 15:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:56 INFO - Downloading/unpacking psutil>=3.1.1 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:58 INFO - Installing collected packages: psutil 15:30:58 INFO - Running setup.py install for psutil 15:30:58 INFO - building 'psutil._psutil_linux' extension 15:30:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:30:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:30:58 INFO - building 'psutil._psutil_posix' extension 15:30:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:30:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:58 INFO - Successfully installed psutil 15:30:58 INFO - Cleaning up... 15:30:58 INFO - Return code: 0 15:30:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:30:58 INFO - Using env: {'DISPLAY': ':0', 15:30:58 INFO - 'HOME': '/home/cltbld', 15:30:58 INFO - 'LANG': 'en_US.UTF-8', 15:30:58 INFO - 'LANGUAGE': 'en_US:en', 15:30:58 INFO - 'LOGNAME': 'cltbld', 15:30:58 INFO - 'MAIL': '/var/mail/cltbld', 15:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:58 INFO - 'MOZ_NO_REMOTE': '1', 15:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:58 INFO - 'NO_EM_RESTART': '1', 15:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:58 INFO - 'PWD': '/builds/slave/test', 15:30:58 INFO - 'SHELL': '/bin/bash', 15:30:58 INFO - 'SHLVL': '1', 15:30:58 INFO - 'TERM': 'linux', 15:30:58 INFO - 'TMOUT': '86400', 15:30:58 INFO - 'USER': 'cltbld', 15:30:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:58 INFO - '_': '/tools/buildbot/bin/python'} 15:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:00 INFO - Installing collected packages: mozsystemmonitor 15:31:00 INFO - Running setup.py install for mozsystemmonitor 15:31:00 INFO - Successfully installed mozsystemmonitor 15:31:00 INFO - Cleaning up... 15:31:00 INFO - Return code: 0 15:31:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:31:00 INFO - Using env: {'DISPLAY': ':0', 15:31:00 INFO - 'HOME': '/home/cltbld', 15:31:00 INFO - 'LANG': 'en_US.UTF-8', 15:31:00 INFO - 'LANGUAGE': 'en_US:en', 15:31:00 INFO - 'LOGNAME': 'cltbld', 15:31:00 INFO - 'MAIL': '/var/mail/cltbld', 15:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:00 INFO - 'MOZ_NO_REMOTE': '1', 15:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:00 INFO - 'NO_EM_RESTART': '1', 15:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:00 INFO - 'PWD': '/builds/slave/test', 15:31:00 INFO - 'SHELL': '/bin/bash', 15:31:00 INFO - 'SHLVL': '1', 15:31:00 INFO - 'TERM': 'linux', 15:31:00 INFO - 'TMOUT': '86400', 15:31:00 INFO - 'USER': 'cltbld', 15:31:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:00 INFO - '_': '/tools/buildbot/bin/python'} 15:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:01 INFO - Downloading/unpacking jsonschema==2.5.1 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:02 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:02 INFO - warning: no files found matching '*.txt' 15:31:02 INFO - no previously-included directories found matching 'build' 15:31:02 INFO - no previously-included directories found matching 'dist' 15:31:02 INFO - no previously-included directories found matching '.git*' 15:31:02 INFO - Installing collected packages: jsonschema, functools32 15:31:02 INFO - Running setup.py install for functools32 15:31:02 INFO - warning: no files found matching '*.txt' 15:31:02 INFO - no previously-included directories found matching 'build' 15:31:02 INFO - no previously-included directories found matching 'dist' 15:31:02 INFO - no previously-included directories found matching '.git*' 15:31:02 INFO - Successfully installed jsonschema functools32 15:31:02 INFO - Cleaning up... 15:31:02 INFO - Return code: 0 15:31:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:31:02 INFO - Using env: {'DISPLAY': ':0', 15:31:02 INFO - 'HOME': '/home/cltbld', 15:31:02 INFO - 'LANG': 'en_US.UTF-8', 15:31:02 INFO - 'LANGUAGE': 'en_US:en', 15:31:02 INFO - 'LOGNAME': 'cltbld', 15:31:02 INFO - 'MAIL': '/var/mail/cltbld', 15:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:02 INFO - 'MOZ_NO_REMOTE': '1', 15:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:02 INFO - 'NO_EM_RESTART': '1', 15:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:02 INFO - 'PWD': '/builds/slave/test', 15:31:02 INFO - 'SHELL': '/bin/bash', 15:31:02 INFO - 'SHLVL': '1', 15:31:02 INFO - 'TERM': 'linux', 15:31:02 INFO - 'TMOUT': '86400', 15:31:02 INFO - 'USER': 'cltbld', 15:31:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:02 INFO - '_': '/tools/buildbot/bin/python'} 15:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:31:03 INFO - Cleaning up... 15:31:03 INFO - Return code: 0 15:31:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:31:03 INFO - Using env: {'DISPLAY': ':0', 15:31:03 INFO - 'HOME': '/home/cltbld', 15:31:03 INFO - 'LANG': 'en_US.UTF-8', 15:31:03 INFO - 'LANGUAGE': 'en_US:en', 15:31:03 INFO - 'LOGNAME': 'cltbld', 15:31:03 INFO - 'MAIL': '/var/mail/cltbld', 15:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:03 INFO - 'MOZ_NO_REMOTE': '1', 15:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:03 INFO - 'NO_EM_RESTART': '1', 15:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:03 INFO - 'PWD': '/builds/slave/test', 15:31:03 INFO - 'SHELL': '/bin/bash', 15:31:03 INFO - 'SHLVL': '1', 15:31:03 INFO - 'TERM': 'linux', 15:31:03 INFO - 'TMOUT': '86400', 15:31:03 INFO - 'USER': 'cltbld', 15:31:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:03 INFO - '_': '/tools/buildbot/bin/python'} 15:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - Downloading docopt-0.6.1.tar.gz 15:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:05 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:05 INFO - Running setup.py install for blobuploader 15:31:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:05 INFO - Running setup.py install for requests 15:31:06 INFO - Running setup.py install for docopt 15:31:06 INFO - Successfully installed blobuploader requests docopt 15:31:06 INFO - Cleaning up... 15:31:06 INFO - Return code: 0 15:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:06 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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:06 INFO - Using env: {'DISPLAY': ':0', 15:31:06 INFO - 'HOME': '/home/cltbld', 15:31:06 INFO - 'LANG': 'en_US.UTF-8', 15:31:06 INFO - 'LANGUAGE': 'en_US:en', 15:31:06 INFO - 'LOGNAME': 'cltbld', 15:31:06 INFO - 'MAIL': '/var/mail/cltbld', 15:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:06 INFO - 'MOZ_NO_REMOTE': '1', 15:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:06 INFO - 'NO_EM_RESTART': '1', 15:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:06 INFO - 'PWD': '/builds/slave/test', 15:31:06 INFO - 'SHELL': '/bin/bash', 15:31:06 INFO - 'SHLVL': '1', 15:31:06 INFO - 'TERM': 'linux', 15:31:06 INFO - 'TMOUT': '86400', 15:31:06 INFO - 'USER': 'cltbld', 15:31:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:06 INFO - '_': '/tools/buildbot/bin/python'} 15:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:06 INFO - Running setup.py (path:/tmp/pip-L2ripx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:06 INFO - Running setup.py (path:/tmp/pip-7xF0fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:06 INFO - Running setup.py (path:/tmp/pip-T9qmcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:06 INFO - Running setup.py (path:/tmp/pip-WWeq0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:06 INFO - Running setup.py (path:/tmp/pip-WfU0SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:07 INFO - Running setup.py (path:/tmp/pip-xfMrLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:07 INFO - Running setup.py (path:/tmp/pip-oZTKcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:07 INFO - Running setup.py (path:/tmp/pip-Sp4zra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:07 INFO - Running setup.py (path:/tmp/pip-S9QXsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:07 INFO - Running setup.py (path:/tmp/pip-repmMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:07 INFO - Running setup.py (path:/tmp/pip-G74skY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:07 INFO - Running setup.py (path:/tmp/pip-KlXoNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:07 INFO - Running setup.py (path:/tmp/pip-ECbBrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:07 INFO - Running setup.py (path:/tmp/pip-IybcRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:07 INFO - Running setup.py (path:/tmp/pip-n_v_xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:07 INFO - Running setup.py (path:/tmp/pip-fUge3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:07 INFO - Running setup.py (path:/tmp/pip-RNjRKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:07 INFO - Running setup.py install for manifestparser 15:31:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Running setup.py install for mozcrash 15:31:08 INFO - Running setup.py install for mozdebug 15:31:08 INFO - Running setup.py install for mozdevice 15:31:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Running setup.py install for mozfile 15:31:08 INFO - Running setup.py install for mozhttpd 15:31:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Running setup.py install for mozinfo 15:31:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Running setup.py install for mozInstall 15:31:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Running setup.py install for mozleak 15:31:08 INFO - Running setup.py install for mozlog 15:31:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:08 INFO - Running setup.py install for moznetwork 15:31:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Running setup.py install for mozprocess 15:31:09 INFO - Running setup.py install for mozprofile 15:31:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Running setup.py install for mozrunner 15:31:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Running setup.py install for mozscreenshot 15:31:09 INFO - Running setup.py install for moztest 15:31:09 INFO - Running setup.py install for mozversion 15:31:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:09 INFO - Cleaning up... 15:31:09 INFO - Return code: 0 15:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:09 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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:09 INFO - Using env: {'DISPLAY': ':0', 15:31:09 INFO - 'HOME': '/home/cltbld', 15:31:09 INFO - 'LANG': 'en_US.UTF-8', 15:31:09 INFO - 'LANGUAGE': 'en_US:en', 15:31:09 INFO - 'LOGNAME': 'cltbld', 15:31:09 INFO - 'MAIL': '/var/mail/cltbld', 15:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:09 INFO - 'MOZ_NO_REMOTE': '1', 15:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:09 INFO - 'NO_EM_RESTART': '1', 15:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:09 INFO - 'PWD': '/builds/slave/test', 15:31:09 INFO - 'SHELL': '/bin/bash', 15:31:09 INFO - 'SHLVL': '1', 15:31:09 INFO - 'TERM': 'linux', 15:31:09 INFO - 'TMOUT': '86400', 15:31:09 INFO - 'USER': 'cltbld', 15:31:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:09 INFO - '_': '/tools/buildbot/bin/python'} 15:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:09 INFO - Running setup.py (path:/tmp/pip-wLIzO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:09 INFO - Running setup.py (path:/tmp/pip-lU8Jh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:10 INFO - Running setup.py (path:/tmp/pip-siLs6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:10 INFO - Running setup.py (path:/tmp/pip-7Zu_Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:10 INFO - Running setup.py (path:/tmp/pip-JF95pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:10 INFO - Running setup.py (path:/tmp/pip-J5bVu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:10 INFO - Running setup.py (path:/tmp/pip-tNCHXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:10 INFO - Running setup.py (path:/tmp/pip-AksYfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:10 INFO - Running setup.py (path:/tmp/pip-_qS_6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:10 INFO - Running setup.py (path:/tmp/pip-9Jj80z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:10 INFO - Running setup.py (path:/tmp/pip-77t0Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:10 INFO - Running setup.py (path:/tmp/pip-QeopzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:10 INFO - Running setup.py (path:/tmp/pip-VdTEmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:10 INFO - Running setup.py (path:/tmp/pip-sp491B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:10 INFO - Running setup.py (path:/tmp/pip-QvQAJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:10 INFO - Running setup.py (path:/tmp/pip-3MXdhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:11 INFO - Running setup.py (path:/tmp/pip-UKL0Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:31:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:12 INFO - Downloading blessings-1.6.tar.gz 15:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:12 INFO - Installing collected packages: blessings 15:31:12 INFO - Running setup.py install for blessings 15:31:12 INFO - Successfully installed blessings 15:31:12 INFO - Cleaning up... 15:31:12 INFO - Return code: 0 15:31:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:12 INFO - Reading from file tmpfile_stdout 15:31:12 INFO - Current package versions: 15:31:12 INFO - argparse == 1.2.1 15:31:12 INFO - blessings == 1.6 15:31:12 INFO - blobuploader == 1.2.4 15:31:12 INFO - docopt == 0.6.1 15:31:12 INFO - functools32 == 3.2.3-2 15:31:12 INFO - jsonschema == 2.5.1 15:31:12 INFO - manifestparser == 1.1 15:31:12 INFO - mozInstall == 1.13 15:31:12 INFO - mozcrash == 1.0 15:31:12 INFO - mozdebug == 0.1 15:31:12 INFO - mozdevice == 0.51 15:31:12 INFO - mozfile == 1.2 15:31:12 INFO - mozhttpd == 0.7 15:31:12 INFO - mozinfo == 0.10 15:31:12 INFO - mozleak == 0.1 15:31:12 INFO - mozlog == 3.5 15:31:12 INFO - moznetwork == 0.27 15:31:12 INFO - mozprocess == 0.25 15:31:12 INFO - mozprofile == 0.28 15:31:12 INFO - mozrunner == 6.13 15:31:12 INFO - mozscreenshot == 0.1 15:31:12 INFO - mozsystemmonitor == 0.3 15:31:12 INFO - moztest == 0.8 15:31:12 INFO - mozversion == 1.4 15:31:12 INFO - psutil == 3.1.1 15:31:12 INFO - requests == 1.2.3 15:31:12 INFO - wsgiref == 0.1.2 15:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:12 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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:12 INFO - Using env: {'DISPLAY': ':0', 15:31:12 INFO - 'HOME': '/home/cltbld', 15:31:12 INFO - 'LANG': 'en_US.UTF-8', 15:31:12 INFO - 'LANGUAGE': 'en_US:en', 15:31:12 INFO - 'LOGNAME': 'cltbld', 15:31:12 INFO - 'MAIL': '/var/mail/cltbld', 15:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:12 INFO - 'MOZ_NO_REMOTE': '1', 15:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:12 INFO - 'NO_EM_RESTART': '1', 15:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:12 INFO - 'PWD': '/builds/slave/test', 15:31:12 INFO - 'SHELL': '/bin/bash', 15:31:12 INFO - 'SHLVL': '1', 15:31:12 INFO - 'TERM': 'linux', 15:31:12 INFO - 'TMOUT': '86400', 15:31:12 INFO - 'USER': 'cltbld', 15:31:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:12 INFO - '_': '/tools/buildbot/bin/python'} 15:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:31:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:31:14 INFO - Installing collected packages: simplejson 15:31:14 INFO - Running setup.py install for simplejson 15:31:14 INFO - building 'simplejson._speedups' extension 15:31:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:31:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:31:15 INFO - Successfully installed simplejson 15:31:15 INFO - Cleaning up... 15:31:15 INFO - Return code: 0 15:31:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:15 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 0x22991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:31:15 INFO - Using env: {'DISPLAY': ':0', 15:31:15 INFO - 'HOME': '/home/cltbld', 15:31:15 INFO - 'LANG': 'en_US.UTF-8', 15:31:15 INFO - 'LANGUAGE': 'en_US:en', 15:31:15 INFO - 'LOGNAME': 'cltbld', 15:31:15 INFO - 'MAIL': '/var/mail/cltbld', 15:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:15 INFO - 'MOZ_NO_REMOTE': '1', 15:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:15 INFO - 'NO_EM_RESTART': '1', 15:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:15 INFO - 'PWD': '/builds/slave/test', 15:31:15 INFO - 'SHELL': '/bin/bash', 15:31:15 INFO - 'SHLVL': '1', 15:31:15 INFO - 'TERM': 'linux', 15:31:15 INFO - 'TMOUT': '86400', 15:31:15 INFO - 'USER': 'cltbld', 15:31:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:15 INFO - '_': '/tools/buildbot/bin/python'} 15:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:15 INFO - Cleaning up... 15:31:15 INFO - Return code: 0 15:31:15 INFO - Running post-action listener: _resource_record_post_action 15:31:15 INFO - Running post-action listener: _start_resource_monitoring 15:31:15 INFO - Starting resource monitoring. 15:31:15 INFO - [mozharness: 2017-09-22 22:31:15.395713Z] Finished create-virtualenv step (success) 15:31:15 INFO - [mozharness: 2017-09-22 22:31:15.396238Z] Running install step. 15:31:15 INFO - Running pre-action listener: _resource_record_pre_action 15:31:15 INFO - Running main action method: install 15:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:15 INFO - Reading from file tmpfile_stdout 15:31:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:15 INFO - Reading from file tmpfile_stdout 15:31:15 INFO - Output received: 15:31:15 INFO - Usage: mozinstall [options] installer 15:31:15 INFO - Options: 15:31:15 INFO - -h, --help show this help message and exit 15:31:15 INFO - -d DEST, --destination=DEST 15:31:15 INFO - Directory to install application into. [default: 15:31:15 INFO - "/builds/slave/test"] 15:31:15 INFO - --app=APP Application being installed. [default: firefox] 15:31:15 INFO - mkdir: /builds/slave/test/build/application 15:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:31:33 INFO - Reading from file tmpfile_stdout 15:31:33 INFO - Output received: 15:31:33 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:33 INFO - Running post-action listener: _resource_record_post_action 15:31:33 INFO - [mozharness: 2017-09-22 22:31:33.571393Z] Finished install step (success) 15:31:33 INFO - [mozharness: 2017-09-22 22:31:33.571645Z] Running setup-mitmproxy step. 15:31:33 INFO - Running pre-action listener: _resource_record_pre_action 15:31:33 INFO - Running main action method: setup_mitmproxy 15:31:33 INFO - Skipping: mitmproxy is not required 15:31:33 INFO - Running post-action listener: _resource_record_post_action 15:31:33 INFO - [mozharness: 2017-09-22 22:31:33.572779Z] Finished setup-mitmproxy step (success) 15:31:33 INFO - [mozharness: 2017-09-22 22:31:33.572999Z] Running run-tests step. 15:31:33 INFO - Running pre-action listener: _resource_record_pre_action 15:31:33 INFO - Running pre-action listener: _set_gcov_prefix 15:31:33 INFO - Running main action method: run_tests 15:31:33 WARNING - Try message not found. 15:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:33 INFO - Python 2.7.3 15:31:33 INFO - Return code: 0 15:31:33 INFO - grabbing minidump binary from tooltool 15:31: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')]} 15:31:33 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 0x2603d60>, '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 0x2604a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2604ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:33 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 15:31:33 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 15:31:33 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 15:31:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:33 INFO - Return code: 0 15:31:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:33 INFO - ENV: RUST_BACKTRACE is now full 15:31:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:31:33 INFO - Using env: {'DISPLAY': ':0', 15:31:33 INFO - 'HOME': '/home/cltbld', 15:31:33 INFO - 'LANG': 'en_US.UTF-8', 15:31:33 INFO - 'LANGUAGE': 'en_US:en', 15:31:33 INFO - 'LOGNAME': 'cltbld', 15:31:33 INFO - 'MAIL': '/var/mail/cltbld', 15:31:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:33 INFO - 'MOZ_NO_REMOTE': '1', 15:31:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:33 INFO - 'NO_EM_RESTART': '1', 15:31:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:33 INFO - 'PWD': '/builds/slave/test', 15:31:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:33 INFO - 'RUST_BACKTRACE': 'full', 15:31:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:31:33 INFO - 'SHELL': '/bin/bash', 15:31:33 INFO - 'SHLVL': '1', 15:31:33 INFO - 'TERM': 'linux', 15:31:33 INFO - 'TMOUT': '86400', 15:31:33 INFO - 'USER': 'cltbld', 15:31:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:33 INFO - '_': '/tools/buildbot/bin/python'} 15:31:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:31:33 INFO - mozversion application_buildid: 20170922212946 15:31:33 INFO - mozversion application_changeset: 61e58a7d800b8a84d3da7c3db977830e206428a3 15:31:33 INFO - mozversion application_display_name: Nightly 15:31:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:33 INFO - mozversion application_name: Firefox 15:31:33 INFO - mozversion application_remotingname: firefox 15:31:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:31:33 INFO - mozversion application_vendor: Mozilla 15:31:33 INFO - mozversion application_version: 58.0a1 15:31:33 INFO - mozversion platform_buildid: 20170922212946 15:31:33 INFO - mozversion platform_changeset: 61e58a7d800b8a84d3da7c3db977830e206428a3 15:31:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:31:33 INFO - mozversion platform_version: 58.0a1 15:31:33 INFO - using testdate: 1506119493 15:31:33 INFO - actual date: 1506119493 15:31:33 INFO - starting webserver on 'localhost:58610' 15:31:33 INFO - SUITE-START | Running 2 tests 15:31:33 INFO - TEST-START | dromaeo_css 15:31:33 INFO - Initialising browser for dromaeo_css test... 15:31:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58610/getInfo.html -profile /tmp/tmpVQiYyN/profile 15:31:33 INFO - TEST-INFO | started process 2699 (/builds/slave/test/build/application/firefox/firefox http://localhost:58610/getInfo.html) 15:31:39 INFO - TEST-INFO | 2699: exit 0 15:31:39 INFO - Browser initialized. 15:31:39 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:39 INFO - Using env: {'DISPLAY': ':0', 15:31:39 INFO - 'HOME': '/home/cltbld', 15:31:39 INFO - 'JSGC_DISABLE_POISONING': '1', 15:31:39 INFO - 'LANG': 'en_US.UTF-8', 15:31:39 INFO - 'LANGUAGE': 'en_US:en', 15:31:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:31:39 INFO - 'LOGNAME': 'cltbld', 15:31:39 INFO - 'MAIL': '/var/mail/cltbld', 15:31:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:39 INFO - 'MOZ_CRASHREPORTER': '1', 15:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:31:39 INFO - 'MOZ_NO_REMOTE': '1', 15:31:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:39 INFO - 'NO_EM_RESTART': '1', 15:31:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:39 INFO - 'PWD': '/builds/slave/test', 15:31:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:39 INFO - 'RUST_BACKTRACE': 'full', 15:31:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:31:39 INFO - 'SHELL': '/bin/bash', 15:31:39 INFO - 'SHLVL': '1', 15:31:39 INFO - 'STYLO_FORCE_DISABLED': '1', 15:31:39 INFO - 'TERM': 'linux', 15:31:39 INFO - 'TMOUT': '86400', 15:31:39 INFO - 'USER': 'cltbld', 15:31:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:39 INFO - '_': '/tools/buildbot/bin/python'} 15:31:39 INFO - TEST-INFO | started process 3004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQiYyN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:40 INFO - PID 3004 | 15:31:40 INFO - PID 3004 | (/builds/slave/test/build/application/firefox/firefox:3089): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:31:40 INFO - PID 3004 | 15:31:50 INFO - PID 3004 | RSS: Main: 153550848 15:31:50 INFO - PID 3004 | 15:34:47 INFO - PID 3004 | Cycle 1(1): loaded http://localhost:58610/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58610/tests/dromaeo/cssquery-ext.html) 15:34:48 INFO - PID 3004 | RSS: Main: 154464256 15:34:48 INFO - PID 3004 | 15:37:50 INFO - PID 3004 | Cycle 1(1): loaded http://localhost:58610/tests/dromaeo/cssquery-ext.html (next: http://localhost:58610/tests/dromaeo/cssquery-jquery.html) 15:37:51 INFO - PID 3004 | RSS: Main: 154099712 15:37:51 INFO - PID 3004 | 15:40:52 INFO - PID 3004 | Cycle 1(1): loaded http://localhost:58610/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58610/tests/dromaeo/cssquery-mootools.html) 15:40:53 INFO - PID 3004 | RSS: Main: 154648576 15:40:53 INFO - PID 3004 | 15:43:55 INFO - PID 3004 | Cycle 1(1): loaded http://localhost:58610/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58610/tests/dromaeo/cssquery-prototype.html) 15:43:55 INFO - PID 3004 | RSS: Main: 154988544 15:43:55 INFO - PID 3004 | 15:46:59 INFO - PID 3004 | Cycle 1(1): loaded http://localhost:58610/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58610/tests/dromaeo/cssquery-yui.html) 15:46:59 INFO - PID 3004 | RSS: Main: 154750976 15:46:59 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | Cycle 1(1): loaded http://localhost:58610/tests/dromaeo/cssquery-yui.html (next: http://localhost:58610/tests/dromaeo/cssquery-dojo.html) 15:50:01 INFO - PID 3004 | RSS: Main: 158412800 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | __start_tp_report 15:50:01 INFO - PID 3004 | _x_x_mozilla_page_load 15:50:01 INFO - PID 3004 | _x_x_mozilla_page_load_details 15:50:01 INFO - PID 3004 | |i|pagename|runs| 15:50:01 INFO - PID 3004 | |0;dojo.html;3118.922026949326;3145.402373549027;3146.417912686153;3150.858211380488;3151.038933125396;6199.783007594735;6231.688415579214;6272.466840318572;6350.14273073135;6372.872542549152;6245.781397651083;6291.465225455841;6302.306746257919;6316.621002739839;6355.142055822463;5664.320281566218;5750.597458177929;5758.395368486312;5779.3642699303045;5818;5863.061910094386;5873.236479257691;5880.2355693759755;5901.940980590203;5904.675242861641;5777.740001699913;5876.676782776945;5927.2294601701715;5928.88142237155;5929.110633404981;5290.502740233457;5596.384397716248;5735.627184233012;5816.302043754777;5839.941600583982;5734.741936612862;5744.798932037359;5812.215350927613;5817.185594016841;5822.475977162034;6166.383361663842;6217.0052791553135;6276.905846412307;6305.59013664115;6385.808425747235;6593.93406065938;6625.4037136657935;6648.069270302113;6667.099941507883;6675.532712710112;6647.900281495781;6700.664966751643;6745.898811517831;6848.760293389708;6856.760013399507;6260.655663938482;6270.592411493239;6341.8414539636415;6346.01636746305;6354.5551811373225;6858.759943402057;6968.233494315621;7030.789076327718;7045.753398631024;7068.575885446787;6336.873262534724;6419.358064193543;6459.483241340681;6473.676316184172;6734;6535.901961470582;6610.272869984298;6690.866182676319;6691.130153080068;6729.024291477708;6600.570962887493;6606.240282367493;6611.33886611335;6620.172478440195;6622.437092847065;6548.738050478023;6565.080888675589;6565.868682626321;6635.336466353326;6639;5090.160123579568;5160.225966105039;5180.715060671624;5242.606804489678;5271.3674359076385;4527.977360113178;4601.056783359403;4663.556962088596;4676.579107880307;4696.459907110726;5755.913661295084;5756.740946657411;5802.680852553066;5821.18503409523;5839.386864379264;6746.392824645805;6789.864202716017;6864.2106157791495;6867.622280774505;6890.069840571559;5654.321481422256;5741.684207368635;5754.108113242454;5762.308522977186;5833.212516310244;5730.799422020209;5796.333421656479;5798.420157984252;5798.5651076168615;5808.88382232353;6362.586431881913;6445.484361251089;6569.080328753978;6575.934240657628;6578.572392794453;6734.8653026940165;6759.966200169164;6804.183497980274;6882.655867206619;6901.896471553031;6393.456556192776;6517.120188774455;6519.185101862267;6602.273749887412;6618.0403841443685;6530.8040758777315;6621.172353455818;6641.169853768279;6643.534952553468;6649.900251496135;6794.694238759169;6826.897596536155;6903.482238832208;6918.273581274095;6929.7921062366195;6572.605643661395;6579.309172536815;6652.800415987528;6661.467082633475;6662.56693314933;6455.48356131499;6551.80344589663;6566.409023187936;6577;6672.699728512326;6339.873202535831;6401.711922963571;6410.935890641033;6427.228732552124;6434.517411194272;6528.869422611616;6575.572587781779;6593.142891424084;6660.167479065117;6688.197416310074;6378.77674281398;6384.712687929147;6436.806895793134;6457.870842583216;6472.644004579794 15:50:01 INFO - PID 3004 | |1;ext.html;760.6957217113154;798.836238571093;801.3188789528901;805.198827166969;805.9597020148991;39129.60870391295;42848.14303713924;42968;42972.785136074315;43128.13743725127;38321.808390958075;38576.22847543047;38594;38681.80659096708;38693.419598706045;7079.469039822021;7193.748218812342;7200.063991681074;7200.963995180043;7795.532268063906;7769.456138070337;7998.720044798433;7999.680012799481;7999.880001799977;8006.319462845665;7903.920960790405;7955.681772729084;7959.243871832166;7975.361971042303;7998.1601931797195;7927.96036019822;7930.246626570467;7958.084820245659;7981.96009019957;7985.321247693924;7773.766786996399;7883.172266911949;7895.565743884084;7898.842023159562;7899.881501777478;38040.23919521594;38338.42492362617;38385.61614383848;38467.230655387015;38470.03824904372;3523.1896663767475;3557.288542291526;3560.857565697395;3561.679448849616;3564.3049605326974;31763.682363176304;31899.681003189904;31936.361272774415;31968;32009;5036.924446133275;5176.689398636094;5208.322918020671;5246.685198888079;5260.079486089919;184040;185085;185508;185677;185811;41844.58155418407;48034.75982620064;48278.27582586264;48323.75838120857;48349.75825120852;43563.346549801776;43644.78177609092;51059.74470127626;52010.739946300026;52029.2195617066;15649.061056336655;15670.529884103495;15703.057816530816;15750;15797.763033554505;12667.556635517896;12675.11274210815;12687.175333603287;12692.49230030807;12696.619101426972;13653.04428690002;13714.725705486035;13839.308034598229;13893.374798134108;14054.508092216724;5459.672419654833;5521.475459831309;5535.6955367455175;5624.240727501817;5627.774889004476;1025.5128813813378;1029.7528593137743;1036.512838965685;1038.6105210546045;1043.436544266103;22395.21616743406;22660.660090098663;22699.659505107436;23011.194608188634;23452.179173728837;1129.6611016695124;1145.3814939932342;1153.0890596428894;1159.9478023488964;1163.8196079607505;12204.572839950737;12239.510419583117;12284.570040048555;12321.753564928651;12391.442385092512;224258;225385;226460;227091;228382;52308.47691523112;52460.47539524632;52518.737406313485;52627.47372526226;52877.47122528803;1443.3432788081188;1450.1371683848095;1477.8078849749463;1490.1878476230481;1500.129924643704;22725.659115112954;22962.19632312861;23116.19093331725;23162;23345;37680.24639507139;37838.43242351422;37843.43234851534;37849;37883.24233515369;198736;198743;199105;199651;199950;29932.55101173528;30593.694063059083;34323.485147722306;34550.30899382049;35129.29741405209;43503.347449787645;43727.56272437235;44015.55984440243;44149.33775993427;44757.77621111873;32421.837890810395;32777.18057048593;32925;32963.835180823946;33326.16684582905;32038.35923281568;32198;32539.34921301608;32797.18007049843;33155.83422082874;35698;36068.45897311595;36290;36310.636893630726;36344.636553634125;31729.365412692077;31917.68082319147;32067.198320042186;32162;32299.928621700416;23424.6486302709;23530.411739706644;23717.407064823517;23730.288091357288;23849.880750596138 15:50:01 INFO - PID 3004 | |2;jquery.html;588.138377277289;590.9320428150761;594.9702514874256;603.4930658247073;617.8826023055619;22126.33620991371;22894.77105228947;22899.656505152438;22928.082876684955;23116.07535698574;21769.673454898188;21891.12435502578;22502;22653.54692906141;22718.318450446513;6654.733810647568;6827.249002609709;6841.144856892888;6847.452203823707;6848.623325717083;6424.453921416685;6696.631685257309;6733.663316834139;6734.56225345351;6792.150981127359;6687.097241872358;6691.330866913294;6694.364035416627;6696.06255124283;6702.966485167592;6685.130932978682;6689.565178263398;6695.096162018138;6714.899276510856;6727.8318042049095;6206.317305096436;6239.188905442309;6239.844003899893;6240.31356550779;6249.593776404519;27321.45357092867;27995.86002069997;28114.859425702944;28348.716512834813;28772.856135719187;2103.316422162803;2125.4048866317457;2125.553633736917;2126.797954194349;2131.8507704460694;15620.140892250922;16527.586810329718;18761.15574799137;19110.23559057636;20035.09842057111;2461.643061756053;2469.9012039518398;2511.6483692283095;2536.961945570818;2550.681164854393;114456;121630;121984;126620.99999999908;137121;14797.852021479648;14864.097120473521;14924.552263432115;14964.952453328162;15435.768463473058;22486.550268994855;22493.32520024402;22544.323670289916;22697.886510567343;22698.43253918665;9787.853182202272;9918.900810991941;10000.649977250761;10084.49577521121;10086.697399078039;9076.591553380114;9172.403793753385;9185.265178785681;9199.816003679889;9327.906720932839;9013.233875120557;9030.954845225731;9048.547572621474;9175.17423431881;9205.217556507638;2670.8664566771586;2684.3960108975716;2700.693137983871;2727.2500062482977;2727.9181624551297;963.677168148664;981.6760469045198;984.1880448629909;998.8501724741202;1000.5847573257163;19241.90379048096;19643.31248406299;19663;19798.109085091204;19963.700544491843;1019.7705516258931;1039;1049.0715716590719;1049.7900419916048;1053.1311667874033;10111.949440252898;10864.837027444595;10882;11028.12236149907;11122.110231181487;477122;478773;485770;490756;491988;107470.46264768626;109686;112007;112407.43796280966;112491.4375428134;1174.7885380631396;1190.976180476403;1192.0463629096687;1193.0276824388095;1197.3115458611333;17371.82628173702;17413;17502.562435938693;17639.647207055532;17762;52257.73871130772;52508;52647;53207.46792532025;53754;68159;68175.31824681888;68624.6568767153;69246.30753692398;69254.65372673105;14341.92829035848;14574.562763117123;14642.780358294847;14644.12135271887;14657.04729192599;22282.331530054125;22367.664485033063;22377.776222237568;22494.550108998057;22689.659655104857;17669.91165044218;18232.726509102107;18312.08439577989;18330.450086497425;18525.9073704636;16114;16214.51356459308;16258;16746.413875514787;17079.31682732677;17199.484015479557;18083.909580452015;18191.636167276316;18311.816881831543;18375.632487350445;14087.084339517898;14102.929485352917;14112.364943577359;14262.144271343752;14264.857351426353;17574.945503269846;17654.911725441292;17723.645527089127;17735.645287094445;17852.19665115099 15:50:01 INFO - PID 3004 | |3;mootools.html;1314.6516173214097;1356.941585563261;1359.1709057474945;1373.8007988841618;1386.140592832444;14935.253237338131;15671.92164039181;15688.45090421834;15703.371865125395;15720.921395393007;15261.016067911183;15506.84493155068;15538.766918496203;15552.766708499381;15568;2844.886204551826;2848.686644469107;2893.5514995175677;2894.044965161502;2898.9710102899016;2776.47247023065;2809.044924725593;2831.348789778352;2838.361368692038;2838.6735525414633;2718.075854209568;2783.554631258999;2831.8159319644155;2833.4049849531625;2835.588839618254;2741.8080734348605;2781.2490627530556;2781.5271403861393;2786.8327900326044;2788.888444462219;2593.922182334533;2696.9325766855986;2738.2606696192115;2752.9036483722975;2757.3658058646624;15334;15430.459933902259;15471.149086800222;15482.690346193125;15495.22523873813;7938.801529961797;8224.753257402288;8242.258196762321;8251.133630968721;8251.33989280856;5273.1035723927025;5460.262864513319;5522.585806064561;5529.281193444866;5536.446355364431;1874.8500119990504;1900.4108726294892;1917.5973045660428;1939.5151212196952;1944.6402415553027;27843.443131137465;28141.29646758827;28183.71816281852;28194.154175374773;28202.294942626395;6868.244493105754;7030.367266945999;7136.892946605805;7144.714211431588;7212.783616491513;17855.73216401755;17895;17898.10509474521;17899.821001790075;18521.629567408847;7802.336801371834;8106.270435660701;8155.306798922039;8156;8165.2243036911395;7266.200717921024;7468.775936721907;7468.775936721907;7480.952666626677;7547.471676982558;5062.417821950449;5271.578273738169;5291.3385826771655;5297.867553311198;5305.389880163753;1572;1591.7214487464878;1601.455505128262;1619.4251040880554;1623.310093210381;833.5165603949816;839.3327304792705;853.6585365853708;854.0562678240578;865.3207232322596;6919.135108111486;6986.476014298846;6997.230304666483;7057.400120989773;7063.717451301993;704.8766465868453;720.6865013719049;724.7970568240901;733.2813842434444;753.7211231844143;4266.935995960063;4268.573142685706;4273.572642735764;4281.186574550888;4290.978545107255;21833.454163645718;22303.55392892133;22343.44141396478;22525.549489010456;22622.547549048926;20795.68806467904;21263.574728505653;21744.673829892563;22093.779062209494;22095.116195352006;11467.598634047936;11528.711782205512;11533.135014873918;11547.249428787101;11555.017823485097;7045.401140903081;7414.518056326321;7622.390208783395;7672;7736.690532378641;18456.26174952987;18492.722609160603;18890.52773680669;18917.148728307533;19130.139143738288;19542.609147816678;19593.608127837648;19617.41147765512;19774.70337944961;20285.188592456725;11121.110311175249;11276.718082048015;11303.1522635801;11328.207025508136;11329.71675708114;14116.435342586181;14131.717365652425;14229.786553201917;14289.857101428852;14293.35679894428;11217.49521271561;11653.708657283636;11694.415279235835;11859.703507412383;11948.820767688318;11216.66350009501;11366.318020918772;11413.828792568283;11469.369184694922;11688.18182727201;9141.588628511867;9148.496832674267;9188.908110918805;9206.631734730536;9208.217301529177;6638.83402914931;6653.667316634246;6695.8326041847395;6715.597064176165;6801.319868013159;6299.6535190564955;6303.779367722108;6309.810705678837;6312.589681670676;6321.652309123042 15:50:01 INFO - PID 3004 | |4;prototype.html;505.9981237150442;512.4926322940288;524.0746806419914;543.540708101654;548.3721139295504;6100.359462256466;6235.812925612233;6317.652529110897;6323.74705011799;6361.278651988592;6023.909641355383;6043.316429766933;6100.633961962285;6161.630302181872;6188.628682279066;4981.551660350577;5007.2489126630935;5026.271190677349;5043.218301163307;5053.6715113517685;4873.537013983666;5071.923921141186;5074.5432911038;5077.238414237857;5099.796008159669;5037.697738135724;5043.798248070073;5052.343195384595;5053.77258023388;5060.038592667382;5000.824971126011;5004.774785134678;5048.1670524363435;5066.341375621182;5068.378119001921;4558.202314594932;4574.153781550423;4584.7936842842155;4586.701864378805;4594.150082234797;5990.191324171225;6079.449740316235;6125.938740612582;6239.469645080128;6283.340249273806;5766.192733017381;5766.913496297559;5777.7977770777825;5792.536597072224;5807.477327040587;6607.735690572371;6618.63597502142;6621.172353455818;6634.137562116894;6645.501587380966;4939.604831613462;4951.603871690292;4963.40439147301;4968.87577810554;4985.476524964863;6890.655467226618;6930.965345173292;6960.582365058062;6984.406325462342;6985.930140698579;5006.424261209934;5008.524190201925;5055.772490237948;5077.796888124508;5086.21163719624;5166.509181627739;5188.0661480933795;5188.584913206934;5198.766055527435;5205.115130427836;5700.543956483471;5709.65742055478;5722.885542289131;5738.713064346766;5749.712514374264;6191.349908259658;6297.149884765498;6506.707198176094;6611.239707433707;6667.499812542139;1722.6124122072683;1750.431109889291;1760.9207585658676;1768.2838450427598;1773.6541374431863;1066.7119877632995;1197.592818441734;1227.472186959616;1249.9812502812465;1251.3743128435783;5553.527950124204;5679.290088738908;5697.800576979786;5701.600887937888;5708.230448560959;6614.570052946543;6673.833154171185;6721.8743284373;6725.529212955046;6780.457563394916;5708.828735137952;5777.913331300034;5794.855128621818;5800.53595712342;5806.912896306559;3545.4859045438266;3583.605803361628;3599.964000359963;3607.6211997740384;3624.7100231981376;6421.51838612106;6440.4847612190915;6453.4506021687885;6562.310957349505;6596.604203747695;6775.62734049632;6782.287859774751;6793.592384456949;6839.179298484114;6844.486663500158;6473.546851720429;6480.384363485367;6501.414872661483;6545.280019197884;6550.475961923034;6562.77030303937;6623.304553022056;6631.972044333136;6722.831929201809;6747.392734653905;6475.579087359307;6488.772892948724;6663.766768163091;6666.666666666551;6740.618173274565;6418.6469744164515;6438;6453.9354606453335;6539.4768418525455;6570.357410647338;5065.8733531662;5080.669756465818;5090.312807770903;5093.4651861554;5097.260897169964;6692.582895289281;6764.594124352555;6830.453563714792;6846.931530684629;6882.208546017272;6390.274625850901;6411.51913606472;6448.29068802422;6451.225852897683;6527.184101987252;6271.184745983175;6342.556021078664;6377.426031657174;6453.645049522322;6485.740570377132;6345.302016778243;6348.048522152728;6355.586886852339;6434.935650643433;6438.259600145856;6140.201773769381;6465.515086368447;6474;6518.282988871315;6542.607443553402;6164.938350616616;6220.440160385587;6234.2830574482705;6261.78083767066;6370.904436433365 15:50:01 INFO - PID 3004 | |5;yui.html;903.358615383078;914.1635403605693;923.755204870709;925.0240995749485;933.6732143749687;19948.401547953566;19975.800241997575;20226.595468090647;20311.984400779977;20335;18940.337088201915;19148.80851191488;19225.423237302904;19243.51891202717;19315.323963661238;968.2834702320285;988.5106872098286;1000.4297550396277;1000.8999100089969;1001.1190152665644;946.0728486083642;982.1602529836994;992.9602815887356;996.5366104761284;997.316837965992;1061.4374381577777;1062.914966802654;1066.7439814444517;1066.8879767624403;1070.2829104499965;994.9801003979879;1024.2011231239644;1028.5577201803221;1038.3406536849118;1043.942583157926;749.7151082588636;749.83128796021;751.2787723785173;752.0486584470649;756.6897571995511;20583.485412864648;20809.89595052015;20824.271150509812;20826.16695332185;20838;20833;22117.66823497649;22302.55394892093;22306.776932230634;22372.88813555938;17133.485995420157;17491.5627109322;17504;17511.036892970882;17616;3750.1562148516637;3778.112143646241;3781.035835861865;3787.2425514896854;3795.278897009587;140839;140983.29508352495;141880;142439;143941;16895.577610559834;17429;17546.034968076878;17554.561135971446;17565.560860978578;31042.379152416826;32413.35173296568;32678.346433071205;32712.182195445304;32752.344953100805;8327.541985190752;8367.414281000394;8551.529665868313;8563.571821408905;8576.614052367659;4378.934315985262;4514.458265008155;4516.07420478801;4517.051419201939;4533.229351010336;5559.972200139055;5656.604037717402;5673.375928647845;5678.659280443104;5687.51656109227;997.5112195024386;1004.8040632076821;1036.3367444835312;1037.9273450858368;1040.5785656809005;669.1234482827512;689.9275576064541;700.719712115158;709.3048812164108;709.3828369318622;11172;11208;11249.66251012471;11726.179167458367;12084.274943503242;658.6114192626374;658.7957733102753;666.1839246922578;677.6002158726375;679.2731776998564;5145.562627176732;5155.74221288934;5184.274201611777;5273.736313184326;5288.2596436498925;118644;121017;124424.37787811003;124904;127137;103323;106627.46686266674;111420.44289778499;112317;112674;95993.52003240079;96286.51856740811;96744;98544;101817;11713.355765432641;12034.578789742667;12171.634850954486;12199;12434.502619895104;42354.77520510837;42391.57608424;42673.57326426696;43169.784151079046;45440.31839522476;76090;77742;78082.6095869517;79760.60119699364;83221;19347.226110955406;19507;19613.607727845647;19701.901490492455;19731.210751569775;21835.344939651837;22133.225337113767;22713.659295110916;22714.43213919665;22743.431414214778;17870.285188592312;18250.36123735663;18251.269949201884;18451.72322415138;18470.81529184691;18244.543886402415;18494;18871.811281887556;18992.620147596695;19131.713024304925;17434.564135896704;17768.289268429635;17801.554961126076;18054.81945180584;18082.819171808114;13218.60344189676;13509.121907076009;13513.527026554024;13589.52436664712;13629.228200333893;12258.387080646111;13169.53906613264;13483.662908427368;13842.723145537235;13884 15:50:01 INFO - PID 3004 | __end_tp_report 15:50:01 INFO - PID 3004 | __start_cc_report 15:50:01 INFO - PID 3004 | _x_x_mozilla_cycle_collect,270 15:50:01 INFO - PID 3004 | __end_cc_report 15:50:01 INFO - PID 3004 | __startTimestamp1506120601556__endTimestamp 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | ------- Summary: start ------- 15:50:01 INFO - PID 3004 | Number of tests: 6 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | [#0] dojo.html Cycles:165 Average:6181.15 Median:6410.94 stddev:747.64 (11.7%) stddev-sans-first:710.29 15:50:01 INFO - PID 3004 | Values: 3118.9 3145.4 3146.4 3150.9 3151.0 6199.8 6231.7 6272.5 6350.1 6372.9 6245.8 6291.5 6302.3 6316.6 6355.1 5664.3 5750.6 5758.4 5779.4 5818.0 5863.1 5873.2 5880.2 5901.9 5904.7 5777.7 5876.7 5927.2 5928.9 5929.1 5290.5 5596.4 5735.6 5816.3 5839.9 5734.7 5744.8 5812.2 5817.2 5822.5 6166.4 6217.0 6276.9 6305.6 6385.8 6593.9 6625.4 6648.1 6667.1 6675.5 6647.9 6700.7 6745.9 6848.8 6856.8 6260.7 6270.6 6341.8 6346.0 6354.6 6858.8 6968.2 7030.8 7045.8 7068.6 6336.9 6419.4 6459.5 6473.7 6734.0 6535.9 6610.3 6690.9 6691.1 6729.0 6600.6 6606.2 6611.3 6620.2 6622.4 6548.7 6565.1 6565.9 6635.3 6639.0 5090.2 5160.2 5180.7 5242.6 5271.4 4528.0 4601.1 4663.6 4676.6 4696.5 5755.9 5756.7 5802.7 5821.2 5839.4 6746.4 6789.9 6864.2 6867.6 6890.1 5654.3 5741.7 5754.1 5762.3 5833.2 5730.8 5796.3 5798.4 5798.6 5808.9 6362.6 6445.5 6569.1 6575.9 6578.6 6734.9 6760.0 6804.2 6882.7 6901.9 6393.5 6517.1 6519.2 6602.3 6618.0 6530.8 6621.2 6641.2 6643.5 6649.9 6794.7 6826.9 6903.5 6918.3 6929.8 6572.6 6579.3 6652.8 6661.5 6662.6 6455.5 6551.8 6566.4 6577.0 6672.7 6339.9 6401.7 6410.9 6427.2 6434.5 6528.9 6575.6 6593.1 6660.2 6688.2 6378.8 6384.7 6436.8 6457.9 6472.6 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | [#1] ext.html Cycles:180 Average:37222.65 Median:3540.24 stddev:52883.24 (1493.8%) stddev-sans-first:52960.72 15:50:01 INFO - PID 3004 | Values: 760.7 798.8 801.3 805.2 806.0 39129.6 42848.1 42968.0 42972.8 43128.1 38321.8 38576.2 38594.0 38681.8 38693.4 7079.5 7193.7 7200.1 7201.0 7795.5 7769.5 7998.7 7999.7 7999.9 8006.3 7903.9 7955.7 7959.2 7975.4 7998.2 7928.0 7930.2 7958.1 7982.0 7985.3 7773.8 7883.2 7895.6 7898.8 7899.9 38040.2 38338.4 38385.6 38467.2 38470.0 3523.2 3557.3 3560.9 3561.7 3564.3 31763.7 31899.7 31936.4 31968.0 32009.0 5036.9 5176.7 5208.3 5246.7 5260.1 184040.0 185085.0 185508.0 185677.0 185811.0 41844.6 48034.8 48278.3 48323.8 48349.8 43563.3 43644.8 51059.7 52010.7 52029.2 15649.1 15670.5 15703.1 15750.0 15797.8 12667.6 12675.1 12687.2 12692.5 12696.6 13653.0 13714.7 13839.3 13893.4 14054.5 5459.7 5521.5 5535.7 5624.2 5627.8 1025.5 1029.8 1036.5 1038.6 1043.4 22395.2 22660.7 22699.7 23011.2 23452.2 1129.7 1145.4 1153.1 1159.9 1163.8 12204.6 12239.5 12284.6 12321.8 12391.4 224258.0 225385.0 226460.0 227091.0 228382.0 52308.5 52460.5 52518.7 52627.5 52877.5 1443.3 1450.1 1477.8 1490.2 1500.1 22725.7 22962.2 23116.2 23162.0 23345.0 37680.2 37838.4 37843.4 37849.0 37883.2 198736.0 198743.0 199105.0 199651.0 199950.0 29932.6 30593.7 34323.5 34550.3 35129.3 43503.3 43727.6 44015.6 44149.3 44757.8 32421.8 32777.2 32925.0 32963.8 33326.2 32038.4 32198.0 32539.3 32797.2 33155.8 35698.0 36068.5 36290.0 36310.6 36344.6 31729.4 31917.7 32067.2 32162.0 32299.9 23424.6 23530.4 23717.4 23730.3 23849.9 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | [#2] jquery.html Cycles:180 Average:33682.46 Median:22489.94 stddev:81187.63 (361.0%) stddev-sans-first:81377.36 15:50:01 INFO - PID 3004 | Values: 588.1 590.9 595.0 603.5 617.9 22126.3 22894.8 22899.7 22928.1 23116.1 21769.7 21891.1 22502.0 22653.5 22718.3 6654.7 6827.2 6841.1 6847.5 6848.6 6424.5 6696.6 6733.7 6734.6 6792.2 6687.1 6691.3 6694.4 6696.1 6703.0 6685.1 6689.6 6695.1 6714.9 6727.8 6206.3 6239.2 6239.8 6240.3 6249.6 27321.5 27995.9 28114.9 28348.7 28772.9 2103.3 2125.4 2125.6 2126.8 2131.9 15620.1 16527.6 18761.2 19110.2 20035.1 2461.6 2469.9 2511.6 2537.0 2550.7 114456.0 121630.0 121984.0 126621.0 137121.0 14797.9 14864.1 14924.6 14965.0 15435.8 22486.6 22493.3 22544.3 22697.9 22698.4 9787.9 9918.9 10000.6 10084.5 10086.7 9076.6 9172.4 9185.3 9199.8 9327.9 9013.2 9031.0 9048.5 9175.2 9205.2 2670.9 2684.4 2700.7 2727.3 2727.9 963.7 981.7 984.2 998.9 1000.6 19241.9 19643.3 19663.0 19798.1 19963.7 1019.8 1039.0 1049.1 1049.8 1053.1 10111.9 10864.8 10882.0 11028.1 11122.1 477122.0 478773.0 485770.0 490756.0 491988.0 107470.5 109686.0 112007.0 112407.4 112491.4 1174.8 1191.0 1192.0 1193.0 1197.3 17371.8 17413.0 17502.6 17639.6 17762.0 52257.7 52508.0 52647.0 53207.5 53754.0 68159.0 68175.3 68624.7 69246.3 69254.7 14341.9 14574.6 14642.8 14644.1 14657.0 22282.3 22367.7 22377.8 22494.6 22689.7 17669.9 18232.7 18312.1 18330.5 18525.9 16114.0 16214.5 16258.0 16746.4 17079.3 17199.5 18083.9 18191.6 18311.8 18375.6 14087.1 14102.9 14112.4 14262.1 14264.9 17574.9 17654.9 17723.6 17735.6 17852.2 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | [#3] mootools.html Cycles:180 Average:9390.92 Median:15313.50 stddev:6959.33 (45.4%) stddev-sans-first:6952.40 15:50:01 INFO - PID 3004 | Values: 1314.7 1356.9 1359.2 1373.8 1386.1 14935.3 15671.9 15688.5 15703.4 15720.9 15261.0 15506.8 15538.8 15552.8 15568.0 2844.9 2848.7 2893.6 2894.0 2899.0 2776.5 2809.0 2831.3 2838.4 2838.7 2718.1 2783.6 2831.8 2833.4 2835.6 2741.8 2781.2 2781.5 2786.8 2788.9 2593.9 2696.9 2738.3 2752.9 2757.4 15334.0 15430.5 15471.1 15482.7 15495.2 7938.8 8224.8 8242.3 8251.1 8251.3 5273.1 5460.3 5522.6 5529.3 5536.4 1874.9 1900.4 1917.6 1939.5 1944.6 27843.4 28141.3 28183.7 28194.2 28202.3 6868.2 7030.4 7136.9 7144.7 7212.8 17855.7 17895.0 17898.1 17899.8 18521.6 7802.3 8106.3 8155.3 8156.0 8165.2 7266.2 7468.8 7468.8 7481.0 7547.5 5062.4 5271.6 5291.3 5297.9 5305.4 1572.0 1591.7 1601.5 1619.4 1623.3 833.5 839.3 853.7 854.1 865.3 6919.1 6986.5 6997.2 7057.4 7063.7 704.9 720.7 724.8 733.3 753.7 4266.9 4268.6 4273.6 4281.2 4291.0 21833.5 22303.6 22343.4 22525.5 22622.5 20795.7 21263.6 21744.7 22093.8 22095.1 11467.6 11528.7 11533.1 11547.2 11555.0 7045.4 7414.5 7622.4 7672.0 7736.7 18456.3 18492.7 18890.5 18917.1 19130.1 19542.6 19593.6 19617.4 19774.7 20285.2 11121.1 11276.7 11303.2 11328.2 11329.7 14116.4 14131.7 14229.8 14289.9 14293.4 11217.5 11653.7 11694.4 11859.7 11948.8 11216.7 11366.3 11413.8 11469.4 11688.2 9141.6 9148.5 9188.9 9206.6 9208.2 6638.8 6653.7 6695.8 6715.6 6801.3 6299.7 6303.8 6309.8 6312.6 6321.7 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | [#4] prototype.html Cycles:180 Average:5515.16 Median:6113.29 stddev:1528.84 (25.0%) stddev-sans-first:1486.18 15:50:01 INFO - PID 3004 | Values: 506.0 512.5 524.1 543.5 548.4 6100.4 6235.8 6317.7 6323.7 6361.3 6023.9 6043.3 6100.6 6161.6 6188.6 4981.6 5007.2 5026.3 5043.2 5053.7 4873.5 5071.9 5074.5 5077.2 5099.8 5037.7 5043.8 5052.3 5053.8 5060.0 5000.8 5004.8 5048.2 5066.3 5068.4 4558.2 4574.2 4584.8 4586.7 4594.2 5990.2 6079.4 6125.9 6239.5 6283.3 5766.2 5766.9 5777.8 5792.5 5807.5 6607.7 6618.6 6621.2 6634.1 6645.5 4939.6 4951.6 4963.4 4968.9 4985.5 6890.7 6931.0 6960.6 6984.4 6985.9 5006.4 5008.5 5055.8 5077.8 5086.2 5166.5 5188.1 5188.6 5198.8 5205.1 5700.5 5709.7 5722.9 5738.7 5749.7 6191.3 6297.1 6506.7 6611.2 6667.5 1722.6 1750.4 1760.9 1768.3 1773.7 1066.7 1197.6 1227.5 1250.0 1251.4 5553.5 5679.3 5697.8 5701.6 5708.2 6614.6 6673.8 6721.9 6725.5 6780.5 5708.8 5777.9 5794.9 5800.5 5806.9 3545.5 3583.6 3600.0 3607.6 3624.7 6421.5 6440.5 6453.5 6562.3 6596.6 6775.6 6782.3 6793.6 6839.2 6844.5 6473.5 6480.4 6501.4 6545.3 6550.5 6562.8 6623.3 6632.0 6722.8 6747.4 6475.6 6488.8 6663.8 6666.7 6740.6 6418.6 6438.0 6453.9 6539.5 6570.4 5065.9 5080.7 5090.3 5093.5 5097.3 6692.6 6764.6 6830.5 6846.9 6882.2 6390.3 6411.5 6448.3 6451.2 6527.2 6271.2 6342.6 6377.4 6453.6 6485.7 6345.3 6348.0 6355.6 6434.9 6438.3 6140.2 6465.5 6474.0 6518.3 6542.6 6164.9 6220.4 6234.3 6261.8 6370.9 15:50:01 INFO - PID 3004 | 15:50:01 INFO - PID 3004 | [#5] yui.html Cycles:180 Average:25745.48 Median:20323.49 stddev:36308.35 (178.7%) stddev-sans-first:36362.29 15:50:01 INFO - PID 3004 | Values: 903.4 914.2 923.8 925.0 933.7 19948.4 19975.8 20226.6 20312.0 20335.0 18940.3 19148.8 19225.4 19243.5 19315.3 968.3 988.5 1000.4 1000.9 1001.1 946.1 982.2 993.0 996.5 997.3 1061.4 1062.9 1066.7 1066.9 1070.3 995.0 1024.2 1028.6 1038.3 1043.9 749.7 749.8 751.3 752.0 756.7 20583.5 20809.9 20824.3 20826.2 20838.0 20833.0 22117.7 22302.6 22306.8 22372.9 17133.5 17491.6 17504.0 17511.0 17616.0 3750.2 3778.1 3781.0 3787.2 3795.3 140839.0 140983.3 141880.0 142439.0 143941.0 16895.6 17429.0 17546.0 17554.6 17565.6 31042.4 32413.4 32678.3 32712.2 32752.3 8327.5 8367.4 8551.5 8563.6 8576.6 4378.9 4514.5 4516.1 4517.1 4533.2 5560.0 5656.6 5673.4 5678.7 5687.5 997.5 1004.8 1036.3 1037.9 1040.6 669.1 689.9 700.7 709.3 709.4 11172.0 11208.0 11249.7 11726.2 12084.3 658.6 658.8 666.2 677.6 679.3 5145.6 5155.7 5184.3 5273.7 5288.3 118644.0 121017.0 124424.4 124904.0 127137.0 103323.0 106627.5 111420.4 112317.0 112674.0 95993.5 96286.5 96744.0 98544.0 101817.0 11713.4 12034.6 12171.6 12199.0 12434.5 42354.8 42391.6 42673.6 43169.8 45440.3 76090.0 77742.0 78082.6 79760.6 83221.0 19347.2 19507.0 19613.6 19701.9 19731.2 21835.3 22133.2 22713.7 22714.4 22743.4 17870.3 18250.4 18251.3 18451.7 18470.8 18244.5 18494.0 18871.8 18992.6 19131.7 17434.6 17768.3 17801.6 18054.8 18082.8 13218.6 13509.1 13513.5 13589.5 13629.2 12258.4 13169.5 13483.7 13842.7 13884.0 15:50:01 INFO - PID 3004 | -------- Summary: end -------- 15:50:01 INFO - PID 3004 | 15:50:02 INFO - TEST-INFO | 3004: exit 0 15:50:02 INFO - TEST-OK | dromaeo_css | took 1108280ms 15:50:02 INFO - TEST-START | kraken 15:50:02 INFO - Initialising browser for kraken test... 15:50:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58610/getInfo.html -profile /tmp/tmpkVMkSN/profile 15:50:02 INFO - TEST-INFO | started process 3425 (/builds/slave/test/build/application/firefox/firefox http://localhost:58610/getInfo.html) 15:50:07 INFO - TEST-INFO | 3425: exit 0 15:50:07 INFO - Browser initialized. 15:50:07 INFO - Running cycle 1/1 for kraken test... 15:50:07 INFO - Using env: {'DISPLAY': ':0', 15:50:07 INFO - 'HOME': '/home/cltbld', 15:50:07 INFO - 'JSGC_DISABLE_POISONING': '1', 15:50:07 INFO - 'LANG': 'en_US.UTF-8', 15:50:07 INFO - 'LANGUAGE': 'en_US:en', 15:50:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:50:07 INFO - 'LOGNAME': 'cltbld', 15:50:07 INFO - 'MAIL': '/var/mail/cltbld', 15:50:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:07 INFO - 'MOZ_CRASHREPORTER': '1', 15:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:50:07 INFO - 'MOZ_NO_REMOTE': '1', 15:50:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:07 INFO - 'NO_EM_RESTART': '1', 15:50:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:07 INFO - 'PWD': '/builds/slave/test', 15:50:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:07 INFO - 'RUST_BACKTRACE': 'full', 15:50:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:50:07 INFO - 'SHELL': '/bin/bash', 15:50:07 INFO - 'SHLVL': '1', 15:50:07 INFO - 'STYLO_FORCE_DISABLED': '1', 15:50:07 INFO - 'TERM': 'linux', 15:50:07 INFO - 'TMOUT': '86400', 15:50:07 INFO - 'USER': 'cltbld', 15:50:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452', 15:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:07 INFO - '_': '/tools/buildbot/bin/python'} 15:50:07 INFO - TEST-INFO | started process 3661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVMkSN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:08 INFO - PID 3661 | 15:50:08 INFO - PID 3661 | (/builds/slave/test/build/application/firefox/firefox:3711): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:50:08 INFO - PID 3661 | 15:50:18 INFO - PID 3661 | RSS: Main: 151080960 15:50:18 INFO - PID 3661 | 15:50:21 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58610/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:22 INFO - PID 3661 | RSS: Main: 157470720 15:50:22 INFO - PID 3661 | 15:50:25 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58610/tests/kraken/driver.html?testName=audio-dft) 15:50:25 INFO - PID 3661 | RSS: Main: 157736960 15:50:25 INFO - PID 3661 | 15:50:28 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58610/tests/kraken/driver.html?testName=audio-fft) 15:50:29 INFO - PID 3661 | RSS: Main: 154529792 15:50:29 INFO - PID 3661 | 15:50:31 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58610/tests/kraken/driver.html?testName=audio-oscillator) 15:50:32 INFO - PID 3661 | RSS: Main: 154869760 15:50:32 INFO - PID 3661 | 15:50:34 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58610/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:34 INFO - PID 3661 | RSS: Main: 155049984 15:50:34 INFO - PID 3661 | 15:50:38 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58610/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:38 INFO - PID 3661 | RSS: Main: 157061120 15:50:38 INFO - PID 3661 | 15:50:42 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58610/tests/kraken/driver.html?testName=imaging-desaturate) 15:50:42 INFO - PID 3661 | RSS: Main: 158035968 15:50:42 INFO - PID 3661 | 15:50:45 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58610/tests/kraken/driver.html?testName=json-parse-financial) 15:50:46 INFO - PID 3661 | RSS: Main: 158031872 15:50:46 INFO - PID 3661 | 15:50:48 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58610/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:50:48 INFO - PID 3661 | RSS: Main: 157552640 15:50:48 INFO - PID 3661 | 15:50:50 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:50:50 INFO - PID 3661 | RSS: Main: 157990912 15:50:50 INFO - PID 3661 | 15:50:53 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:50:53 INFO - PID 3661 | RSS: Main: 155115520 15:50:53 INFO - PID 3661 | 15:50:56 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:50:56 INFO - PID 3661 | RSS: Main: 155254784 15:50:56 INFO - PID 3661 | 15:50:59 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:00 INFO - PID 3661 | RSS: Main: 155217920 15:51:00 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:58610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58610/tests/kraken/driver.html?testName=ai-astar) 15:51:02 INFO - PID 3661 | RSS: Main: 156409856 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | __start_tp_report 15:51:02 INFO - PID 3661 | _x_x_mozilla_page_load 15:51:02 INFO - PID 3661 | _x_x_mozilla_page_load_details 15:51:02 INFO - PID 3661 | |i|pagename|runs| 15:51:02 INFO - PID 3661 | |0;ai-astar;109;109;109;107;107;94;110;108;108;108 15:51:02 INFO - PID 3661 | |1;audio-beat-detection;117;124;117;120;117;119;117;145;121;119 15:51:02 INFO - PID 3661 | |2;audio-dft;164;163;163;162;162;162;163;164;170;167 15:51:02 INFO - PID 3661 | |3;audio-fft;74;75;73;73;73;73;75;75;73;74 15:51:02 INFO - PID 3661 | |4;audio-oscillator;80;80;80;78;82;79;79;80;79;79 15:51:02 INFO - PID 3661 | |5;imaging-gaussian-blur;113;114;113;114;115;114;115;114;115;115 15:51:02 INFO - PID 3661 | |6;imaging-darkroom;147;148;149;148;149;150;150;148;149;148 15:51:02 INFO - PID 3661 | |7;imaging-desaturate;100;95;95;93;94;94;96;99;94;95 15:51:02 INFO - PID 3661 | |8;json-parse-financial;54;55;53;52;53;52;52;50;51;52 15:51:02 INFO - PID 3661 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;39;38 15:51:02 INFO - PID 3661 | |10;stanford-crypto-aes;74;74;78;75;74;80;74;81;73;73 15:51:02 INFO - PID 3661 | |11;stanford-crypto-ccm;111;108;108;114;120;111;114;118;118;110 15:51:02 INFO - PID 3661 | |12;stanford-crypto-pbkdf2;180;167;177;171;168;176;172;170;175;171 15:51:02 INFO - PID 3661 | |13;stanford-crypto-sha256-iterative;69;70;67;66;66;66;69;66;71;66 15:51:02 INFO - PID 3661 | __end_tp_report 15:51:02 INFO - PID 3661 | __start_cc_report 15:51:02 INFO - PID 3661 | _x_x_mozilla_cycle_collect,743 15:51:02 INFO - PID 3661 | __end_cc_report 15:51:02 INFO - PID 3661 | __startTimestamp1506120662568__endTimestamp 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | ------- Summary: start ------- 15:51:02 INFO - PID 3661 | Number of tests: 14 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:4.63 (4.2%) stddev-sans-first:4.85 15:51:02 INFO - PID 3661 | Values: 109.0 109.0 109.0 107.0 107.0 94.0 110.0 108.0 108.0 108.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:119.50 stddev:8.53 (7.1%) stddev-sans-first:8.88 15:51:02 INFO - PID 3661 | Values: 117.0 124.0 117.0 120.0 117.0 119.0 117.0 145.0 121.0 119.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.58 (1.6%) stddev-sans-first:2.74 15:51:02 INFO - PID 3661 | Values: 164.0 163.0 163.0 162.0 162.0 162.0 163.0 164.0 170.0 167.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 15:51:02 INFO - PID 3661 | Values: 74.0 75.0 73.0 73.0 73.0 73.0 75.0 75.0 73.0 74.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:80.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 15:51:02 INFO - PID 3661 | Values: 80.0 80.0 80.0 78.0 82.0 79.0 79.0 80.0 79.0 79.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 15:51:02 INFO - PID 3661 | Values: 113.0 114.0 113.0 114.0 115.0 114.0 115.0 114.0 115.0 115.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 15:51:02 INFO - PID 3661 | Values: 147.0 148.0 149.0 148.0 149.0 150.0 150.0 148.0 149.0 148.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.27 (2.4%) stddev-sans-first:1.73 15:51:02 INFO - PID 3661 | Values: 100.0 95.0 95.0 93.0 94.0 94.0 96.0 99.0 94.0 95.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.43 (2.7%) stddev-sans-first:1.39 15:51:02 INFO - PID 3661 | Values: 54.0 55.0 53.0 52.0 53.0 52.0 52.0 50.0 51.0 52.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 15:51:02 INFO - PID 3661 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.50 stddev:2.95 (4.0%) stddev-sans-first:3.07 15:51:02 INFO - PID 3661 | Values: 74.0 74.0 78.0 75.0 74.0 80.0 74.0 81.0 73.0 73.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:114.00 stddev:4.32 (3.8%) stddev-sans-first:4.50 15:51:02 INFO - PID 3661 | Values: 111.0 108.0 108.0 114.0 120.0 111.0 114.0 118.0 118.0 110.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.50 stddev:4.16 (2.4%) stddev-sans-first:3.48 15:51:02 INFO - PID 3661 | Values: 180.0 167.0 177.0 171.0 168.0 176.0 172.0 170.0 175.0 171.0 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.96 (2.9%) stddev-sans-first:2.01 15:51:02 INFO - PID 3661 | Values: 69.0 70.0 67.0 66.0 66.0 66.0 69.0 66.0 71.0 66.0 15:51:02 INFO - PID 3661 | -------- Summary: end -------- 15:51:02 INFO - PID 3661 | 15:51:02 INFO - PID 3661 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:51:03 INFO - TEST-INFO | 3661: exit 0 15:51:03 INFO - TEST-OK | kraken | took 61006ms 15:51:03 INFO - SUITE-END | took 1169s 15:51:03 INFO - Completed test suite (00:19:29) 15:51:03 INFO - javascript benchmark 15:51:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8541.912147293422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.922026949326, 3145.402373549027, 3146.417912686153, 3150.858211380488, 3151.038933125396, 6199.783007594735, 6231.688415579214, 6272.466840318572, 6350.14273073135, 6372.872542549152, 6245.781397651083, 6291.465225455841, 6302.306746257919, 6316.621002739839, 6355.142055822463, 5664.320281566218, 5750.597458177929, 5758.395368486312, 5779.3642699303045, 5818.0, 5863.061910094386, 5873.236479257691, 5880.2355693759755, 5901.940980590203, 5904.675242861641, 5777.740001699913, 5876.676782776945, 5927.2294601701715, 5928.88142237155, 5929.110633404981, 5290.502740233457, 5596.384397716248, 5735.627184233012, 5816.302043754777, 5839.941600583982, 5734.741936612862, 5744.798932037359, 5812.215350927613, 5817.185594016841, 5822.475977162034, 6166.383361663842, 6217.0052791553135, 6276.905846412307, 6305.59013664115, 6385.808425747235, 6593.93406065938, 6625.4037136657935, 6648.069270302113, 6667.099941507883, 6675.532712710112, 6647.900281495781, 6700.664966751643, 6745.898811517831, 6848.760293389708, 6856.760013399507, 6260.655663938482, 6270.592411493239, 6341.8414539636415, 6346.01636746305, 6354.5551811373225, 6858.759943402057, 6968.233494315621, 7030.789076327718, 7045.753398631024, 7068.575885446787, 6336.873262534724, 6419.358064193543, 6459.483241340681, 6473.676316184172, 6734.0, 6535.901961470582, 6610.272869984298, 6690.866182676319, 6691.130153080068, 6729.024291477708, 6600.570962887493, 6606.240282367493, 6611.33886611335, 6620.172478440195, 6622.437092847065, 6548.738050478023, 6565.080888675589, 6565.868682626321, 6635.336466353326, 6639.0, 5090.160123579568, 5160.225966105039, 5180.715060671624, 5242.606804489678, 5271.3674359076385, 4527.977360113178, 4601.056783359403, 4663.556962088596, 4676.579107880307, 4696.459907110726, 5755.913661295084, 5756.740946657411, 5802.680852553066, 5821.18503409523, 5839.386864379264, 6746.392824645805, 6789.864202716017, 6864.2106157791495, 6867.622280774505, 6890.069840571559, 5654.321481422256, 5741.684207368635, 5754.108113242454, 5762.308522977186, 5833.212516310244, 5730.799422020209, 5796.333421656479, 5798.420157984252, 5798.5651076168615, 5808.88382232353, 6362.586431881913, 6445.484361251089, 6569.080328753978, 6575.934240657628, 6578.572392794453, 6734.8653026940165, 6759.966200169164, 6804.183497980274, 6882.655867206619, 6901.896471553031, 6393.456556192776, 6517.120188774455, 6519.185101862267, 6602.273749887412, 6618.0403841443685, 6530.8040758777315, 6621.172353455818, 6641.169853768279, 6643.534952553468, 6649.900251496135, 6794.694238759169, 6826.897596536155, 6903.482238832208, 6918.273581274095, 6929.7921062366195, 6572.605643661395, 6579.309172536815, 6652.800415987528, 6661.467082633475, 6662.56693314933, 6455.48356131499, 6551.80344589663, 6566.409023187936, 6577.0, 6672.699728512326, 6339.873202535831, 6401.711922963571, 6410.935890641033, 6427.228732552124, 6434.517411194272, 6528.869422611616, 6575.572587781779, 6593.142891424084, 6660.167479065117, 6688.197416310074, 6378.77674281398, 6384.712687929147, 6436.806895793134, 6457.870842583216, 6472.644004579794], "value": 6123.791328142664, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.6957217113154, 798.836238571093, 801.3188789528901, 805.198827166969, 805.9597020148991, 39129.60870391295, 42848.14303713924, 42968.0, 42972.785136074315, 43128.13743725127, 38321.808390958075, 38576.22847543047, 38594.0, 38681.80659096708, 38693.419598706045, 7079.469039822021, 7193.748218812342, 7200.063991681074, 7200.963995180043, 7795.532268063906, 7769.456138070337, 7998.720044798433, 7999.680012799481, 7999.880001799977, 8006.319462845665, 7903.920960790405, 7955.681772729084, 7959.243871832166, 7975.361971042303, 7998.1601931797195, 7927.96036019822, 7930.246626570467, 7958.084820245659, 7981.96009019957, 7985.321247693924, 7773.766786996399, 7883.172266911949, 7895.565743884084, 7898.842023159562, 7899.881501777478, 38040.23919521594, 38338.42492362617, 38385.61614383848, 38467.230655387015, 38470.03824904372, 3523.1896663767475, 3557.288542291526, 3560.857565697395, 3561.679448849616, 3564.3049605326974, 31763.682363176304, 31899.681003189904, 31936.361272774415, 31968.0, 32009.0, 5036.924446133275, 5176.689398636094, 5208.322918020671, 5246.685198888079, 5260.079486089919, 184040.0, 185085.0, 185508.0, 185677.0, 185811.0, 41844.58155418407, 48034.75982620064, 48278.27582586264, 48323.75838120857, 48349.75825120852, 43563.346549801776, 43644.78177609092, 51059.74470127626, 52010.739946300026, 52029.2195617066, 15649.061056336655, 15670.529884103495, 15703.057816530816, 15750.0, 15797.763033554505, 12667.556635517896, 12675.11274210815, 12687.175333603287, 12692.49230030807, 12696.619101426972, 13653.04428690002, 13714.725705486035, 13839.308034598229, 13893.374798134108, 14054.508092216724, 5459.672419654833, 5521.475459831309, 5535.6955367455175, 5624.240727501817, 5627.774889004476, 1025.5128813813378, 1029.7528593137743, 1036.512838965685, 1038.6105210546045, 1043.436544266103, 22395.21616743406, 22660.660090098663, 22699.659505107436, 23011.194608188634, 23452.179173728837, 1129.6611016695124, 1145.3814939932342, 1153.0890596428894, 1159.9478023488964, 1163.8196079607505, 12204.572839950737, 12239.510419583117, 12284.570040048555, 12321.753564928651, 12391.442385092512, 224258.0, 225385.0, 226460.0, 227091.0, 228382.0, 52308.47691523112, 52460.47539524632, 52518.737406313485, 52627.47372526226, 52877.47122528803, 1443.3432788081188, 1450.1371683848095, 1477.8078849749463, 1490.1878476230481, 1500.129924643704, 22725.659115112954, 22962.19632312861, 23116.19093331725, 23162.0, 23345.0, 37680.24639507139, 37838.43242351422, 37843.43234851534, 37849.0, 37883.24233515369, 198736.0, 198743.0, 199105.0, 199651.0, 199950.0, 29932.55101173528, 30593.694063059083, 34323.485147722306, 34550.30899382049, 35129.29741405209, 43503.347449787645, 43727.56272437235, 44015.55984440243, 44149.33775993427, 44757.77621111873, 32421.837890810395, 32777.18057048593, 32925.0, 32963.835180823946, 33326.16684582905, 32038.35923281568, 32198.0, 32539.34921301608, 32797.18007049843, 33155.83422082874, 35698.0, 36068.45897311595, 36290.0, 36310.636893630726, 36344.636553634125, 31729.365412692077, 31917.68082319147, 32067.198320042186, 32162.0, 32299.928621700416, 23424.6486302709, 23530.411739706644, 23717.407064823517, 23730.288091357288, 23849.880750596138], "value": 17083.490715950116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.138377277289, 590.9320428150761, 594.9702514874256, 603.4930658247073, 617.8826023055619, 22126.33620991371, 22894.77105228947, 22899.656505152438, 22928.082876684955, 23116.07535698574, 21769.673454898188, 21891.12435502578, 22502.0, 22653.54692906141, 22718.318450446513, 6654.733810647568, 6827.249002609709, 6841.144856892888, 6847.452203823707, 6848.623325717083, 6424.453921416685, 6696.631685257309, 6733.663316834139, 6734.56225345351, 6792.150981127359, 6687.097241872358, 6691.330866913294, 6694.364035416627, 6696.06255124283, 6702.966485167592, 6685.130932978682, 6689.565178263398, 6695.096162018138, 6714.899276510856, 6727.8318042049095, 6206.317305096436, 6239.188905442309, 6239.844003899893, 6240.31356550779, 6249.593776404519, 27321.45357092867, 27995.86002069997, 28114.859425702944, 28348.716512834813, 28772.856135719187, 2103.316422162803, 2125.4048866317457, 2125.553633736917, 2126.797954194349, 2131.8507704460694, 15620.140892250922, 16527.586810329718, 18761.15574799137, 19110.23559057636, 20035.09842057111, 2461.643061756053, 2469.9012039518398, 2511.6483692283095, 2536.961945570818, 2550.681164854393, 114456.0, 121630.0, 121984.0, 126620.99999999908, 137121.0, 14797.852021479648, 14864.097120473521, 14924.552263432115, 14964.952453328162, 15435.768463473058, 22486.550268994855, 22493.32520024402, 22544.323670289916, 22697.886510567343, 22698.43253918665, 9787.853182202272, 9918.900810991941, 10000.649977250761, 10084.49577521121, 10086.697399078039, 9076.591553380114, 9172.403793753385, 9185.265178785681, 9199.816003679889, 9327.906720932839, 9013.233875120557, 9030.954845225731, 9048.547572621474, 9175.17423431881, 9205.217556507638, 2670.8664566771586, 2684.3960108975716, 2700.693137983871, 2727.2500062482977, 2727.9181624551297, 963.677168148664, 981.6760469045198, 984.1880448629909, 998.8501724741202, 1000.5847573257163, 19241.90379048096, 19643.31248406299, 19663.0, 19798.109085091204, 19963.700544491843, 1019.7705516258931, 1039.0, 1049.0715716590719, 1049.7900419916048, 1053.1311667874033, 10111.949440252898, 10864.837027444595, 10882.0, 11028.12236149907, 11122.110231181487, 477122.0, 478773.0, 485770.0, 490756.0, 491988.0, 107470.46264768626, 109686.0, 112007.0, 112407.43796280966, 112491.4375428134, 1174.7885380631396, 1190.976180476403, 1192.0463629096687, 1193.0276824388095, 1197.3115458611333, 17371.82628173702, 17413.0, 17502.562435938693, 17639.647207055532, 17762.0, 52257.73871130772, 52508.0, 52647.0, 53207.46792532025, 53754.0, 68159.0, 68175.31824681888, 68624.6568767153, 69246.30753692398, 69254.65372673105, 14341.92829035848, 14574.562763117123, 14642.780358294847, 14644.12135271887, 14657.04729192599, 22282.331530054125, 22367.664485033063, 22377.776222237568, 22494.550108998057, 22689.659655104857, 17669.91165044218, 18232.726509102107, 18312.08439577989, 18330.450086497425, 18525.9073704636, 16114.0, 16214.51356459308, 16258.0, 16746.413875514787, 17079.31682732677, 17199.484015479557, 18083.909580452015, 18191.636167276316, 18311.816881831543, 18375.632487350445, 14087.084339517898, 14102.929485352917, 14112.364943577359, 14262.144271343752, 14264.857351426353, 17574.945503269846, 17654.911725441292, 17723.645527089127, 17735.645287094445, 17852.19665115099], "value": 11804.432139372322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.6516173214097, 1356.941585563261, 1359.1709057474945, 1373.8007988841618, 1386.140592832444, 14935.253237338131, 15671.92164039181, 15688.45090421834, 15703.371865125395, 15720.921395393007, 15261.016067911183, 15506.84493155068, 15538.766918496203, 15552.766708499381, 15568.0, 2844.886204551826, 2848.686644469107, 2893.5514995175677, 2894.044965161502, 2898.9710102899016, 2776.47247023065, 2809.044924725593, 2831.348789778352, 2838.361368692038, 2838.6735525414633, 2718.075854209568, 2783.554631258999, 2831.8159319644155, 2833.4049849531625, 2835.588839618254, 2741.8080734348605, 2781.2490627530556, 2781.5271403861393, 2786.8327900326044, 2788.888444462219, 2593.922182334533, 2696.9325766855986, 2738.2606696192115, 2752.9036483722975, 2757.3658058646624, 15334.0, 15430.459933902259, 15471.149086800222, 15482.690346193125, 15495.22523873813, 7938.801529961797, 8224.753257402288, 8242.258196762321, 8251.133630968721, 8251.33989280856, 5273.1035723927025, 5460.262864513319, 5522.585806064561, 5529.281193444866, 5536.446355364431, 1874.8500119990504, 1900.4108726294892, 1917.5973045660428, 1939.5151212196952, 1944.6402415553027, 27843.443131137465, 28141.29646758827, 28183.71816281852, 28194.154175374773, 28202.294942626395, 6868.244493105754, 7030.367266945999, 7136.892946605805, 7144.714211431588, 7212.783616491513, 17855.73216401755, 17895.0, 17898.10509474521, 17899.821001790075, 18521.629567408847, 7802.336801371834, 8106.270435660701, 8155.306798922039, 8156.0, 8165.2243036911395, 7266.200717921024, 7468.775936721907, 7468.775936721907, 7480.952666626677, 7547.471676982558, 5062.417821950449, 5271.578273738169, 5291.3385826771655, 5297.867553311198, 5305.389880163753, 1572.0, 1591.7214487464878, 1601.455505128262, 1619.4251040880554, 1623.310093210381, 833.5165603949816, 839.3327304792705, 853.6585365853708, 854.0562678240578, 865.3207232322596, 6919.135108111486, 6986.476014298846, 6997.230304666483, 7057.400120989773, 7063.717451301993, 704.8766465868453, 720.6865013719049, 724.7970568240901, 733.2813842434444, 753.7211231844143, 4266.935995960063, 4268.573142685706, 4273.572642735764, 4281.186574550888, 4290.978545107255, 21833.454163645718, 22303.55392892133, 22343.44141396478, 22525.549489010456, 22622.547549048926, 20795.68806467904, 21263.574728505653, 21744.673829892563, 22093.779062209494, 22095.116195352006, 11467.598634047936, 11528.711782205512, 11533.135014873918, 11547.249428787101, 11555.017823485097, 7045.401140903081, 7414.518056326321, 7622.390208783395, 7672.0, 7736.690532378641, 18456.26174952987, 18492.722609160603, 18890.52773680669, 18917.148728307533, 19130.139143738288, 19542.609147816678, 19593.608127837648, 19617.41147765512, 19774.70337944961, 20285.188592456725, 11121.110311175249, 11276.718082048015, 11303.1522635801, 11328.207025508136, 11329.71675708114, 14116.435342586181, 14131.717365652425, 14229.786553201917, 14289.857101428852, 14293.35679894428, 11217.49521271561, 11653.708657283636, 11694.415279235835, 11859.703507412383, 11948.820767688318, 11216.66350009501, 11366.318020918772, 11413.828792568283, 11469.369184694922, 11688.18182727201, 9141.588628511867, 9148.496832674267, 9188.908110918805, 9206.631734730536, 9208.217301529177, 6638.83402914931, 6653.667316634246, 6695.8326041847395, 6715.597064176165, 6801.319868013159, 6299.6535190564955, 6303.779367722108, 6309.810705678837, 6312.589681670676, 6321.652309123042], "value": 6599.760436738349, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.9981237150442, 512.4926322940288, 524.0746806419914, 543.540708101654, 548.3721139295504, 6100.359462256466, 6235.812925612233, 6317.652529110897, 6323.74705011799, 6361.278651988592, 6023.909641355383, 6043.316429766933, 6100.633961962285, 6161.630302181872, 6188.628682279066, 4981.551660350577, 5007.2489126630935, 5026.271190677349, 5043.218301163307, 5053.6715113517685, 4873.537013983666, 5071.923921141186, 5074.5432911038, 5077.238414237857, 5099.796008159669, 5037.697738135724, 5043.798248070073, 5052.343195384595, 5053.77258023388, 5060.038592667382, 5000.824971126011, 5004.774785134678, 5048.1670524363435, 5066.341375621182, 5068.378119001921, 4558.202314594932, 4574.153781550423, 4584.7936842842155, 4586.701864378805, 4594.150082234797, 5990.191324171225, 6079.449740316235, 6125.938740612582, 6239.469645080128, 6283.340249273806, 5766.192733017381, 5766.913496297559, 5777.7977770777825, 5792.536597072224, 5807.477327040587, 6607.735690572371, 6618.63597502142, 6621.172353455818, 6634.137562116894, 6645.501587380966, 4939.604831613462, 4951.603871690292, 4963.40439147301, 4968.87577810554, 4985.476524964863, 6890.655467226618, 6930.965345173292, 6960.582365058062, 6984.406325462342, 6985.930140698579, 5006.424261209934, 5008.524190201925, 5055.772490237948, 5077.796888124508, 5086.21163719624, 5166.509181627739, 5188.0661480933795, 5188.584913206934, 5198.766055527435, 5205.115130427836, 5700.543956483471, 5709.65742055478, 5722.885542289131, 5738.713064346766, 5749.712514374264, 6191.349908259658, 6297.149884765498, 6506.707198176094, 6611.239707433707, 6667.499812542139, 1722.6124122072683, 1750.431109889291, 1760.9207585658676, 1768.2838450427598, 1773.6541374431863, 1066.7119877632995, 1197.592818441734, 1227.472186959616, 1249.9812502812465, 1251.3743128435783, 5553.527950124204, 5679.290088738908, 5697.800576979786, 5701.600887937888, 5708.230448560959, 6614.570052946543, 6673.833154171185, 6721.8743284373, 6725.529212955046, 6780.457563394916, 5708.828735137952, 5777.913331300034, 5794.855128621818, 5800.53595712342, 5806.912896306559, 3545.4859045438266, 3583.605803361628, 3599.964000359963, 3607.6211997740384, 3624.7100231981376, 6421.51838612106, 6440.4847612190915, 6453.4506021687885, 6562.310957349505, 6596.604203747695, 6775.62734049632, 6782.287859774751, 6793.592384456949, 6839.179298484114, 6844.486663500158, 6473.546851720429, 6480.384363485367, 6501.414872661483, 6545.280019197884, 6550.475961923034, 6562.77030303937, 6623.304553022056, 6631.972044333136, 6722.831929201809, 6747.392734653905, 6475.579087359307, 6488.772892948724, 6663.766768163091, 6666.666666666551, 6740.618173274565, 6418.6469744164515, 6438.0, 6453.9354606453335, 6539.4768418525455, 6570.357410647338, 5065.8733531662, 5080.669756465818, 5090.312807770903, 5093.4651861554, 5097.260897169964, 6692.582895289281, 6764.594124352555, 6830.453563714792, 6846.931530684629, 6882.208546017272, 6390.274625850901, 6411.51913606472, 6448.29068802422, 6451.225852897683, 6527.184101987252, 6271.184745983175, 6342.556021078664, 6377.426031657174, 6453.645049522322, 6485.740570377132, 6345.302016778243, 6348.048522152728, 6355.586886852339, 6434.935650643433, 6438.259600145856, 6140.201773769381, 6465.515086368447, 6474.0, 6518.282988871315, 6542.607443553402, 6164.938350616616, 6220.440160385587, 6234.2830574482705, 6261.78083767066, 6370.904436433365], "value": 5065.641076543827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.358615383078, 914.1635403605693, 923.755204870709, 925.0240995749485, 933.6732143749687, 19948.401547953566, 19975.800241997575, 20226.595468090647, 20311.984400779977, 20335.0, 18940.337088201915, 19148.80851191488, 19225.423237302904, 19243.51891202717, 19315.323963661238, 968.2834702320285, 988.5106872098286, 1000.4297550396277, 1000.8999100089969, 1001.1190152665644, 946.0728486083642, 982.1602529836994, 992.9602815887356, 996.5366104761284, 997.316837965992, 1061.4374381577777, 1062.914966802654, 1066.7439814444517, 1066.8879767624403, 1070.2829104499965, 994.9801003979879, 1024.2011231239644, 1028.5577201803221, 1038.3406536849118, 1043.942583157926, 749.7151082588636, 749.83128796021, 751.2787723785173, 752.0486584470649, 756.6897571995511, 20583.485412864648, 20809.89595052015, 20824.271150509812, 20826.16695332185, 20838.0, 20833.0, 22117.66823497649, 22302.55394892093, 22306.776932230634, 22372.88813555938, 17133.485995420157, 17491.5627109322, 17504.0, 17511.036892970882, 17616.0, 3750.1562148516637, 3778.112143646241, 3781.035835861865, 3787.2425514896854, 3795.278897009587, 140839.0, 140983.29508352495, 141880.0, 142439.0, 143941.0, 16895.577610559834, 17429.0, 17546.034968076878, 17554.561135971446, 17565.560860978578, 31042.379152416826, 32413.35173296568, 32678.346433071205, 32712.182195445304, 32752.344953100805, 8327.541985190752, 8367.414281000394, 8551.529665868313, 8563.571821408905, 8576.614052367659, 4378.934315985262, 4514.458265008155, 4516.07420478801, 4517.051419201939, 4533.229351010336, 5559.972200139055, 5656.604037717402, 5673.375928647845, 5678.659280443104, 5687.51656109227, 997.5112195024386, 1004.8040632076821, 1036.3367444835312, 1037.9273450858368, 1040.5785656809005, 669.1234482827512, 689.9275576064541, 700.719712115158, 709.3048812164108, 709.3828369318622, 11172.0, 11208.0, 11249.66251012471, 11726.179167458367, 12084.274943503242, 658.6114192626374, 658.7957733102753, 666.1839246922578, 677.6002158726375, 679.2731776998564, 5145.562627176732, 5155.74221288934, 5184.274201611777, 5273.736313184326, 5288.2596436498925, 118644.0, 121017.0, 124424.37787811003, 124904.0, 127137.0, 103323.0, 106627.46686266674, 111420.44289778499, 112317.0, 112674.0, 95993.52003240079, 96286.51856740811, 96744.0, 98544.0, 101817.0, 11713.355765432641, 12034.578789742667, 12171.634850954486, 12199.0, 12434.502619895104, 42354.77520510837, 42391.57608424, 42673.57326426696, 43169.784151079046, 45440.31839522476, 76090.0, 77742.0, 78082.6095869517, 79760.60119699364, 83221.0, 19347.226110955406, 19507.0, 19613.607727845647, 19701.901490492455, 19731.210751569775, 21835.344939651837, 22133.225337113767, 22713.659295110916, 22714.43213919665, 22743.431414214778, 17870.285188592312, 18250.36123735663, 18251.269949201884, 18451.72322415138, 18470.81529184691, 18244.543886402415, 18494.0, 18871.811281887556, 18992.620147596695, 19131.713024304925, 17434.564135896704, 17768.289268429635, 17801.554961126076, 18054.81945180584, 18082.819171808114, 13218.60344189676, 13509.121907076009, 13513.527026554024, 13589.52436664712, 13629.228200333893, 12258.387080646111, 13169.53906613264, 13483.662908427368, 13842.723145537235, 13884.0], "value": 9408.061506553351, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 109.0, 107.0, 107.0, 94.0, 110.0, 108.0, 108.0, 108.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 124.0, 117.0, 120.0, 117.0, 119.0, 117.0, 145.0, 121.0, 119.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 162.0, 162.0, 163.0, 164.0, 170.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 73.0, 73.0, 73.0, 75.0, 75.0, 73.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 78.0, 82.0, 79.0, 79.0, 80.0, 79.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 149.0, 150.0, 150.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 93.0, 94.0, 94.0, 96.0, 99.0, 94.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 52.0, 53.0, 52.0, 52.0, 50.0, 51.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 75.0, 74.0, 80.0, 74.0, 81.0, 73.0, 73.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 108.0, 114.0, 120.0, 111.0, 114.0, 118.0, 118.0, 110.0], "value": 113.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 167.0, 177.0, 171.0, 168.0, 176.0, 172.0, 170.0, 175.0, 171.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 66.0, 66.0, 66.0, 69.0, 66.0, 71.0, 66.0], "value": 67.6, "unit": "score"}]}]} 15:51:03 INFO - Return code: 0 15:51:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:51:03 INFO - # TBPL SUCCESS # 15:51:03 INFO - Running post-action listener: _package_coverage_data 15:51:03 INFO - Running post-action listener: _resource_record_post_action 15:51:03 INFO - [mozharness: 2017-09-22 22:51:03.862416Z] Finished run-tests step (success) 15:51:03 INFO - Running post-run listener: _resource_record_post_run 15:51:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346251264; Read time: 12; Write time: 319668 15:51:03 INFO - TinderboxPrint: CPU usage
13.1% 15:51:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:51:03 INFO - TinderboxPrint: I/O write bytes / time
346,251,264 / 319,668 15:51:03 INFO - TinderboxPrint: CPU idle
8,227.5 (86.9%) 15:51:03 INFO - TinderboxPrint: CPU user
1,193.8 (12.6%) 15:51:03 INFO - TinderboxPrint: Swap in / out
0 / 0 15:51:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 22409216; Read time: 0; Write time: 6024 15:51:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:51:03 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 323842048; Read time: 0; Write time: 313644 15:51:04 INFO - Running post-run listener: _upload_blobber_files 15:51:04 INFO - Blob upload gear active. 15:51:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:51:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:51:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:05 INFO - (blobuploader) - INFO - Done attempting. 15:51:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:51:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:06 INFO - (blobuploader) - INFO - Done attempting. 15:51:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:51:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:07 INFO - (blobuploader) - INFO - Done attempting. 15:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:14 INFO - (blobuploader) - INFO - Done attempting. 15:51:14 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:14 INFO - Return code: 0 15:51:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f12610dc8ebf7fe2c2786cfe1dfac440ae4574dd1c2c10506d33dc6d6cfd14d943090a5908f63e4850ed7cc6711a3b119570e0eee408144f81d0b656958fbf24", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d47cfa912614a0597ad78899b8131a0e7de6a389f97ac80573b0d5687ce723e25aef1cdae6996a1ea127b17a6e5e5e405d34a615ff45556e6954041e5aa77f8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1f6683b448c34bbc58b8cb7053a3d3cf7f5d9ddee0d6f62fb762f23d0fb66c768fac93f69ba45f8d40b87bb500f3a91d7500a24c2dff6234cea3f9e83a83f27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/255bc7036a85010d7903c662af95914af4ea5a14605126ec31d33c13ecc406d3c2afe4773d2aa5bc337e0cadd929da6acc2cb79d19b6535400a23a766ecc5659"} 15:51:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:14 INFO - Contents: 15:51:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f12610dc8ebf7fe2c2786cfe1dfac440ae4574dd1c2c10506d33dc6d6cfd14d943090a5908f63e4850ed7cc6711a3b119570e0eee408144f81d0b656958fbf24", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d47cfa912614a0597ad78899b8131a0e7de6a389f97ac80573b0d5687ce723e25aef1cdae6996a1ea127b17a6e5e5e405d34a615ff45556e6954041e5aa77f8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1f6683b448c34bbc58b8cb7053a3d3cf7f5d9ddee0d6f62fb762f23d0fb66c768fac93f69ba45f8d40b87bb500f3a91d7500a24c2dff6234cea3f9e83a83f27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/255bc7036a85010d7903c662af95914af4ea5a14605126ec31d33c13ecc406d3c2afe4773d2aa5bc337e0cadd929da6acc2cb79d19b6535400a23a766ecc5659"} 15:51:14 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:14 INFO - Copying logs to upload dir... 15:51:14 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.240114 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-22 15:51:14.816397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 15:51:14.821061) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f12610dc8ebf7fe2c2786cfe1dfac440ae4574dd1c2c10506d33dc6d6cfd14d943090a5908f63e4850ed7cc6711a3b119570e0eee408144f81d0b656958fbf24", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d47cfa912614a0597ad78899b8131a0e7de6a389f97ac80573b0d5687ce723e25aef1cdae6996a1ea127b17a6e5e5e405d34a615ff45556e6954041e5aa77f8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1f6683b448c34bbc58b8cb7053a3d3cf7f5d9ddee0d6f62fb762f23d0fb66c768fac93f69ba45f8d40b87bb500f3a91d7500a24c2dff6234cea3f9e83a83f27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/255bc7036a85010d7903c662af95914af4ea5a14605126ec31d33c13ecc406d3c2afe4773d2aa5bc337e0cadd929da6acc2cb79d19b6535400a23a766ecc5659"} build_url:https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/e1Vm0nnPTMG3de0u1_1tzQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f12610dc8ebf7fe2c2786cfe1dfac440ae4574dd1c2c10506d33dc6d6cfd14d943090a5908f63e4850ed7cc6711a3b119570e0eee408144f81d0b656958fbf24", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d47cfa912614a0597ad78899b8131a0e7de6a389f97ac80573b0d5687ce723e25aef1cdae6996a1ea127b17a6e5e5e405d34a615ff45556e6954041e5aa77f8", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1f6683b448c34bbc58b8cb7053a3d3cf7f5d9ddee0d6f62fb762f23d0fb66c768fac93f69ba45f8d40b87bb500f3a91d7500a24c2dff6234cea3f9e83a83f27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/255bc7036a85010d7903c662af95914af4ea5a14605126ec31d33c13ecc406d3c2afe4773d2aa5bc337e0cadd929da6acc2cb79d19b6535400a23a766ecc5659"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 15:51:14.850564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:51:14.850953) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506119434.999639-515697452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:51:14.935474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 15:51:14.935795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 15:51:14.936112) ========= ========= Total master_lag: 0.55 =========