builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1506536845.01 results: success (0) revision: 756e10aa8bbd416cbc49b7739f78fb81d5525477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.006609) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.007063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.007385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.067546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.067878) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:27:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-09-27 11:27:25 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131110 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.257100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.257414) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014877 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:25.334808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-27 11:27:25.335138) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 756e10aa8bbd416cbc49b7739f78fb81d5525477 --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 756e10aa8bbd416cbc49b7739f78fb81d5525477 --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=20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:27:25,758 truncating revision to first 12 chars 2017-09-27 11:27:25,758 Setting DEBUG logging. 2017-09-27 11:27:25,758 attempt 1/10 2017-09-27 11:27:25,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/756e10aa8bbd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:27:26,465 attempt 1/10 2017-09-27 11:27:27,228 current task status: no status available at this point. state: STARTED 2017-09-27 11:27:27,229 sleeping for 9.00s (attempt 1/10) 2017-09-27 11:27:36,238 attempt 2/10 2017-09-27 11:27:36,576 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-27 11:27:36,755 unpacking tar archive at: mozilla-central-756e10aa8bbd/testing/mozharness/ program finished with exit code 0 elapsedTime=11.270606 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-27 11:27:36.642240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:36.642537) ========= script_repo_revision: 756e10aa8bbd416cbc49b7739f78fb81d5525477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:36.645971) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:36.646285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:27:36.660036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-27 11:27:36.660353) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:27:37 INFO - MultiFileLogger online at 20170927 11:27:37 in /builds/slave/test 11:27:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:27:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:27:37 INFO - {'append_to_log': False, 11:27:37 INFO - 'base_work_dir': '/builds/slave/test', 11:27:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:27:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:27:37 INFO - 'branch': 'Firefox-Non-PGO', 11:27:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:27:37 INFO - 'code_coverage': False, 11:27:37 INFO - 'config_files': ('talos/linux_config.py',), 11:27:37 INFO - 'default_actions': ('clobber', 11:27:37 INFO - 'read-buildbot-config', 11:27:37 INFO - 'download-and-extract', 11:27:37 INFO - 'populate-webroot', 11:27:37 INFO - 'create-virtualenv', 11:27:37 INFO - 'install', 11:27:37 INFO - 'setup-mitmproxy', 11:27:37 INFO - 'run-tests'), 11:27:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:27:37 INFO - 'disable_ccov_upload': False, 11:27:37 INFO - 'disable_stylo': False, 11:27:37 INFO - 'download_minidump_stackwalk': True, 11:27:37 INFO - 'download_symbols': 'ondemand', 11:27:37 INFO - 'enable_stylo': False, 11:27:37 INFO - 'enable_webrender': False, 11:27:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:27:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:27:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:27:37 INFO - 'gecko_profile': False, 11:27:37 INFO - 'gecko_profile_interval': 0, 11:27:37 INFO - 'installer_path': 'installer.exe', 11:27:37 INFO - 'log_level': 'info', 11:27:37 INFO - 'log_name': 'talos', 11:27:37 INFO - 'log_to_console': True, 11:27:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:27:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:27:37 INFO - 'opt_config_files': (), 11:27:37 INFO - 'pip_index': False, 11:27:37 INFO - 'suite': 'dromaeojs-e10s', 11:27:37 INFO - 'system_bits': '32', 11:27:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:27:37 INFO - 'title': 'talos-linux64-ix-077', 11:27:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:27:37 INFO - 'use_talos_json': True, 11:27:37 INFO - 'verify': 'False', 11:27:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:27:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:27:37 INFO - 'work_dir': 'build'} 11:27:37 INFO - [mozharness: 2017-09-27 18:27:37.199066Z] Running clobber step. 11:27:37 INFO - Running pre-action listener: _resource_record_pre_action 11:27:37 INFO - Running main action method: clobber 11:27:37 INFO - rmtree: /builds/slave/test/build 11:27:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:27:38 INFO - Running post-action listener: _resource_record_post_action 11:27:38 INFO - [mozharness: 2017-09-27 18:27:38.198480Z] Finished clobber step (success) 11:27:38 INFO - [mozharness: 2017-09-27 18:27:38.198578Z] Running read-buildbot-config step. 11:27:38 INFO - Running pre-action listener: _resource_record_pre_action 11:27:38 INFO - Running main action method: read_buildbot_config 11:27:38 INFO - Using buildbot properties: 11:27:38 INFO - { 11:27:38 INFO - "project": "", 11:27:38 INFO - "product": "firefox", 11:27:38 INFO - "who": "ffxbld@noreply.mozilla.org", 11:27:38 INFO - "installer_path": "public/build/target.tar.bz2", 11:27:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:27:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:27:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:27:38 INFO - "stage_platform": "linux64", 11:27:38 INFO - "basedir": "/builds/slave/test", 11:27:38 INFO - "buildnumber": 873, 11:27:38 INFO - "platform": "ubuntu64_hw", 11:27:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:27:38 INFO - "slavebuilddir": "test", 11:27:38 INFO - "taskId": "Vxj6-4GySoWvzgmrwIr8hw", 11:27:38 INFO - "branch": "mozilla-central", 11:27:38 INFO - "script_repo_revision": "production", 11:27:38 INFO - "revision": "756e10aa8bbd416cbc49b7739f78fb81d5525477", 11:27:38 INFO - "slavename": "talos-linux64-ix-077", 11:27:38 INFO - "repo_path": "mozilla-central" 11:27:38 INFO - } 11:27:38 INFO - Finding installer, test and symbols from parent task. 11:27:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vxj6-4GySoWvzgmrwIr8hw'}, attempt #1 11:27:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vxj6-4GySoWvzgmrwIr8hw'}, attempt #1 11:27:39 INFO - Task dependencies: d8mZXx0pQCyLHthBkHAPng 11:27:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng'}, attempt #1 11:27:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:27:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json 11:27:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip 11:27:39 INFO - Running post-action listener: _resource_record_post_action 11:27:39 INFO - [mozharness: 2017-09-27 18:27:39.550925Z] Finished read-buildbot-config step (success) 11:27:39 INFO - [mozharness: 2017-09-27 18:27:39.551142Z] Running download-and-extract step. 11:27:39 INFO - Running pre-action listener: _resource_record_pre_action 11:27:39 INFO - Running main action method: download_and_extract 11:27:39 INFO - mkdir: /builds/slave/test/build/tests 11:27:39 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')]} 11:27:39 INFO - trying https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json 11:27:39 INFO - Downloading https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:27:40 INFO - Downloaded 989 bytes. 11:27:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:27:40 INFO - Using the following test package requirements: 11:27:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:27:40 INFO - u'common': [u'target.common.tests.zip'], 11:27:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:27:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:27:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:27:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:27:40 INFO - u'mozbase': [u'target.common.tests.zip'], 11:27:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:27:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:27:40 INFO - u'web-platform': [u'target.common.tests.zip', 11:27:40 INFO - u'target.web-platform.tests.tar.gz'], 11:27:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:27:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:27:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.common.tests.zip 11:27:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:27:40 INFO - Fetch https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.common.tests.zip into memory 11:27:41 INFO - Content-Length response header: 54946080 11:27:41 INFO - Bytes received: 54946080 11:27:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.talos.tests.zip 11:27:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:27:52 INFO - Fetch https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.talos.tests.zip into memory 11:27:52 INFO - Content-Length response header: 14513665 11:27:52 INFO - Bytes received: 14513665 11:27: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')]} 11:27:53 INFO - trying https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:28:01 INFO - Downloaded 61658681 bytes. 11:28:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:28:01 INFO - mkdir: /builds/slave/test/properties 11:28:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:28:01 INFO - Writing to file /builds/slave/test/properties/build_url 11:28:01 INFO - Contents: 11:28:01 INFO - build_url:https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 11:28:01 INFO - Running post-action listener: _resource_record_post_action 11:28:01 INFO - Running post-action listener: find_tests_for_verification 11:28:01 INFO - Running post-action listener: set_extra_try_arguments 11:28:01 INFO - [mozharness: 2017-09-27 18:28:01.981505Z] Finished download-and-extract step (success) 11:28:01 INFO - [mozharness: 2017-09-27 18:28:01.981604Z] Running populate-webroot step. 11:28:01 INFO - Running pre-action listener: _resource_record_pre_action 11:28:01 INFO - Running main action method: populate_webroot 11:28:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:28:01 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['tresize', 11:28:01 INFO - 'tcanvasmark']}, 11:28:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:28:01 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['dromaeo_css', 11:28:01 INFO - 'kraken']}, 11:28:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:01 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'tests': ['damp', 'tps']}, 11:28:01 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['damp', 'tps']}, 11:28:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:28:01 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['dromaeo_dom']}, 11:28:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:28:01 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['basic_compositor_video', 11:28:01 INFO - 'glvideo']}, 11:28:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:28:01 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['ts_paint_webext', 11:28:01 INFO - 'tp5o_webext']}, 11:28:01 INFO - 'other-e10s': {'tests': ['a11yr', 11:28:01 INFO - 'ts_paint', 11:28:01 INFO - 'tpaint', 11:28:01 INFO - 'sessionrestore', 11:28:01 INFO - 'sessionrestore_many_windows', 11:28:01 INFO - 'sessionrestore_no_auto_restore', 11:28:01 INFO - 'tabpaint']}, 11:28:01 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['a11yr', 11:28:01 INFO - 'ts_paint', 11:28:01 INFO - 'tpaint', 11:28:01 INFO - 'sessionrestore', 11:28:01 INFO - 'sessionrestore_many_windows', 11:28:01 INFO - 'sessionrestore_no_auto_restore', 11:28:01 INFO - 'tabpaint']}, 11:28:01 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:28:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:28:01 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['perf_reftest_singletons']}, 11:28:01 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['perf_reftest']}, 11:28:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:28:01 INFO - 'tsvgr_opacity', 11:28:01 INFO - 'tart', 11:28:01 INFO - 'tscrollx', 11:28:01 INFO - 'tsvg_static']}, 11:28:01 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['tsvgx', 11:28:01 INFO - 'tsvgr_opacity', 11:28:01 INFO - 'tart', 11:28:01 INFO - 'tscrollx', 11:28:01 INFO - 'tsvg_static']}, 11:28:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:28:01 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'talos_options': ['--disable-stylo'], 11:28:01 INFO - 'tests': ['tp5o']}, 11:28:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:01 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:28:01 INFO - 'talos_options': ['--mitmproxy', 11:28:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:01 INFO - '--firstNonBlankPaint'], 11:28:01 INFO - 'tests': ['tp6_google', 11:28:01 INFO - 'tp6_youtube', 11:28:01 INFO - 'tp6_amazon', 11:28:01 INFO - 'tp6_facebook']}, 11:28:01 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:01 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:28:01 INFO - 'talos_options': ['--disable-stylo', 11:28:01 INFO - '--mitmproxy', 11:28:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:01 INFO - '--firstNonBlankPaint'], 11:28:01 INFO - 'tests': ['tp6_google', 11:28:01 INFO - 'tp6_youtube', 11:28:01 INFO - 'tp6_amazon', 11:28:01 INFO - 'tp6_facebook']}, 11:28:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:01 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:28:01 INFO - 'talos_options': ['--stylo-threads=1', 11:28:01 INFO - '--mitmproxy', 11:28:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:01 INFO - '--firstNonBlankPaint'], 11:28:01 INFO - 'tests': ['tp6_google', 11:28:01 INFO - 'tp6_youtube', 11:28:01 INFO - 'tp6_amazon', 11:28:01 INFO - 'tp6_facebook']}, 11:28:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'talos_options': ['--xperf_path', 11:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:01 INFO - 'tests': ['tp5n']}, 11:28:01 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:01 INFO - 'talos_options': ['--disable-stylo', 11:28:01 INFO - '--xperf_path', 11:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:01 INFO - 'tests': ['tp5n']}}} 11:28:01 INFO - Running post-action listener: _resource_record_post_action 11:28:01 INFO - [mozharness: 2017-09-27 18:28:01.997079Z] Finished populate-webroot step (success) 11:28:01 INFO - [mozharness: 2017-09-27 18:28:01.997169Z] Running create-virtualenv step. 11:28:01 INFO - Running pre-action listener: _resource_record_pre_action 11:28:01 INFO - Running main action method: create_virtualenv 11:28:01 INFO - Creating virtualenv /builds/slave/test/build/venv 11:28:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:28:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:28:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:28:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:28:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:28:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:28:02 INFO - Installing pip...............done. 11:28:02 INFO - Return code: 0 11:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:28:02 INFO - Reading from file tmpfile_stdout 11:28:02 INFO - Output received: 11:28:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:28:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28: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', 'pip>=1.5'] in /builds/slave/test/build 11:28: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 pip>=1.5 11:28:02 INFO - Using env: {'DISPLAY': ':0', 11:28:02 INFO - 'HOME': '/home/cltbld', 11:28:02 INFO - 'LANG': 'en_US.UTF-8', 11:28:02 INFO - 'LANGUAGE': 'en_US:en', 11:28:02 INFO - 'LOGNAME': 'cltbld', 11:28:02 INFO - 'MAIL': '/var/mail/cltbld', 11:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:02 INFO - 'MOZ_NO_REMOTE': '1', 11:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:02 INFO - 'NO_EM_RESTART': '1', 11:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:02 INFO - 'PWD': '/builds/slave/test', 11:28:02 INFO - 'SHELL': '/bin/bash', 11:28:02 INFO - 'SHLVL': '1', 11:28:02 INFO - 'TERM': 'linux', 11:28:02 INFO - 'TMOUT': '86400', 11:28:02 INFO - 'USER': 'cltbld', 11:28:02 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:02 INFO - '_': '/tools/buildbot/bin/python'} 11:28:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:28:04 INFO - Downloading/unpacking pip>=1.5 11:28:04 INFO - Running setup.py egg_info for package pip 11:28:04 INFO - warning: no files found matching 'pip/cacert.pem' 11:28:04 INFO - warning: no files found matching '*.html' under directory 'docs' 11:28:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:28:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:28:04 INFO - Installing collected packages: pip 11:28:04 INFO - Found existing installation: pip 1.1 11:28:04 INFO - Uninstalling pip: 11:28:04 INFO - Successfully uninstalled pip 11:28:04 INFO - Running setup.py install for pip 11:28:04 INFO - warning: no files found matching 'pip/cacert.pem' 11:28:04 INFO - warning: no files found matching '*.html' under directory 'docs' 11:28:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:28:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:28:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:28:04 INFO - Successfully installed pip 11:28:04 INFO - Cleaning up... 11:28:04 INFO - Return code: 0 11:28:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:28:04 INFO - Using env: {'DISPLAY': ':0', 11:28:04 INFO - 'HOME': '/home/cltbld', 11:28:04 INFO - 'LANG': 'en_US.UTF-8', 11:28:04 INFO - 'LANGUAGE': 'en_US:en', 11:28:04 INFO - 'LOGNAME': 'cltbld', 11:28:04 INFO - 'MAIL': '/var/mail/cltbld', 11:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:04 INFO - 'MOZ_NO_REMOTE': '1', 11:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:04 INFO - 'NO_EM_RESTART': '1', 11:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:04 INFO - 'PWD': '/builds/slave/test', 11:28:04 INFO - 'SHELL': '/bin/bash', 11:28:04 INFO - 'SHLVL': '1', 11:28:04 INFO - 'TERM': 'linux', 11:28:04 INFO - 'TMOUT': '86400', 11:28:04 INFO - 'USER': 'cltbld', 11:28:04 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:04 INFO - '_': '/tools/buildbot/bin/python'} 11:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:04 INFO - Downloading/unpacking psutil>=3.1.1 11:28: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 11:28: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 11:28: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 11:28: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 11:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:28:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:05 INFO - Installing collected packages: psutil 11:28:05 INFO - Running setup.py install for psutil 11:28:05 INFO - building 'psutil._psutil_linux' extension 11:28:05 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 11:28:05 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 11:28:05 INFO - building 'psutil._psutil_posix' extension 11:28:05 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 11:28:06 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 11:28:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:06 INFO - Successfully installed psutil 11:28:06 INFO - Cleaning up... 11:28:06 INFO - Return code: 0 11:28:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:28:06 INFO - Using env: {'DISPLAY': ':0', 11:28:06 INFO - 'HOME': '/home/cltbld', 11:28:06 INFO - 'LANG': 'en_US.UTF-8', 11:28:06 INFO - 'LANGUAGE': 'en_US:en', 11:28:06 INFO - 'LOGNAME': 'cltbld', 11:28:06 INFO - 'MAIL': '/var/mail/cltbld', 11:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:06 INFO - 'MOZ_NO_REMOTE': '1', 11:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:06 INFO - 'NO_EM_RESTART': '1', 11:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:06 INFO - 'PWD': '/builds/slave/test', 11:28:06 INFO - 'SHELL': '/bin/bash', 11:28:06 INFO - 'SHLVL': '1', 11:28:06 INFO - 'TERM': 'linux', 11:28:06 INFO - 'TMOUT': '86400', 11:28:06 INFO - 'USER': 'cltbld', 11:28:06 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:06 INFO - '_': '/tools/buildbot/bin/python'} 11:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:28:07 INFO - Installing collected packages: mozsystemmonitor 11:28:07 INFO - Running setup.py install for mozsystemmonitor 11:28:07 INFO - Successfully installed mozsystemmonitor 11:28:07 INFO - Cleaning up... 11:28:08 INFO - Return code: 0 11:28:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:28:08 INFO - Using env: {'DISPLAY': ':0', 11:28:08 INFO - 'HOME': '/home/cltbld', 11:28:08 INFO - 'LANG': 'en_US.UTF-8', 11:28:08 INFO - 'LANGUAGE': 'en_US:en', 11:28:08 INFO - 'LOGNAME': 'cltbld', 11:28:08 INFO - 'MAIL': '/var/mail/cltbld', 11:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:08 INFO - 'MOZ_NO_REMOTE': '1', 11:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:08 INFO - 'NO_EM_RESTART': '1', 11:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:08 INFO - 'PWD': '/builds/slave/test', 11:28:08 INFO - 'SHELL': '/bin/bash', 11:28:08 INFO - 'SHLVL': '1', 11:28:08 INFO - 'TERM': 'linux', 11:28:08 INFO - 'TMOUT': '86400', 11:28:08 INFO - 'USER': 'cltbld', 11:28:08 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:08 INFO - '_': '/tools/buildbot/bin/python'} 11:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:08 INFO - Downloading/unpacking jsonschema==2.5.1 11:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:28:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:28:09 INFO - warning: no files found matching '*.txt' 11:28:09 INFO - no previously-included directories found matching 'build' 11:28:09 INFO - no previously-included directories found matching 'dist' 11:28:09 INFO - no previously-included directories found matching '.git*' 11:28:10 INFO - Installing collected packages: jsonschema, functools32 11:28:10 INFO - Running setup.py install for functools32 11:28:10 INFO - warning: no files found matching '*.txt' 11:28:10 INFO - no previously-included directories found matching 'build' 11:28:10 INFO - no previously-included directories found matching 'dist' 11:28:10 INFO - no previously-included directories found matching '.git*' 11:28:10 INFO - Successfully installed jsonschema functools32 11:28:10 INFO - Cleaning up... 11:28:10 INFO - Return code: 0 11:28:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:28:10 INFO - Using env: {'DISPLAY': ':0', 11:28:10 INFO - 'HOME': '/home/cltbld', 11:28:10 INFO - 'LANG': 'en_US.UTF-8', 11:28:10 INFO - 'LANGUAGE': 'en_US:en', 11:28:10 INFO - 'LOGNAME': 'cltbld', 11:28:10 INFO - 'MAIL': '/var/mail/cltbld', 11:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:10 INFO - 'MOZ_NO_REMOTE': '1', 11:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:10 INFO - 'NO_EM_RESTART': '1', 11:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:10 INFO - 'PWD': '/builds/slave/test', 11:28:10 INFO - 'SHELL': '/bin/bash', 11:28:10 INFO - 'SHLVL': '1', 11:28:10 INFO - 'TERM': 'linux', 11:28:10 INFO - 'TMOUT': '86400', 11:28:10 INFO - 'USER': 'cltbld', 11:28:10 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:10 INFO - '_': '/tools/buildbot/bin/python'} 11:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:28:10 INFO - Cleaning up... 11:28:10 INFO - Return code: 0 11:28:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:28:10 INFO - Using env: {'DISPLAY': ':0', 11:28:10 INFO - 'HOME': '/home/cltbld', 11:28:10 INFO - 'LANG': 'en_US.UTF-8', 11:28:10 INFO - 'LANGUAGE': 'en_US:en', 11:28:10 INFO - 'LOGNAME': 'cltbld', 11:28:10 INFO - 'MAIL': '/var/mail/cltbld', 11:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:10 INFO - 'MOZ_NO_REMOTE': '1', 11:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:10 INFO - 'NO_EM_RESTART': '1', 11:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:10 INFO - 'PWD': '/builds/slave/test', 11:28:10 INFO - 'SHELL': '/bin/bash', 11:28:10 INFO - 'SHLVL': '1', 11:28:10 INFO - 'TERM': 'linux', 11:28:10 INFO - 'TMOUT': '86400', 11:28:10 INFO - 'USER': 'cltbld', 11:28:10 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:10 INFO - '_': '/tools/buildbot/bin/python'} 11:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28: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 11:28: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 11:28: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 11:28: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 11:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:28:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:28: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 11:28: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 11:28: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 11:28: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 11:28:12 INFO - Downloading docopt-0.6.1.tar.gz 11:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:28:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:28:12 INFO - Running setup.py install for blobuploader 11:28:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:28:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:28:12 INFO - Running setup.py install for requests 11:28:12 INFO - Running setup.py install for docopt 11:28:13 INFO - Successfully installed blobuploader requests docopt 11:28:13 INFO - Cleaning up... 11:28:13 INFO - Return code: 0 11:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:13 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:13 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 11:28:13 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 11:28:13 INFO - Using env: {'DISPLAY': ':0', 11:28:13 INFO - 'HOME': '/home/cltbld', 11:28:13 INFO - 'LANG': 'en_US.UTF-8', 11:28:13 INFO - 'LANGUAGE': 'en_US:en', 11:28:13 INFO - 'LOGNAME': 'cltbld', 11:28:13 INFO - 'MAIL': '/var/mail/cltbld', 11:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:13 INFO - 'MOZ_NO_REMOTE': '1', 11:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:13 INFO - 'NO_EM_RESTART': '1', 11:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:13 INFO - 'PWD': '/builds/slave/test', 11:28:13 INFO - 'SHELL': '/bin/bash', 11:28:13 INFO - 'SHLVL': '1', 11:28:13 INFO - 'TERM': 'linux', 11:28:13 INFO - 'TMOUT': '86400', 11:28:13 INFO - 'USER': 'cltbld', 11:28:13 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:13 INFO - '_': '/tools/buildbot/bin/python'} 11:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:13 INFO - Running setup.py (path:/tmp/pip-Z8mzJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:13 INFO - Running setup.py (path:/tmp/pip-IAagGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:13 INFO - Running setup.py (path:/tmp/pip-dJDbV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:13 INFO - Running setup.py (path:/tmp/pip-Nzx14X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:13 INFO - Running setup.py (path:/tmp/pip-ivogBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:13 INFO - Running setup.py (path:/tmp/pip-vWYkwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:13 INFO - Running setup.py (path:/tmp/pip-HSfz6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:13 INFO - Running setup.py (path:/tmp/pip-sy2TA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:13 INFO - Running setup.py (path:/tmp/pip-vCRwyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:13 INFO - Running setup.py (path:/tmp/pip-2xuQX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:13 INFO - Running setup.py (path:/tmp/pip-JmFBHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:14 INFO - Running setup.py (path:/tmp/pip-xpv3ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:14 INFO - Running setup.py (path:/tmp/pip-nekUhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:14 INFO - Running setup.py (path:/tmp/pip-lXUGgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:14 INFO - Running setup.py (path:/tmp/pip-vu1Bmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:14 INFO - Running setup.py (path:/tmp/pip-mqDx9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:14 INFO - Running setup.py (path:/tmp/pip-Xarvyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:28:14 INFO - Running setup.py install for manifestparser 11:28:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Running setup.py install for mozcrash 11:28:14 INFO - Running setup.py install for mozdebug 11:28:14 INFO - Running setup.py install for mozdevice 11:28:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:28:14 INFO - Running setup.py install for mozfile 11:28:14 INFO - Running setup.py install for mozhttpd 11:28:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for mozinfo 11:28:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for mozInstall 11:28:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for mozleak 11:28:15 INFO - Running setup.py install for mozlog 11:28:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for moznetwork 11:28:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for mozprocess 11:28:15 INFO - Running setup.py install for mozprofile 11:28:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for mozrunner 11:28:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:28:15 INFO - Running setup.py install for mozscreenshot 11:28:16 INFO - Running setup.py install for moztest 11:28:16 INFO - Running setup.py install for mozversion 11:28:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:28:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:28:16 INFO - Cleaning up... 11:28:16 INFO - Return code: 0 11:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:16 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:16 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 11:28:16 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 11:28:16 INFO - Using env: {'DISPLAY': ':0', 11:28:16 INFO - 'HOME': '/home/cltbld', 11:28:16 INFO - 'LANG': 'en_US.UTF-8', 11:28:16 INFO - 'LANGUAGE': 'en_US:en', 11:28:16 INFO - 'LOGNAME': 'cltbld', 11:28:16 INFO - 'MAIL': '/var/mail/cltbld', 11:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:16 INFO - 'MOZ_NO_REMOTE': '1', 11:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:16 INFO - 'NO_EM_RESTART': '1', 11:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:16 INFO - 'PWD': '/builds/slave/test', 11:28:16 INFO - 'SHELL': '/bin/bash', 11:28:16 INFO - 'SHLVL': '1', 11:28:16 INFO - 'TERM': 'linux', 11:28:16 INFO - 'TMOUT': '86400', 11:28:16 INFO - 'USER': 'cltbld', 11:28:16 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:16 INFO - '_': '/tools/buildbot/bin/python'} 11:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:16 INFO - Running setup.py (path:/tmp/pip-8l0Da6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:16 INFO - Running setup.py (path:/tmp/pip-Z0nP5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:16 INFO - Running setup.py (path:/tmp/pip-dw_ojb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:16 INFO - Running setup.py (path:/tmp/pip-VF69p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:16 INFO - Running setup.py (path:/tmp/pip-VF9K9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:16 INFO - Running setup.py (path:/tmp/pip-cu0aVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:16 INFO - Running setup.py (path:/tmp/pip-kBqybE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:16 INFO - Running setup.py (path:/tmp/pip-cKe9ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:16 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)) 11:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:16 INFO - Running setup.py (path:/tmp/pip-j96H_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:17 INFO - Running setup.py (path:/tmp/pip-7pD5YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:17 INFO - Running setup.py (path:/tmp/pip-aur6_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:17 INFO - Running setup.py (path:/tmp/pip-cx5FQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:17 INFO - Running setup.py (path:/tmp/pip-N_IYFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:17 INFO - Running setup.py (path:/tmp/pip-B_mqgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:17 INFO - Running setup.py (path:/tmp/pip-S9c_QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:17 INFO - Running setup.py (path:/tmp/pip-fiUf29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:17 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)) 11:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:17 INFO - Running setup.py (path:/tmp/pip-MyxLEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:17 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)) 11:28:17 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)) 11:28:17 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)) 11:28:17 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)) 11:28:17 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)) 11:28:17 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)) 11:28:17 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)) 11:28:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:28:17 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 11:28:17 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 11:28:17 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 11:28:17 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 11:28:18 INFO - Downloading blessings-1.6.tar.gz 11:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:28:18 INFO - Installing collected packages: blessings 11:28:18 INFO - Running setup.py install for blessings 11:28:18 INFO - Successfully installed blessings 11:28:18 INFO - Cleaning up... 11:28:19 INFO - Return code: 0 11:28:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:19 INFO - Reading from file tmpfile_stdout 11:28:19 INFO - Current package versions: 11:28:19 INFO - argparse == 1.2.1 11:28:19 INFO - blessings == 1.6 11:28:19 INFO - blobuploader == 1.2.4 11:28:19 INFO - docopt == 0.6.1 11:28:19 INFO - functools32 == 3.2.3-2 11:28:19 INFO - jsonschema == 2.5.1 11:28:19 INFO - manifestparser == 1.1 11:28:19 INFO - mozInstall == 1.13 11:28:19 INFO - mozcrash == 1.0 11:28:19 INFO - mozdebug == 0.1 11:28:19 INFO - mozdevice == 0.51 11:28:19 INFO - mozfile == 1.2 11:28:19 INFO - mozhttpd == 0.7 11:28:19 INFO - mozinfo == 0.10 11:28:19 INFO - mozleak == 0.1 11:28:19 INFO - mozlog == 3.5 11:28:19 INFO - moznetwork == 0.27 11:28:19 INFO - mozprocess == 0.25 11:28:19 INFO - mozprofile == 0.28 11:28:19 INFO - mozrunner == 6.13 11:28:19 INFO - mozscreenshot == 0.1 11:28:19 INFO - mozsystemmonitor == 0.3 11:28:19 INFO - moztest == 0.8 11:28:19 INFO - mozversion == 1.4 11:28:19 INFO - psutil == 3.1.1 11:28:19 INFO - requests == 1.2.3 11:28:19 INFO - wsgiref == 0.1.2 11:28:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:19 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')]} 11:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:19 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')]} 11:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:19 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:19 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 11:28:19 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 11:28:19 INFO - Using env: {'DISPLAY': ':0', 11:28:19 INFO - 'HOME': '/home/cltbld', 11:28:19 INFO - 'LANG': 'en_US.UTF-8', 11:28:19 INFO - 'LANGUAGE': 'en_US:en', 11:28:19 INFO - 'LOGNAME': 'cltbld', 11:28:19 INFO - 'MAIL': '/var/mail/cltbld', 11:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:19 INFO - 'MOZ_NO_REMOTE': '1', 11:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:19 INFO - 'NO_EM_RESTART': '1', 11:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:19 INFO - 'PWD': '/builds/slave/test', 11:28:19 INFO - 'SHELL': '/bin/bash', 11:28:19 INFO - 'SHLVL': '1', 11:28:19 INFO - 'TERM': 'linux', 11:28:19 INFO - 'TMOUT': '86400', 11:28:19 INFO - 'USER': 'cltbld', 11:28:19 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:19 INFO - '_': '/tools/buildbot/bin/python'} 11:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 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)) 11:28:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:28:19 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 11:28:19 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 11:28:19 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 11:28:19 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 11:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:28:20 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)) 11:28:20 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)) 11:28:20 INFO - Installing collected packages: simplejson 11:28:20 INFO - Running setup.py install for simplejson 11:28:20 INFO - building 'simplejson._speedups' extension 11:28:20 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 11:28:21 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 11:28:21 INFO - Successfully installed simplejson 11:28:21 INFO - Cleaning up... 11:28:21 INFO - Return code: 0 11:28:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:21 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb19c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', '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 11:28:21 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 11:28:21 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 11:28:21 INFO - Using env: {'DISPLAY': ':0', 11:28:21 INFO - 'HOME': '/home/cltbld', 11:28:21 INFO - 'LANG': 'en_US.UTF-8', 11:28:21 INFO - 'LANGUAGE': 'en_US:en', 11:28:21 INFO - 'LOGNAME': 'cltbld', 11:28:21 INFO - 'MAIL': '/var/mail/cltbld', 11:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:21 INFO - 'MOZ_NO_REMOTE': '1', 11:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:21 INFO - 'NO_EM_RESTART': '1', 11:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:21 INFO - 'PWD': '/builds/slave/test', 11:28:21 INFO - 'SHELL': '/bin/bash', 11:28:21 INFO - 'SHLVL': '1', 11:28:21 INFO - 'TERM': 'linux', 11:28:21 INFO - 'TMOUT': '86400', 11:28:21 INFO - 'USER': 'cltbld', 11:28:21 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:21 INFO - '_': '/tools/buildbot/bin/python'} 11:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:28:21 INFO - Cleaning up... 11:28:21 INFO - Return code: 0 11:28:21 INFO - Running post-action listener: _resource_record_post_action 11:28:21 INFO - Running post-action listener: _start_resource_monitoring 11:28:21 INFO - Starting resource monitoring. 11:28:21 INFO - [mozharness: 2017-09-27 18:28:21.934430Z] Finished create-virtualenv step (success) 11:28:21 INFO - [mozharness: 2017-09-27 18:28:21.934953Z] Running install step. 11:28:21 INFO - Running pre-action listener: _resource_record_pre_action 11:28:21 INFO - Running main action method: install 11:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:22 INFO - Reading from file tmpfile_stdout 11:28:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:28:22 INFO - Reading from file tmpfile_stdout 11:28:22 INFO - Output received: 11:28:22 INFO - Usage: mozinstall [options] installer 11:28:22 INFO - Options: 11:28:22 INFO - -h, --help show this help message and exit 11:28:22 INFO - -d DEST, --destination=DEST 11:28:22 INFO - Directory to install application into. [default: 11:28:22 INFO - "/builds/slave/test"] 11:28:22 INFO - --app=APP Application being installed. [default: firefox] 11:28:22 INFO - mkdir: /builds/slave/test/build/application 11:28:22 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'] 11:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:28:40 INFO - Reading from file tmpfile_stdout 11:28:40 INFO - Output received: 11:28:40 INFO - /builds/slave/test/build/application/firefox/firefox 11:28:40 INFO - Running post-action listener: _resource_record_post_action 11:28:40 INFO - [mozharness: 2017-09-27 18:28:40.047358Z] Finished install step (success) 11:28:40 INFO - [mozharness: 2017-09-27 18:28:40.047610Z] Running setup-mitmproxy step. 11:28:40 INFO - Running pre-action listener: _resource_record_pre_action 11:28:40 INFO - Running main action method: setup_mitmproxy 11:28:40 INFO - Skipping: mitmproxy is not required 11:28:40 INFO - Running post-action listener: _resource_record_post_action 11:28:40 INFO - [mozharness: 2017-09-27 18:28:40.048896Z] Finished setup-mitmproxy step (success) 11:28:40 INFO - [mozharness: 2017-09-27 18:28:40.049117Z] Running run-tests step. 11:28:40 INFO - Running pre-action listener: _resource_record_pre_action 11:28:40 INFO - Running pre-action listener: _set_gcov_prefix 11:28:40 INFO - Running main action method: run_tests 11:28:40 WARNING - Try message not found. 11:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:28:40 INFO - Python 2.7.3 11:28:40 INFO - Return code: 0 11:28:40 INFO - grabbing minidump binary from tooltool 11:28: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')]} 11:28:40 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 0x2caed60>, '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 0x2cafa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cafef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:28:40 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 11:28:40 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 11:28:40 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 11:28:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:28:40 INFO - Return code: 0 11:28:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:28:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:28:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:28:40 INFO - ENV: RUST_BACKTRACE is now full 11:28:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:28:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:28:40 INFO - Using env: {'DISPLAY': ':0', 11:28:40 INFO - 'HOME': '/home/cltbld', 11:28:40 INFO - 'LANG': 'en_US.UTF-8', 11:28:40 INFO - 'LANGUAGE': 'en_US:en', 11:28:40 INFO - 'LOGNAME': 'cltbld', 11:28:40 INFO - 'MAIL': '/var/mail/cltbld', 11:28:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:40 INFO - 'MOZ_NO_REMOTE': '1', 11:28:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:40 INFO - 'NO_EM_RESTART': '1', 11:28:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:40 INFO - 'PWD': '/builds/slave/test', 11:28:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:40 INFO - 'RUST_BACKTRACE': 'full', 11:28:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:28:40 INFO - 'SHELL': '/bin/bash', 11:28:40 INFO - 'SHLVL': '1', 11:28:40 INFO - 'TERM': 'linux', 11:28:40 INFO - 'TMOUT': '86400', 11:28:40 INFO - 'USER': 'cltbld', 11:28:40 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:40 INFO - '_': '/tools/buildbot/bin/python'} 11:28:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:28:40 INFO - mozversion application_buildid: 20170927173830 11:28:40 INFO - mozversion application_changeset: 756e10aa8bbd416cbc49b7739f78fb81d5525477 11:28:40 INFO - mozversion application_display_name: Nightly 11:28:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:28:40 INFO - mozversion application_name: Firefox 11:28:40 INFO - mozversion application_remotingname: firefox 11:28:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:28:40 INFO - mozversion application_vendor: Mozilla 11:28:40 INFO - mozversion application_version: 58.0a1 11:28:40 INFO - mozversion platform_buildid: 20170927173830 11:28:40 INFO - mozversion platform_changeset: 756e10aa8bbd416cbc49b7739f78fb81d5525477 11:28:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:28:40 INFO - mozversion platform_version: 58.0a1 11:28:40 INFO - using testdate: 1506536920 11:28:40 INFO - actual date: 1506536920 11:28:40 INFO - starting webserver on 'localhost:33706' 11:28:40 INFO - SUITE-START | Running 2 tests 11:28:40 INFO - TEST-START | dromaeo_css 11:28:40 INFO - Initialising browser for dromaeo_css test... 11:28:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33706/getInfo.html -profile /tmp/tmp7zK4XT/profile 11:28:40 INFO - TEST-INFO | started process 16720 (/builds/slave/test/build/application/firefox/firefox http://localhost:33706/getInfo.html) 11:28:45 INFO - TEST-INFO | 16720: exit 0 11:28:45 INFO - Browser initialized. 11:28:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:28:45 INFO - Using env: {'DISPLAY': ':0', 11:28:45 INFO - 'HOME': '/home/cltbld', 11:28:45 INFO - 'JSGC_DISABLE_POISONING': '1', 11:28:45 INFO - 'LANG': 'en_US.UTF-8', 11:28:45 INFO - 'LANGUAGE': 'en_US:en', 11:28:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:28:45 INFO - 'LOGNAME': 'cltbld', 11:28:45 INFO - 'MAIL': '/var/mail/cltbld', 11:28:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:28:45 INFO - 'MOZ_CRASHREPORTER': '1', 11:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:28:45 INFO - 'MOZ_NO_REMOTE': '1', 11:28:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:45 INFO - 'NO_EM_RESTART': '1', 11:28:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:45 INFO - 'PWD': '/builds/slave/test', 11:28:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:45 INFO - 'RUST_BACKTRACE': 'full', 11:28:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:28:45 INFO - 'SHELL': '/bin/bash', 11:28:45 INFO - 'SHLVL': '1', 11:28:45 INFO - 'TERM': 'linux', 11:28:45 INFO - 'TMOUT': '86400', 11:28:45 INFO - 'USER': 'cltbld', 11:28:45 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:45 INFO - '_': '/tools/buildbot/bin/python'} 11:28:45 INFO - TEST-INFO | started process 16950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7zK4XT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:46 INFO - PID 16950 | 11:28:46 INFO - PID 16950 | (/builds/slave/test/build/application/firefox/firefox:16999): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:28:46 INFO - PID 16950 | 11:28:56 INFO - PID 16950 | RSS: Main: 152571904 11:28:56 INFO - PID 16950 | 11:31:54 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:33706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33706/tests/dromaeo/cssquery-ext.html) 11:31:55 INFO - PID 16950 | RSS: Main: 154595328 11:31:55 INFO - PID 16950 | 11:34:57 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:33706/tests/dromaeo/cssquery-ext.html (next: http://localhost:33706/tests/dromaeo/cssquery-jquery.html) 11:34:57 INFO - PID 16950 | RSS: Main: 153542656 11:34:57 INFO - PID 16950 | 11:37:59 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:33706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33706/tests/dromaeo/cssquery-mootools.html) 11:38:00 INFO - PID 16950 | RSS: Main: 155201536 11:38:00 INFO - PID 16950 | 11:41:01 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:33706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33706/tests/dromaeo/cssquery-prototype.html) 11:41:02 INFO - PID 16950 | RSS: Main: 152293376 11:41:02 INFO - PID 16950 | 11:44:05 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:33706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33706/tests/dromaeo/cssquery-yui.html) 11:44:06 INFO - PID 16950 | RSS: Main: 154886144 11:44:06 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | Cycle 1(1): loaded http://localhost:33706/tests/dromaeo/cssquery-yui.html (next: http://localhost:33706/tests/dromaeo/cssquery-dojo.html) 11:47:08 INFO - PID 16950 | RSS: Main: 156770304 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | __start_tp_report 11:47:08 INFO - PID 16950 | _x_x_mozilla_page_load 11:47:08 INFO - PID 16950 | _x_x_mozilla_page_load_details 11:47:08 INFO - PID 16950 | |i|pagename|runs| 11:47:08 INFO - PID 16950 | |0;dojo.html;3191.6967888050635;3209.3260415312784;3213.052149615863;3213.726833219176;3242;6111.877762444748;6192.164057852195;6221.191245138137;6348.111264422979;6381.649009304487;6270.937290627093;6299.275583307909;6301.495880329574;6329.019002054689;6338.33447488014;5760.740766665489;5796.913046304308;5802.564807639423;5804.970975145118;5825.679587622701;5820.563457740665;5856.824295271149;5901.026330655437;5909.8227053188475;5910.231669882931;5822.3886491918165;5892.499137573312;5901.734421951022;5915.5859089863725;5926.496247818941;1231.2362183656724;5732.3121225453215;5735;5828.473802975476;5894.233749612566;5749.022666146765;5749.223854779593;5815.09865970771;5823.2138661280605;5836.97081514594;6247.219097612799;6268.1851359323;6278.121063051177;6303.968480157616;6352.809415717536;6645;6657.800265992028;6744.190697116328;6758.324167583251;6762.526623136382;6743.865122697568;6757.222919364287;6834;6846.7945961621235;6857.382835544825;6136.478399336062;6217.285012223607;6230.844228894269;6230.844228894269;6245.62526248422;6877.105976223059;6879.2432832388395;6898.482613803984;6988.021676965229;7003.369696727217;6597.80206593803;6673.799786006331;6701.028350889093;6705.731770729214;6711.932880671228;6730.495212859055;6745.258021617618;6796.932030679729;6824.41992430639;6825.180978282638;6547.607143571306;6643.701033453506;6646.567973081735;6658.367455091856;6670.433013193933;6640.734370625121;6677.332266773381;6685.532012759158;6688.3646053624825;6690.899636505456;5145.588352931756;5205.895882082413;5257.684538927677;5278.366596008504;5280.128778751463;4467.6649251305635;4551.294549344857;4568.132054909556;4626.537346265347;4651.162790697639;5697.287839020122;5745.2818397700285;5755;5778.27771528559;5789.8552536186935;6766.28953959837;6766.594004359754;6846.863062738817;6857.382835544825;6862.828429289308;5755.395683453261;5781.103928891029;5792.333881603669;5825.417458254141;5854.560907931837;5775.306963164448;5782.132680098019;5850.736716847752;5853.824385268449;5856.765729370863;6457.321981191907;6466.385693359123;6553.868922621521;6555.442787363032;6627.304133066055;6763.357481039294;6795;6815.386615204656;6835.760748373783;6849.48628852848;6358.618482891041;6434.903476447951;6493.090967264681;6545.37818907203;6574.112494813139;6631.801045968628;6655.401013908771;6717.596944183365;6722.495812814156;6731.562448440835;6798.354156355138;6805.625690586867;6814.761483348059;6905.102336696197;6918.619475928671;6434.0670602763275;6516.771912983023;6519.869602608016;6525.282218956006;6533.509986751108;6564.179477565304;6630.7679231226675;6640.236372817188;6641.867162656623;6642.070110184482;6463.709133089116;6499.5775274607;6521;6566.343365663395;6575.736970521317;6554.820132376218;6582.670866456562;6588.670566471561;6629.270780214269;6648.767293144717;6405.551611387158;6416.711247993758;6438.6136831790245;6447.097406363207;6473.2232132144445 11:47:08 INFO - PID 16950 | |1;ext.html;838.1492784823402;846.5386364431384;874.4796845876704;897.0222457521301;906.891173059233;40313.59686403135;40384.59615403845;41360.37959430607;41756.791216043915;41776.373354399635;40855;41129;41202.793986030105;41308.793456032676;41342.37986430198;7970.521768693868;8108.824220488025;8126.837463250731;8133.2680058794695;8133.552654603995;7989.480683755537;8119.106898241189;8121.837563248731;8126.878096828552;8128.796780080486;8060.798480038016;8112;8142.47073940192;8149.551774652392;8154.592270386457;8068.596570171468;8071.757847264592;8099.149589293098;8103.149169337194;8106.148854370324;7819.648115834744;7941.880871786928;7946;7947.4039447041705;7961.681532738684;36625;36639.450408243894;36808;36881;36911.26177476462;3226.370857682753;3274.8690052397874;3292.687194716498;3292.8682852685865;3293.2096296888813;30607;30623.540646890313;30783.230419239473;30832.53751193734;30917.22706932322;4888.364512613338;5144.768485418128;5234.842954711365;5260.947390526084;5264.578833693296;184242.07878960654;184290;184482;184529;185474;44984.55015449869;45057.774711126236;45088.098238035054;45156.774216129365;45175.77412112919;52281.47718522766;53365.1995220072;53384.73307633437;53428.465715343125;53520;14553.92723036378;14582.197979111039;14605.707885842223;14662.413503459955;14718.779218311734;11677.824832627517;11687.649370518899;11690.70773230659;11716.062714982781;11720.355380454157;14490;14586.708265834624;14591;14604.926975365055;14671.633209169857;5780.450857168562;5848.444397782204;5866.032104702762;5915.526757859361;6022.397760223943;1006.8187726209206;1018.5365658625308;1019.5463018956641;1032.7056788815303;1033.8862725100232;22892.771072289397;23020.65469017966;23217.53564928692;23233.954472048797;23234.883825580764;1116.4585176189541;1118.1502058435647;1119.9888001119884;1129.9096072314196;1132.9773404531863;11897.048236141089;12299.754004919852;12326.31778725614;12333.95161411272;12369.814452783216;214486;214664;231388;231698;232251;53381.466185338424;54738.45261547333;54913;54997.175042374394;55204.447955520736;1439.9352029158713;1457.5554455890842;1465.1868213141809;1467.8091848059685;1469.6840179361488;26975.190744277705;27497.86251068732;27562;27603;27835.721642784123;37031.44452833156;37386.252274953804;37407.251854962204;37546;37680.81159594184;201715;204632;205130;205166;205721;32838.671613283565;33972;34158.8292058548;34241.65758342385;34387.48418773671;42877.356839648055;42984.57015429805;43347;43407.56592434035;43432.565674342855;31615.525767113973;31715.20711982219;31715.36569268648;31921.840390797897;32147.67852321447;30804.22989425282;31321.21696957503;31354.21614459657;31397.215069623442;31581.526277105404;35689.1077723059;35782;36097.097572560895;36097.45853812143;36210;30414.239644009078;30589.54115688222;30665.54001690021;30746;30821.22946926345;23261.883690582115;23282.883585581963;23301.951412186154;23322.76677233206;23551.646725298793 11:47:08 INFO - PID 16950 | |2;jquery.html;576.7779404929104;583.2417856786177;588.9411058894109;596.749365266588;620.658637749238;22197.556048879032;22955.770442295572;23045.654315185264;23049.654255186142;23068.88465557674;22662.546749065008;24331.635025474632;24416.877915610443;24579;24627;6442.903356449645;6561.639109848957;6590.176227971504;6607.306232845554;6610.338966103375;6556.573822701533;6646.169228846395;6646.302138275484;6664.966675166617;6674.3325667433355;6600.207975043001;6624.5694029888145;6626.5030122740745;6627.60234385936;6636.900446493307;6266.185395898527;6536.477081833442;6558.114654521626;6559.672016399209;6577.901331480056;6085.2697676278685;6105.358937311563;6113.083037544359;6127.050307202391;6128.908066379008;27725.58411623807;28040.298992525146;28079.29801754952;28084.719152808415;28097.578536321973;1956.2370675436591;2009.2967461388544;2010.1758279105497;2010.5677279385002;2011.1754180785808;18379.540511487186;19767;19771.90114049435;19849.50376240591;19939.50151246216;2253.921112761062;2268.6823844661762;2317.1310758465575;2331.9650205246935;2363.6218205087102;116024;122841;129450;132703;136104.31947840296;14950.626234344229;14981.625459363604;15339.693206135815;15529.689406211812;15648.295826687827;23334.883325583603;23337;23370.532589348117;23418.765812342;23462.17882374143;9728.124468797841;9855.55649995752;9867;9943.900560994298;10112.140468060297;8811.735647930573;8918.821623567492;8981.326400519856;9011.27909767217;9018;9097.727068187965;9111.134442227978;9266.860997085048;9268.907310926805;9331.393459425251;2651.57574788033;2680.865956702196;2685.7179996100517;2708.945821083607;2838.6451693538306;981.474910922653;1000.9349392289478;1006.7734759679014;1007.2797949466167;1023.4217667018111;18977.43067707971;19506.80493195078;19528.316508922402;19707.901460492893;20027;1059.1579694143174;1061.1987949098382;1063.5586231713753;1064.1486810551528;1072.7210925159516;10648.307859989076;10795.352278863136;10805.405702686428;10894.891051089546;10961.287516311415;480579;485889;498388;500392;500643;110889;110936.4453177729;112257.43871280592;112845;114386;1058.8305871060593;1109.517359948425;1136.78969390663;1173.6185739634652;1222.5598784437595;20123.899380503004;20157.992100395215;20178.899105504377;20473;20545.794542054387;57198;59238;59244;59276.11085833802;59930.700346497986;71951.64024179845;72218.63890680514;72517.6374118147;72641.27358726345;73774.63112684402;14468.85531144675;14576.125432474086;14712.852871471148;14714.852851471776;14717.116972981656;22572.435689107904;22736.65895011543;22771.430714232276;23098.538029238985;23239.186628467924;16570.66858662796;16910.154492275582;17225.39711110105;18156.45530634083;18342.17460214267;16150.434734784696;16367.345306187619;16970.830291697417;16991.49025529236;17262.82737172612;17485.388011419538;18499.260029598667;18530.722039169155;18730.625387492448;18823;14360.425582976564;14373.06575072617;14439.278036098363;14457.92771036138;14462.132272063709;18073.18670659797;18119.909400452914;18222.544436389195;18375.724364134283;18381.264749409875 11:47:08 INFO - PID 16950 | |3;mootools.html;1294.7928331466965;1351.3648585164974;1366.24856329019;1368.0628769293035;1372.7529044771943;14764.409423623056;15363.692726145471;15371;15382.230888455575;15414.460493882716;15013;15174.696506069871;15223.23883805808;15234.085954842689;15240.542783716506;2719.3201699575056;2829.221963959907;2830.844303563303;2831.3346363604637;2833.858307084648;2676.7992400569938;2724.7329991553925;2775.5420355641395;2804.9158525244175;2806.7473927346537;2778.305423644089;2829.7170282971642;2829.8868045278164;2830.023641843571;2830.221689035521;2681.182239416977;2685.301821526398;2701.6082668013128;2704.5537486314734;2709.9322516937036;2675.291047872315;2702.8648567571545;2722.2377734234447;2725.68654604721;2729.6178535005115;14766.70466590673;15172.013819101834;15199.164045977466;15209.695806083817;15232.238388080552;7818.179091195457;8120.3503719702285;8127.065387480457;8134.877976830352;8139.104698483221;5171.844844654666;5342.67943923362;5499.175123731432;5511.090670039479;5515.944840551583;1818.5362732503258;1837.2467288411822;1849.9722504162448;1884.1144662008835;1896.7439395681545;25856.095036673625;26231.73768262312;26448.07431739899;26626.73373266262;26745.73254267452;6472.255690595548;6477.967610161919;6582.8354291143105;6645.767398141139;6700;17512.562185945197;17665.205065772072;17682.204300806494;17682.82317176812;17804.643907121786;7535.472516923873;7803.02462192226;7805.297523222937;7813.960930195312;7848.607569621496;7098.716051357887;7166.319199676022;7382.778516644509;7509.286617771303;7512.924870751332;5058.317127187856;5219.556337711337;5229.137192363293;5260.105782017066;5269.841904742864;1486.3385793322084;1487.2861026707242;1497.4309762290477;1512.9848701513065;1513.0770230159594;870.1820288928387;895.9328050396247;901.396064636695;903.6159632156307;906.0712769411406;7426.220246874109;7527.096748390119;7553.32020118192;7558.886616700754;7606.277403646644;724.3263764698776;728.3117454005913;728.3772374619624;729.3290173040815;742.4617152564456;4736.407949006374;4908.509149085063;5079.3650793650795;5171.922421163686;5225.451327610622;21641.78358216429;22150.113995440322;22326.665100023514;22563.774362256496;22608.660870086962;20834.79165208359;21770.47606667518;21923.780762192175;22259;22545.887270563544;9869.605215791287;10322.948385258176;11382.886171138183;11888.465019074163;11982.400879955967;8508.319334453352;8543.0602633709;8552.401331906707;8554;8565.100664430394;19015.90492047531;19200.423987280403;19394.70907936354;19508.512287192934;19863.404097877086;19192;19443.222271108996;19617.52868534894;19645.70531442001;19812.801871981097;11273.774524509628;11454;11463.197576169921;11464.31214127155;11472.254303470248;13743.450261989808;14057;14170.92914535462;14188;14191.290435477978;10719.303245289031;10752.13982881352;10769.299995500267;10949.507272172612;11083.113350932068;11054.170937179904;11068.723281918017;11170.776584468427;11273.267237629529;11468.197226194086;9695.9030409695;9903.603855845686;9947.253955953187;9990.100890919852;10007.399556026661;7072.186698529735;7090.539114957512;7162.64186790648;7237.384822289953;7301.123865136217;7186.209516953236;7387.519811212254;7400.592967386845;7400.888986665097;7416.814579635552 11:47:08 INFO - PID 16950 | |4;prototype.html;517.3274742834315;530.4085944172248;541.2017274520083;549.0994768579528;557.453695378529;6227.602373086361;6291.182146320977;6297.244330680313;6333.606606546558;6415.101885736;6196.932518403385;6273.247210334766;6283.622982621046;6294.33909439508;6303.842403939904;5230.947690523084;5256.027634887539;5259.105951988171;5260.868478288055;5278.419373868871;5124.694572001057;5129.84578469845;5164.92252616211;5177.559907407875;5290.947090529084;5106.489351064901;5134.691918484884;5139.537441630253;5151.304573882534;5194.168932970725;5058.7976480940715;5066.164082926312;5107.7956881724685;5138.023775482647;5166.844994650167;4717.174494463489;4753.789487888149;4771.498992605796;4777.092352453057;4793.520647935214;6184.856146381935;6191.349908259613;6194.5354098442795;6225.132460261903;6262.5929314594405;5813.854653633651;5847.590668653196;5890.2342695449315;5926.733297001645;5964.701764911737;6482.481401487869;6557.442617377481;6587.473002159816;6613.636250006248;6617.239017512999;4970.353853998957;5194.948050519484;5213.618391126354;5214.817481388133;5216.556592689588;6684.899726504106;6809;6965.65171741421;6970.686319115652;6983.336583024656;5300.277409841817;5307.6284660073425;5365.6244062916;5365.6244062916;5387.703676297841;5467.480589344006;5482.780688772405;5484.588655850827;5489.505944465017;5493.697846618395;5917.733701983335;5934.258217722785;5949.405059494103;5957.4042595740075;5986.07215881539;6543.233327001778;6638.5684930479365;6647.135872336662;6668.499862510331;6728.889733194066;1894.8957807320453;1917.475606892496;1923.8941858197654;1924.6631839428323;1932.4202739178472;1292.373198998485;1353.2151352215888;1407.718975732079;1411.84469708332;1453.883689304853;5575.470330318613;5695.829125126253;5722.77108915647;5735.311762588516;5736.397678243808;6736.966315168491;6770.69531871067;6785.16800463872;6824.18109826824;6832.624205668637;5754.4533269339345;5757.337906140848;5775.133729940459;5777.768889244468;5819;3437.570303712036;3510.736694747904;3526.9118272042892;3558.5373901392654;3564.3940530109944;6534.738610455529;6538.901916471256;6550.7707230246715;6563.540552161303;6597.73609055642;6905;6920.4809639277255;6943.6875340609795;6945.09713737221;6992.2658120897595;6500.804975850732;6540.771073012422;6554.180727409074;6554.9672251639395;6581.288864895066;6603.933960660332;6621.404073633396;6673.332666733482;6690.765823196165;6708.463322934251;6460.675561509785;6578.210614726072;6635.701393437211;6701.463882889455;6703.29615390377;6411.615303081643;6471.288158302489;6494.571194337238;6496.317886621837;6521.934780652133;4966.751662416792;4970.826021089245;4973.825916092919;4974.427940786856;5038.269450929668;6640.734370625121;6704.463642908653;6741.696623651849;6744.258131605618;6794.626295553792;6442;6491.091247225298;6528.37980391862;6539.444147247347;6560.278369379269;6350.68246587678;6369.77705780314;6465.64438955862;6481.708323125565;6526.67366631676;6250.06249062626;6334.714937827716;6342.52431067681;6358.554901156875;6418.871622567616;6594.703238354382;6605.405513503808;6622.768203113061;6628.801135965929;6638.933610663831;5943.514121469632;6056.788012419544;6255.093011513396;6338.116157148578;6436.549441539235 11:47:08 INFO - PID 16950 | |5;yui.html;913.9268858491322;921.3596550397474;938.3384713776784;940.7507010642181;962.1917589225052;19658.213671453126;20233;20242;20258.89870550649;20283.391498255038;18401.447956561293;18508.629827403445;18567.257309707595;19089.80910190901;19225.807741922577;947.4362754161281;967.013646080997;970.3789574672215;970.9417434953925;971.3103696375547;964.3779762053472;984.3700031979539;986.9851952220722;987.4026214140414;999.2655398282257;1053.2364036073861;1055.5566662001977;1059.1738444013681;1059.830427131659;1060.3849767135043;979.6816034788651;1009.6970908727352;1045.1847558904028;1046.2362475392968;1049.3913530152493;745.2584678245181;746.220199891115;746.8319628083692;749.0187853911393;749.3667850666178;19728.60542789136;19885.304014359426;20007.1997120115;20036;20270.39188824323;21381.67927481089;21990.230341938117;22341.55316893653;22347;22453.438664033365;17829.375971840924;17859.285628574842;18229.908850455664;18301.08494575266;18420.815791842044;3756.69946404287;3789.1853251550774;3797.4493698413853;3799.525059367579;3806.352920003606;141814;142175;142186.28906855502;142575.57424425727;144810;16841.747373789403;16846.831531684773;17209.65580688379;17214.65570688579;17235.31058757661;30700.38599228003;31413.528797068062;31670.841645791625;31703;31744.841275793475;8503.1921967413;8642.611082501302;8665.653373864974;8704.564771761387;8712.520811355436;4209.24233637942;4307.655387568987;4316.676249281317;4320.071184695243;4323.546027667113;5381.811636592701;5398.460153984649;5402;5422.024035673617;5470.64440811346;1015.3653966271081;1053.2679787547581;1056.5773690523852;1067.108964015056;1069.1072954083427;593.2139914613155;599.27188466014;611.5230120506012;618.227215980025;626.865223976838;11080.445977701083;11568.942155289169;12124.969377603002;13135;13140.540081097115;671.7313074770132;697.3723648716094;699.993000070003;701.768396464202;708.5961002228784;5514.5864060195645;5551.583631227674;5569.749361278752;5603.131514615241;5658.434156584309;117458.41270793592;118591.40704296423;119848;119935.40032299783;121881.39059304647;100259.49870250748;103999.4800025995;105650.47174764077;105800.47099764606;109839.45080274547;88675;88880;91085.54457227804;93244.53377733068;93838.53080734552;10262.948685256824;10274.897251027394;10468.738281543023;10477.057064863893;10483.108935740547;42572;42746.358804618576;43231.05460254359;43308.35037474377;45508.63474095782;55261;57207.42792572021;57228.1415778772;57336.56658583569;59189.40810591839;15107.773383399039;15381.76927346113;15744.92127539355;15745.763813542577;15933.521994340188;17698;17807;17824.10879455996;17837.197326120615;17912.641747165246;16196.109213993344;16284.91857540752;16351.100689461719;16507.752383714014;16598;15881.8411815885;16248.918755406148;16369.427070052967;16423.260953256893;16451.177441127656;16134.67730645357;16293.26680299413;16392.119345869814;16554.337826486804;16574.585635359213;11340.09279257674;11528.769424611293;11918.284902905853;11963.042956563628;12006.579769708018;12632;12703.93648031754;12841.229526228457;12860.099793014399;13007.934960325516 11:47:08 INFO - PID 16950 | __end_tp_report 11:47:08 INFO - PID 16950 | __start_cc_report 11:47:08 INFO - PID 16950 | _x_x_mozilla_cycle_collect,275 11:47:08 INFO - PID 16950 | __end_cc_report 11:47:08 INFO - PID 16950 | __startTimestamp1506538028318__endTimestamp 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | ------- Summary: start ------- 11:47:08 INFO - PID 16950 | Number of tests: 6 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | [#0] dojo.html Cycles:165 Average:6176.04 Median:6457.32 stddev:837.69 (13.0%) stddev-sans-first:806.88 11:47:08 INFO - PID 16950 | Values: 3191.7 3209.3 3213.1 3213.7 3242.0 6111.9 6192.2 6221.2 6348.1 6381.6 6270.9 6299.3 6301.5 6329.0 6338.3 5760.7 5796.9 5802.6 5805.0 5825.7 5820.6 5856.8 5901.0 5909.8 5910.2 5822.4 5892.5 5901.7 5915.6 5926.5 1231.2 5732.3 5735.0 5828.5 5894.2 5749.0 5749.2 5815.1 5823.2 5837.0 6247.2 6268.2 6278.1 6304.0 6352.8 6645.0 6657.8 6744.2 6758.3 6762.5 6743.9 6757.2 6834.0 6846.8 6857.4 6136.5 6217.3 6230.8 6230.8 6245.6 6877.1 6879.2 6898.5 6988.0 7003.4 6597.8 6673.8 6701.0 6705.7 6711.9 6730.5 6745.3 6796.9 6824.4 6825.2 6547.6 6643.7 6646.6 6658.4 6670.4 6640.7 6677.3 6685.5 6688.4 6690.9 5145.6 5205.9 5257.7 5278.4 5280.1 4467.7 4551.3 4568.1 4626.5 4651.2 5697.3 5745.3 5755.0 5778.3 5789.9 6766.3 6766.6 6846.9 6857.4 6862.8 5755.4 5781.1 5792.3 5825.4 5854.6 5775.3 5782.1 5850.7 5853.8 5856.8 6457.3 6466.4 6553.9 6555.4 6627.3 6763.4 6795.0 6815.4 6835.8 6849.5 6358.6 6434.9 6493.1 6545.4 6574.1 6631.8 6655.4 6717.6 6722.5 6731.6 6798.4 6805.6 6814.8 6905.1 6918.6 6434.1 6516.8 6519.9 6525.3 6533.5 6564.2 6630.8 6640.2 6641.9 6642.1 6463.7 6499.6 6521.0 6566.3 6575.7 6554.8 6582.7 6588.7 6629.3 6648.8 6405.6 6416.7 6438.6 6447.1 6473.2 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | [#1] ext.html Cycles:180 Average:37423.41 Median:18632.60 stddev:53180.96 (285.4%) stddev-sans-first:53259.20 11:47:08 INFO - PID 16950 | Values: 838.1 846.5 874.5 897.0 906.9 40313.6 40384.6 41360.4 41756.8 41776.4 40855.0 41129.0 41202.8 41308.8 41342.4 7970.5 8108.8 8126.8 8133.3 8133.6 7989.5 8119.1 8121.8 8126.9 8128.8 8060.8 8112.0 8142.5 8149.6 8154.6 8068.6 8071.8 8099.1 8103.1 8106.1 7819.6 7941.9 7946.0 7947.4 7961.7 36625.0 36639.5 36808.0 36881.0 36911.3 3226.4 3274.9 3292.7 3292.9 3293.2 30607.0 30623.5 30783.2 30832.5 30917.2 4888.4 5144.8 5234.8 5260.9 5264.6 184242.1 184290.0 184482.0 184529.0 185474.0 44984.6 45057.8 45088.1 45156.8 45175.8 52281.5 53365.2 53384.7 53428.5 53520.0 14553.9 14582.2 14605.7 14662.4 14718.8 11677.8 11687.6 11690.7 11716.1 11720.4 14490.0 14586.7 14591.0 14604.9 14671.6 5780.5 5848.4 5866.0 5915.5 6022.4 1006.8 1018.5 1019.5 1032.7 1033.9 22892.8 23020.7 23217.5 23234.0 23234.9 1116.5 1118.2 1120.0 1129.9 1133.0 11897.0 12299.8 12326.3 12334.0 12369.8 214486.0 214664.0 231388.0 231698.0 232251.0 53381.5 54738.5 54913.0 54997.2 55204.4 1439.9 1457.6 1465.2 1467.8 1469.7 26975.2 27497.9 27562.0 27603.0 27835.7 37031.4 37386.3 37407.3 37546.0 37680.8 201715.0 204632.0 205130.0 205166.0 205721.0 32838.7 33972.0 34158.8 34241.7 34387.5 42877.4 42984.6 43347.0 43407.6 43432.6 31615.5 31715.2 31715.4 31921.8 32147.7 30804.2 31321.2 31354.2 31397.2 31581.5 35689.1 35782.0 36097.1 36097.5 36210.0 30414.2 30589.5 30665.5 30746.0 30821.2 23261.9 23282.9 23302.0 23322.8 23551.6 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | [#2] jquery.html Cycles:180 Average:34512.16 Median:22754.04 stddev:82679.07 (363.4%) stddev-sans-first:82871.75 11:47:08 INFO - PID 16950 | Values: 576.8 583.2 588.9 596.7 620.7 22197.6 22955.8 23045.7 23049.7 23068.9 22662.5 24331.6 24416.9 24579.0 24627.0 6442.9 6561.6 6590.2 6607.3 6610.3 6556.6 6646.2 6646.3 6665.0 6674.3 6600.2 6624.6 6626.5 6627.6 6636.9 6266.2 6536.5 6558.1 6559.7 6577.9 6085.3 6105.4 6113.1 6127.1 6128.9 27725.6 28040.3 28079.3 28084.7 28097.6 1956.2 2009.3 2010.2 2010.6 2011.2 18379.5 19767.0 19771.9 19849.5 19939.5 2253.9 2268.7 2317.1 2332.0 2363.6 116024.0 122841.0 129450.0 132703.0 136104.3 14950.6 14981.6 15339.7 15529.7 15648.3 23334.9 23337.0 23370.5 23418.8 23462.2 9728.1 9855.6 9867.0 9943.9 10112.1 8811.7 8918.8 8981.3 9011.3 9018.0 9097.7 9111.1 9266.9 9268.9 9331.4 2651.6 2680.9 2685.7 2708.9 2838.6 981.5 1000.9 1006.8 1007.3 1023.4 18977.4 19506.8 19528.3 19707.9 20027.0 1059.2 1061.2 1063.6 1064.1 1072.7 10648.3 10795.4 10805.4 10894.9 10961.3 480579.0 485889.0 498388.0 500392.0 500643.0 110889.0 110936.4 112257.4 112845.0 114386.0 1058.8 1109.5 1136.8 1173.6 1222.6 20123.9 20158.0 20178.9 20473.0 20545.8 57198.0 59238.0 59244.0 59276.1 59930.7 71951.6 72218.6 72517.6 72641.3 73774.6 14468.9 14576.1 14712.9 14714.9 14717.1 22572.4 22736.7 22771.4 23098.5 23239.2 16570.7 16910.2 17225.4 18156.5 18342.2 16150.4 16367.3 16970.8 16991.5 17262.8 17485.4 18499.3 18530.7 18730.6 18823.0 14360.4 14373.1 14439.3 14457.9 14462.1 18073.2 18119.9 18222.5 18375.7 18381.3 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | [#3] mootools.html Cycles:180 Average:9370.53 Median:2703.71 stddev:6792.32 (251.2%) stddev-sans-first:6784.27 11:47:08 INFO - PID 16950 | Values: 1294.8 1351.4 1366.2 1368.1 1372.8 14764.4 15363.7 15371.0 15382.2 15414.5 15013.0 15174.7 15223.2 15234.1 15240.5 2719.3 2829.2 2830.8 2831.3 2833.9 2676.8 2724.7 2775.5 2804.9 2806.7 2778.3 2829.7 2829.9 2830.0 2830.2 2681.2 2685.3 2701.6 2704.6 2709.9 2675.3 2702.9 2722.2 2725.7 2729.6 14766.7 15172.0 15199.2 15209.7 15232.2 7818.2 8120.4 8127.1 8134.9 8139.1 5171.8 5342.7 5499.2 5511.1 5515.9 1818.5 1837.2 1850.0 1884.1 1896.7 25856.1 26231.7 26448.1 26626.7 26745.7 6472.3 6478.0 6582.8 6645.8 6700.0 17512.6 17665.2 17682.2 17682.8 17804.6 7535.5 7803.0 7805.3 7814.0 7848.6 7098.7 7166.3 7382.8 7509.3 7512.9 5058.3 5219.6 5229.1 5260.1 5269.8 1486.3 1487.3 1497.4 1513.0 1513.1 870.2 895.9 901.4 903.6 906.1 7426.2 7527.1 7553.3 7558.9 7606.3 724.3 728.3 728.4 729.3 742.5 4736.4 4908.5 5079.4 5171.9 5225.5 21641.8 22150.1 22326.7 22563.8 22608.7 20834.8 21770.5 21923.8 22259.0 22545.9 9869.6 10322.9 11382.9 11888.5 11982.4 8508.3 8543.1 8552.4 8554.0 8565.1 19015.9 19200.4 19394.7 19508.5 19863.4 19192.0 19443.2 19617.5 19645.7 19812.8 11273.8 11454.0 11463.2 11464.3 11472.3 13743.5 14057.0 14170.9 14188.0 14191.3 10719.3 10752.1 10769.3 10949.5 11083.1 11054.2 11068.7 11170.8 11273.3 11468.2 9695.9 9903.6 9947.3 9990.1 10007.4 7072.2 7090.5 7162.6 7237.4 7301.1 7186.2 7387.5 7400.6 7400.9 7416.8 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | [#4] prototype.html Cycles:180 Average:5595.00 Median:6211.03 stddev:1508.34 (24.3%) stddev-sans-first:1463.63 11:47:08 INFO - PID 16950 | Values: 517.3 530.4 541.2 549.1 557.5 6227.6 6291.2 6297.2 6333.6 6415.1 6196.9 6273.2 6283.6 6294.3 6303.8 5230.9 5256.0 5259.1 5260.9 5278.4 5124.7 5129.8 5164.9 5177.6 5290.9 5106.5 5134.7 5139.5 5151.3 5194.2 5058.8 5066.2 5107.8 5138.0 5166.8 4717.2 4753.8 4771.5 4777.1 4793.5 6184.9 6191.3 6194.5 6225.1 6262.6 5813.9 5847.6 5890.2 5926.7 5964.7 6482.5 6557.4 6587.5 6613.6 6617.2 4970.4 5194.9 5213.6 5214.8 5216.6 6684.9 6809.0 6965.7 6970.7 6983.3 5300.3 5307.6 5365.6 5365.6 5387.7 5467.5 5482.8 5484.6 5489.5 5493.7 5917.7 5934.3 5949.4 5957.4 5986.1 6543.2 6638.6 6647.1 6668.5 6728.9 1894.9 1917.5 1923.9 1924.7 1932.4 1292.4 1353.2 1407.7 1411.8 1453.9 5575.5 5695.8 5722.8 5735.3 5736.4 6737.0 6770.7 6785.2 6824.2 6832.6 5754.5 5757.3 5775.1 5777.8 5819.0 3437.6 3510.7 3526.9 3558.5 3564.4 6534.7 6538.9 6550.8 6563.5 6597.7 6905.0 6920.5 6943.7 6945.1 6992.3 6500.8 6540.8 6554.2 6555.0 6581.3 6603.9 6621.4 6673.3 6690.8 6708.5 6460.7 6578.2 6635.7 6701.5 6703.3 6411.6 6471.3 6494.6 6496.3 6521.9 4966.8 4970.8 4973.8 4974.4 5038.3 6640.7 6704.5 6741.7 6744.3 6794.6 6442.0 6491.1 6528.4 6539.4 6560.3 6350.7 6369.8 6465.6 6481.7 6526.7 6250.1 6334.7 6342.5 6358.6 6418.9 6594.7 6605.4 6622.8 6628.8 6638.9 5943.5 6056.8 6255.1 6338.1 6436.5 11:47:08 INFO - PID 16950 | 11:47:08 INFO - PID 16950 | [#5] yui.html Cycles:180 Average:24229.67 Median:19806.95 stddev:34825.08 (175.8%) stddev-sans-first:34878.77 11:47:08 INFO - PID 16950 | Values: 913.9 921.4 938.3 940.8 962.2 19658.2 20233.0 20242.0 20258.9 20283.4 18401.4 18508.6 18567.3 19089.8 19225.8 947.4 967.0 970.4 970.9 971.3 964.4 984.4 987.0 987.4 999.3 1053.2 1055.6 1059.2 1059.8 1060.4 979.7 1009.7 1045.2 1046.2 1049.4 745.3 746.2 746.8 749.0 749.4 19728.6 19885.3 20007.2 20036.0 20270.4 21381.7 21990.2 22341.6 22347.0 22453.4 17829.4 17859.3 18229.9 18301.1 18420.8 3756.7 3789.2 3797.4 3799.5 3806.4 141814.0 142175.0 142186.3 142575.6 144810.0 16841.7 16846.8 17209.7 17214.7 17235.3 30700.4 31413.5 31670.8 31703.0 31744.8 8503.2 8642.6 8665.7 8704.6 8712.5 4209.2 4307.7 4316.7 4320.1 4323.5 5381.8 5398.5 5402.0 5422.0 5470.6 1015.4 1053.3 1056.6 1067.1 1069.1 593.2 599.3 611.5 618.2 626.9 11080.4 11568.9 12125.0 13135.0 13140.5 671.7 697.4 700.0 701.8 708.6 5514.6 5551.6 5569.7 5603.1 5658.4 117458.4 118591.4 119848.0 119935.4 121881.4 100259.5 103999.5 105650.5 105800.5 109839.5 88675.0 88880.0 91085.5 93244.5 93838.5 10262.9 10274.9 10468.7 10477.1 10483.1 42572.0 42746.4 43231.1 43308.4 45508.6 55261.0 57207.4 57228.1 57336.6 59189.4 15107.8 15381.8 15744.9 15745.8 15933.5 17698.0 17807.0 17824.1 17837.2 17912.6 16196.1 16284.9 16351.1 16507.8 16598.0 15881.8 16248.9 16369.4 16423.3 16451.2 16134.7 16293.3 16392.1 16554.3 16574.6 11340.1 11528.8 11918.3 11963.0 12006.6 12632.0 12703.9 12841.2 12860.1 13007.9 11:47:08 INFO - PID 16950 | -------- Summary: end -------- 11:47:08 INFO - PID 16950 | 11:47:09 INFO - TEST-INFO | 16950: exit 0 11:47:09 INFO - TEST-OK | dromaeo_css | took 1108609ms 11:47:09 INFO - TEST-START | kraken 11:47:09 INFO - Initialising browser for kraken test... 11:47:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33706/getInfo.html -profile /tmp/tmpFfhOUS/profile 11:47:09 INFO - TEST-INFO | started process 17321 (/builds/slave/test/build/application/firefox/firefox http://localhost:33706/getInfo.html) 11:47:13 INFO - TEST-INFO | 17321: exit 0 11:47:13 INFO - Browser initialized. 11:47:13 INFO - Running cycle 1/1 for kraken test... 11:47:13 INFO - Using env: {'DISPLAY': ':0', 11:47:13 INFO - 'HOME': '/home/cltbld', 11:47:13 INFO - 'JSGC_DISABLE_POISONING': '1', 11:47:13 INFO - 'LANG': 'en_US.UTF-8', 11:47:13 INFO - 'LANGUAGE': 'en_US:en', 11:47:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:47:13 INFO - 'LOGNAME': 'cltbld', 11:47:13 INFO - 'MAIL': '/var/mail/cltbld', 11:47:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:13 INFO - 'MOZ_CRASHREPORTER': '1', 11:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:47:13 INFO - 'MOZ_NO_REMOTE': '1', 11:47:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:13 INFO - 'NO_EM_RESTART': '1', 11:47:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:13 INFO - 'PWD': '/builds/slave/test', 11:47:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:13 INFO - 'RUST_BACKTRACE': 'full', 11:47:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:47:13 INFO - 'SHELL': '/bin/bash', 11:47:13 INFO - 'SHLVL': '1', 11:47:13 INFO - 'TERM': 'linux', 11:47:13 INFO - 'TMOUT': '86400', 11:47:13 INFO - 'USER': 'cltbld', 11:47:13 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747', 11:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:13 INFO - '_': '/tools/buildbot/bin/python'} 11:47:13 INFO - TEST-INFO | started process 17552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfhOUS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:14 INFO - PID 17552 | 11:47:14 INFO - PID 17552 | (/builds/slave/test/build/application/firefox/firefox:17602): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:47:14 INFO - PID 17552 | 11:47:25 INFO - PID 17552 | RSS: Main: 153128960 11:47:25 INFO - PID 17552 | 11:47:27 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33706/tests/kraken/driver.html?testName=audio-beat-detection) 11:47:28 INFO - PID 17552 | RSS: Main: 159203328 11:47:28 INFO - PID 17552 | 11:47:31 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33706/tests/kraken/driver.html?testName=audio-dft) 11:47:31 INFO - PID 17552 | RSS: Main: 159563776 11:47:31 INFO - PID 17552 | 11:47:34 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33706/tests/kraken/driver.html?testName=audio-fft) 11:47:35 INFO - PID 17552 | RSS: Main: 156110848 11:47:35 INFO - PID 17552 | 11:47:37 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33706/tests/kraken/driver.html?testName=audio-oscillator) 11:47:38 INFO - PID 17552 | RSS: Main: 156880896 11:47:38 INFO - PID 17552 | 11:47:40 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:47:40 INFO - PID 17552 | RSS: Main: 156790784 11:47:40 INFO - PID 17552 | 11:47:44 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33706/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:44 INFO - PID 17552 | RSS: Main: 159379456 11:47:44 INFO - PID 17552 | 11:47:48 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33706/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:48 INFO - PID 17552 | RSS: Main: 159252480 11:47:48 INFO - PID 17552 | 11:47:51 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33706/tests/kraken/driver.html?testName=json-parse-financial) 11:47:52 INFO - PID 17552 | RSS: Main: 159326208 11:47:52 INFO - PID 17552 | 11:47:54 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:54 INFO - PID 17552 | RSS: Main: 159461376 11:47:54 INFO - PID 17552 | 11:47:56 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:56 INFO - PID 17552 | RSS: Main: 159625216 11:47:56 INFO - PID 17552 | 11:47:59 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:59 INFO - PID 17552 | RSS: Main: 156311552 11:47:59 INFO - PID 17552 | 11:48:02 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:48:02 INFO - PID 17552 | RSS: Main: 156651520 11:48:02 INFO - PID 17552 | 11:48:05 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:48:06 INFO - PID 17552 | RSS: Main: 156762112 11:48:06 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | Cycle 1(1): loaded http://localhost:33706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33706/tests/kraken/driver.html?testName=ai-astar) 11:48:08 INFO - PID 17552 | RSS: Main: 158035968 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | __start_tp_report 11:48:08 INFO - PID 17552 | _x_x_mozilla_page_load 11:48:08 INFO - PID 17552 | _x_x_mozilla_page_load_details 11:48:08 INFO - PID 17552 | |i|pagename|runs| 11:48:08 INFO - PID 17552 | |0;ai-astar;109;108;109;110;109;98;108;107;107;109 11:48:08 INFO - PID 17552 | |1;audio-beat-detection;117;117;119;117;120;116;117;116;120;119 11:48:08 INFO - PID 17552 | |2;audio-dft;163;162;164;163;163;162;163;166;165;176 11:48:08 INFO - PID 17552 | |3;audio-fft;75;76;76;75;75;74;74;75;76;75 11:48:08 INFO - PID 17552 | |4;audio-oscillator;79;81;78;79;79;78;80;80;79;78 11:48:08 INFO - PID 17552 | |5;imaging-gaussian-blur;118;109;113;113;117;114;114;115;115;114 11:48:08 INFO - PID 17552 | |6;imaging-darkroom;153;146;147;147;149;149;148;149;148;149 11:48:08 INFO - PID 17552 | |7;imaging-desaturate;94;95;95;93;94;94;95;95;95;95 11:48:08 INFO - PID 17552 | |8;json-parse-financial;52;53;55;58;51;52;51;52;52;54 11:48:08 INFO - PID 17552 | |9;json-stringify-tinderbox;38;38;38;39;37;39;38;39;38;37 11:48:08 INFO - PID 17552 | |10;stanford-crypto-aes;94;71;80;74;73;72;73;74;74;74 11:48:08 INFO - PID 17552 | |11;stanford-crypto-ccm;113;118;117;114;119;114;114;116;119;114 11:48:08 INFO - PID 17552 | |12;stanford-crypto-pbkdf2;179;185;175;173;179;166;170;166;167;168 11:48:08 INFO - PID 17552 | |13;stanford-crypto-sha256-iterative;67;66;64;67;63;64;65;65;66;67 11:48:08 INFO - PID 17552 | __end_tp_report 11:48:08 INFO - PID 17552 | __start_cc_report 11:48:08 INFO - PID 17552 | _x_x_mozilla_cycle_collect,727 11:48:08 INFO - PID 17552 | __end_cc_report 11:48:08 INFO - PID 17552 | __startTimestamp1506538088442__endTimestamp 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | ------- Summary: start ------- 11:48:08 INFO - PID 17552 | Number of tests: 14 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.44 (3.2%) stddev-sans-first:3.60 11:48:08 INFO - PID 17552 | Values: 109.0 108.0 109.0 110.0 109.0 98.0 108.0 107.0 107.0 109.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:118.00 stddev:1.55 (1.3%) stddev-sans-first:1.62 11:48:08 INFO - PID 17552 | Values: 117.0 117.0 119.0 117.0 120.0 116.0 117.0 116.0 120.0 119.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.16 (2.5%) stddev-sans-first:4.37 11:48:08 INFO - PID 17552 | Values: 163.0 162.0 164.0 163.0 163.0 162.0 163.0 166.0 165.0 176.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 11:48:08 INFO - PID 17552 | Values: 75.0 76.0 76.0 75.0 75.0 74.0 74.0 75.0 76.0 75.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 11:48:08 INFO - PID 17552 | Values: 79.0 81.0 78.0 79.0 79.0 78.0 80.0 80.0 79.0 78.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:2.44 (2.1%) stddev-sans-first:2.17 11:48:08 INFO - PID 17552 | Values: 118.0 109.0 113.0 113.0 117.0 114.0 114.0 115.0 115.0 114.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.90 (1.3%) stddev-sans-first:1.12 11:48:08 INFO - PID 17552 | Values: 153.0 146.0 147.0 147.0 149.0 149.0 148.0 149.0 148.0 149.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 11:48:08 INFO - PID 17552 | Values: 94.0 95.0 95.0 93.0 94.0 94.0 95.0 95.0 95.0 95.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.50 stddev:2.16 (4.1%) stddev-sans-first:2.26 11:48:08 INFO - PID 17552 | Values: 52.0 53.0 55.0 58.0 51.0 52.0 51.0 52.0 52.0 54.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.74 (1.9%) stddev-sans-first:0.78 11:48:08 INFO - PID 17552 | Values: 38.0 38.0 38.0 39.0 37.0 39.0 38.0 39.0 38.0 37.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:74.00 stddev:6.79 (9.2%) stddev-sans-first:2.52 11:48:08 INFO - PID 17552 | Values: 94.0 71.0 80.0 74.0 73.0 72.0 73.0 74.0 74.0 74.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:116.50 stddev:2.30 (2.0%) stddev-sans-first:2.20 11:48:08 INFO - PID 17552 | Values: 113.0 118.0 117.0 114.0 119.0 114.0 114.0 116.0 119.0 114.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.00 stddev:6.56 (3.8%) stddev-sans-first:6.57 11:48:08 INFO - PID 17552 | Values: 179.0 185.0 175.0 173.0 179.0 166.0 170.0 166.0 167.0 168.0 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.39 11:48:08 INFO - PID 17552 | Values: 67.0 66.0 64.0 67.0 63.0 64.0 65.0 65.0 66.0 67.0 11:48:08 INFO - PID 17552 | -------- Summary: end -------- 11:48:08 INFO - PID 17552 | 11:48:08 INFO - PID 17552 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:48:09 INFO - TEST-INFO | 17552: exit 0 11:48:09 INFO - TEST-OK | kraken | took 60131ms 11:48:09 INFO - SUITE-END | took 1168s 11:48:09 INFO - Completed test suite (00:19:29) 11:48:09 INFO - javascript benchmark 11:48:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8530.507654531557, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.6967888050635, 3209.3260415312784, 3213.052149615863, 3213.726833219176, 3242.0, 6111.877762444748, 6192.164057852195, 6221.191245138137, 6348.111264422979, 6381.649009304487, 6270.937290627093, 6299.275583307909, 6301.495880329574, 6329.019002054689, 6338.33447488014, 5760.740766665489, 5796.913046304308, 5802.564807639423, 5804.970975145118, 5825.679587622701, 5820.563457740665, 5856.824295271149, 5901.026330655437, 5909.8227053188475, 5910.231669882931, 5822.3886491918165, 5892.499137573312, 5901.734421951022, 5915.5859089863725, 5926.496247818941, 1231.2362183656724, 5732.3121225453215, 5735.0, 5828.473802975476, 5894.233749612566, 5749.022666146765, 5749.223854779593, 5815.09865970771, 5823.2138661280605, 5836.97081514594, 6247.219097612799, 6268.1851359323, 6278.121063051177, 6303.968480157616, 6352.809415717536, 6645.0, 6657.800265992028, 6744.190697116328, 6758.324167583251, 6762.526623136382, 6743.865122697568, 6757.222919364287, 6834.0, 6846.7945961621235, 6857.382835544825, 6136.478399336062, 6217.285012223607, 6230.844228894269, 6230.844228894269, 6245.62526248422, 6877.105976223059, 6879.2432832388395, 6898.482613803984, 6988.021676965229, 7003.369696727217, 6597.80206593803, 6673.799786006331, 6701.028350889093, 6705.731770729214, 6711.932880671228, 6730.495212859055, 6745.258021617618, 6796.932030679729, 6824.41992430639, 6825.180978282638, 6547.607143571306, 6643.701033453506, 6646.567973081735, 6658.367455091856, 6670.433013193933, 6640.734370625121, 6677.332266773381, 6685.532012759158, 6688.3646053624825, 6690.899636505456, 5145.588352931756, 5205.895882082413, 5257.684538927677, 5278.366596008504, 5280.128778751463, 4467.6649251305635, 4551.294549344857, 4568.132054909556, 4626.537346265347, 4651.162790697639, 5697.287839020122, 5745.2818397700285, 5755.0, 5778.27771528559, 5789.8552536186935, 6766.28953959837, 6766.594004359754, 6846.863062738817, 6857.382835544825, 6862.828429289308, 5755.395683453261, 5781.103928891029, 5792.333881603669, 5825.417458254141, 5854.560907931837, 5775.306963164448, 5782.132680098019, 5850.736716847752, 5853.824385268449, 5856.765729370863, 6457.321981191907, 6466.385693359123, 6553.868922621521, 6555.442787363032, 6627.304133066055, 6763.357481039294, 6795.0, 6815.386615204656, 6835.760748373783, 6849.48628852848, 6358.618482891041, 6434.903476447951, 6493.090967264681, 6545.37818907203, 6574.112494813139, 6631.801045968628, 6655.401013908771, 6717.596944183365, 6722.495812814156, 6731.562448440835, 6798.354156355138, 6805.625690586867, 6814.761483348059, 6905.102336696197, 6918.619475928671, 6434.0670602763275, 6516.771912983023, 6519.869602608016, 6525.282218956006, 6533.509986751108, 6564.179477565304, 6630.7679231226675, 6640.236372817188, 6641.867162656623, 6642.070110184482, 6463.709133089116, 6499.5775274607, 6521.0, 6566.343365663395, 6575.736970521317, 6554.820132376218, 6582.670866456562, 6588.670566471561, 6629.270780214269, 6648.767293144717, 6405.551611387158, 6416.711247993758, 6438.6136831790245, 6447.097406363207, 6473.2232132144445], "value": 6115.568258891137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.1492784823402, 846.5386364431384, 874.4796845876704, 897.0222457521301, 906.891173059233, 40313.59686403135, 40384.59615403845, 41360.37959430607, 41756.791216043915, 41776.373354399635, 40855.0, 41129.0, 41202.793986030105, 41308.793456032676, 41342.37986430198, 7970.521768693868, 8108.824220488025, 8126.837463250731, 8133.2680058794695, 8133.552654603995, 7989.480683755537, 8119.106898241189, 8121.837563248731, 8126.878096828552, 8128.796780080486, 8060.798480038016, 8112.0, 8142.47073940192, 8149.551774652392, 8154.592270386457, 8068.596570171468, 8071.757847264592, 8099.149589293098, 8103.149169337194, 8106.148854370324, 7819.648115834744, 7941.880871786928, 7946.0, 7947.4039447041705, 7961.681532738684, 36625.0, 36639.450408243894, 36808.0, 36881.0, 36911.26177476462, 3226.370857682753, 3274.8690052397874, 3292.687194716498, 3292.8682852685865, 3293.2096296888813, 30607.0, 30623.540646890313, 30783.230419239473, 30832.53751193734, 30917.22706932322, 4888.364512613338, 5144.768485418128, 5234.842954711365, 5260.947390526084, 5264.578833693296, 184242.07878960654, 184290.0, 184482.0, 184529.0, 185474.0, 44984.55015449869, 45057.774711126236, 45088.098238035054, 45156.774216129365, 45175.77412112919, 52281.47718522766, 53365.1995220072, 53384.73307633437, 53428.465715343125, 53520.0, 14553.92723036378, 14582.197979111039, 14605.707885842223, 14662.413503459955, 14718.779218311734, 11677.824832627517, 11687.649370518899, 11690.70773230659, 11716.062714982781, 11720.355380454157, 14490.0, 14586.708265834624, 14591.0, 14604.926975365055, 14671.633209169857, 5780.450857168562, 5848.444397782204, 5866.032104702762, 5915.526757859361, 6022.397760223943, 1006.8187726209206, 1018.5365658625308, 1019.5463018956641, 1032.7056788815303, 1033.8862725100232, 22892.771072289397, 23020.65469017966, 23217.53564928692, 23233.954472048797, 23234.883825580764, 1116.4585176189541, 1118.1502058435647, 1119.9888001119884, 1129.9096072314196, 1132.9773404531863, 11897.048236141089, 12299.754004919852, 12326.31778725614, 12333.95161411272, 12369.814452783216, 214486.0, 214664.0, 231388.0, 231698.0, 232251.0, 53381.466185338424, 54738.45261547333, 54913.0, 54997.175042374394, 55204.447955520736, 1439.9352029158713, 1457.5554455890842, 1465.1868213141809, 1467.8091848059685, 1469.6840179361488, 26975.190744277705, 27497.86251068732, 27562.0, 27603.0, 27835.721642784123, 37031.44452833156, 37386.252274953804, 37407.251854962204, 37546.0, 37680.81159594184, 201715.0, 204632.0, 205130.0, 205166.0, 205721.0, 32838.671613283565, 33972.0, 34158.8292058548, 34241.65758342385, 34387.48418773671, 42877.356839648055, 42984.57015429805, 43347.0, 43407.56592434035, 43432.565674342855, 31615.525767113973, 31715.20711982219, 31715.36569268648, 31921.840390797897, 32147.67852321447, 30804.22989425282, 31321.21696957503, 31354.21614459657, 31397.215069623442, 31581.526277105404, 35689.1077723059, 35782.0, 36097.097572560895, 36097.45853812143, 36210.0, 30414.239644009078, 30589.54115688222, 30665.54001690021, 30746.0, 30821.22946926345, 23261.883690582115, 23282.883585581963, 23301.951412186154, 23322.76677233206, 23551.646725298793], "value": 17181.785882724445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7779404929104, 583.2417856786177, 588.9411058894109, 596.749365266588, 620.658637749238, 22197.556048879032, 22955.770442295572, 23045.654315185264, 23049.654255186142, 23068.88465557674, 22662.546749065008, 24331.635025474632, 24416.877915610443, 24579.0, 24627.0, 6442.903356449645, 6561.639109848957, 6590.176227971504, 6607.306232845554, 6610.338966103375, 6556.573822701533, 6646.169228846395, 6646.302138275484, 6664.966675166617, 6674.3325667433355, 6600.207975043001, 6624.5694029888145, 6626.5030122740745, 6627.60234385936, 6636.900446493307, 6266.185395898527, 6536.477081833442, 6558.114654521626, 6559.672016399209, 6577.901331480056, 6085.2697676278685, 6105.358937311563, 6113.083037544359, 6127.050307202391, 6128.908066379008, 27725.58411623807, 28040.298992525146, 28079.29801754952, 28084.719152808415, 28097.578536321973, 1956.2370675436591, 2009.2967461388544, 2010.1758279105497, 2010.5677279385002, 2011.1754180785808, 18379.540511487186, 19767.0, 19771.90114049435, 19849.50376240591, 19939.50151246216, 2253.921112761062, 2268.6823844661762, 2317.1310758465575, 2331.9650205246935, 2363.6218205087102, 116024.0, 122841.0, 129450.0, 132703.0, 136104.31947840296, 14950.626234344229, 14981.625459363604, 15339.693206135815, 15529.689406211812, 15648.295826687827, 23334.883325583603, 23337.0, 23370.532589348117, 23418.765812342, 23462.17882374143, 9728.124468797841, 9855.55649995752, 9867.0, 9943.900560994298, 10112.140468060297, 8811.735647930573, 8918.821623567492, 8981.326400519856, 9011.27909767217, 9018.0, 9097.727068187965, 9111.134442227978, 9266.860997085048, 9268.907310926805, 9331.393459425251, 2651.57574788033, 2680.865956702196, 2685.7179996100517, 2708.945821083607, 2838.6451693538306, 981.474910922653, 1000.9349392289478, 1006.7734759679014, 1007.2797949466167, 1023.4217667018111, 18977.43067707971, 19506.80493195078, 19528.316508922402, 19707.901460492893, 20027.0, 1059.1579694143174, 1061.1987949098382, 1063.5586231713753, 1064.1486810551528, 1072.7210925159516, 10648.307859989076, 10795.352278863136, 10805.405702686428, 10894.891051089546, 10961.287516311415, 480579.0, 485889.0, 498388.0, 500392.0, 500643.0, 110889.0, 110936.4453177729, 112257.43871280592, 112845.0, 114386.0, 1058.8305871060593, 1109.517359948425, 1136.78969390663, 1173.6185739634652, 1222.5598784437595, 20123.899380503004, 20157.992100395215, 20178.899105504377, 20473.0, 20545.794542054387, 57198.0, 59238.0, 59244.0, 59276.11085833802, 59930.700346497986, 71951.64024179845, 72218.63890680514, 72517.6374118147, 72641.27358726345, 73774.63112684402, 14468.85531144675, 14576.125432474086, 14712.852871471148, 14714.852851471776, 14717.116972981656, 22572.435689107904, 22736.65895011543, 22771.430714232276, 23098.538029238985, 23239.186628467924, 16570.66858662796, 16910.154492275582, 17225.39711110105, 18156.45530634083, 18342.17460214267, 16150.434734784696, 16367.345306187619, 16970.830291697417, 16991.49025529236, 17262.82737172612, 17485.388011419538, 18499.260029598667, 18530.722039169155, 18730.625387492448, 18823.0, 14360.425582976564, 14373.06575072617, 14439.278036098363, 14457.92771036138, 14462.132272063709, 18073.18670659797, 18119.909400452914, 18222.544436389195, 18375.724364134283, 18381.264749409875], "value": 11924.136507648713, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.7928331466965, 1351.3648585164974, 1366.24856329019, 1368.0628769293035, 1372.7529044771943, 14764.409423623056, 15363.692726145471, 15371.0, 15382.230888455575, 15414.460493882716, 15013.0, 15174.696506069871, 15223.23883805808, 15234.085954842689, 15240.542783716506, 2719.3201699575056, 2829.221963959907, 2830.844303563303, 2831.3346363604637, 2833.858307084648, 2676.7992400569938, 2724.7329991553925, 2775.5420355641395, 2804.9158525244175, 2806.7473927346537, 2778.305423644089, 2829.7170282971642, 2829.8868045278164, 2830.023641843571, 2830.221689035521, 2681.182239416977, 2685.301821526398, 2701.6082668013128, 2704.5537486314734, 2709.9322516937036, 2675.291047872315, 2702.8648567571545, 2722.2377734234447, 2725.68654604721, 2729.6178535005115, 14766.70466590673, 15172.013819101834, 15199.164045977466, 15209.695806083817, 15232.238388080552, 7818.179091195457, 8120.3503719702285, 8127.065387480457, 8134.877976830352, 8139.104698483221, 5171.844844654666, 5342.67943923362, 5499.175123731432, 5511.090670039479, 5515.944840551583, 1818.5362732503258, 1837.2467288411822, 1849.9722504162448, 1884.1144662008835, 1896.7439395681545, 25856.095036673625, 26231.73768262312, 26448.07431739899, 26626.73373266262, 26745.73254267452, 6472.255690595548, 6477.967610161919, 6582.8354291143105, 6645.767398141139, 6700.0, 17512.562185945197, 17665.205065772072, 17682.204300806494, 17682.82317176812, 17804.643907121786, 7535.472516923873, 7803.02462192226, 7805.297523222937, 7813.960930195312, 7848.607569621496, 7098.716051357887, 7166.319199676022, 7382.778516644509, 7509.286617771303, 7512.924870751332, 5058.317127187856, 5219.556337711337, 5229.137192363293, 5260.105782017066, 5269.841904742864, 1486.3385793322084, 1487.2861026707242, 1497.4309762290477, 1512.9848701513065, 1513.0770230159594, 870.1820288928387, 895.9328050396247, 901.396064636695, 903.6159632156307, 906.0712769411406, 7426.220246874109, 7527.096748390119, 7553.32020118192, 7558.886616700754, 7606.277403646644, 724.3263764698776, 728.3117454005913, 728.3772374619624, 729.3290173040815, 742.4617152564456, 4736.407949006374, 4908.509149085063, 5079.3650793650795, 5171.922421163686, 5225.451327610622, 21641.78358216429, 22150.113995440322, 22326.665100023514, 22563.774362256496, 22608.660870086962, 20834.79165208359, 21770.47606667518, 21923.780762192175, 22259.0, 22545.887270563544, 9869.605215791287, 10322.948385258176, 11382.886171138183, 11888.465019074163, 11982.400879955967, 8508.319334453352, 8543.0602633709, 8552.401331906707, 8554.0, 8565.100664430394, 19015.90492047531, 19200.423987280403, 19394.70907936354, 19508.512287192934, 19863.404097877086, 19192.0, 19443.222271108996, 19617.52868534894, 19645.70531442001, 19812.801871981097, 11273.774524509628, 11454.0, 11463.197576169921, 11464.31214127155, 11472.254303470248, 13743.450261989808, 14057.0, 14170.92914535462, 14188.0, 14191.290435477978, 10719.303245289031, 10752.13982881352, 10769.299995500267, 10949.507272172612, 11083.113350932068, 11054.170937179904, 11068.723281918017, 11170.776584468427, 11273.267237629529, 11468.197226194086, 9695.9030409695, 9903.603855845686, 9947.253955953187, 9990.100890919852, 10007.399556026661, 7072.186698529735, 7090.539114957512, 7162.64186790648, 7237.384822289953, 7301.123865136217, 7186.209516953236, 7387.519811212254, 7400.592967386845, 7400.888986665097, 7416.814579635552], "value": 6627.500995789702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.3274742834315, 530.4085944172248, 541.2017274520083, 549.0994768579528, 557.453695378529, 6227.602373086361, 6291.182146320977, 6297.244330680313, 6333.606606546558, 6415.101885736, 6196.932518403385, 6273.247210334766, 6283.622982621046, 6294.33909439508, 6303.842403939904, 5230.947690523084, 5256.027634887539, 5259.105951988171, 5260.868478288055, 5278.419373868871, 5124.694572001057, 5129.84578469845, 5164.92252616211, 5177.559907407875, 5290.947090529084, 5106.489351064901, 5134.691918484884, 5139.537441630253, 5151.304573882534, 5194.168932970725, 5058.7976480940715, 5066.164082926312, 5107.7956881724685, 5138.023775482647, 5166.844994650167, 4717.174494463489, 4753.789487888149, 4771.498992605796, 4777.092352453057, 4793.520647935214, 6184.856146381935, 6191.349908259613, 6194.5354098442795, 6225.132460261903, 6262.5929314594405, 5813.854653633651, 5847.590668653196, 5890.2342695449315, 5926.733297001645, 5964.701764911737, 6482.481401487869, 6557.442617377481, 6587.473002159816, 6613.636250006248, 6617.239017512999, 4970.353853998957, 5194.948050519484, 5213.618391126354, 5214.817481388133, 5216.556592689588, 6684.899726504106, 6809.0, 6965.65171741421, 6970.686319115652, 6983.336583024656, 5300.277409841817, 5307.6284660073425, 5365.6244062916, 5365.6244062916, 5387.703676297841, 5467.480589344006, 5482.780688772405, 5484.588655850827, 5489.505944465017, 5493.697846618395, 5917.733701983335, 5934.258217722785, 5949.405059494103, 5957.4042595740075, 5986.07215881539, 6543.233327001778, 6638.5684930479365, 6647.135872336662, 6668.499862510331, 6728.889733194066, 1894.8957807320453, 1917.475606892496, 1923.8941858197654, 1924.6631839428323, 1932.4202739178472, 1292.373198998485, 1353.2151352215888, 1407.718975732079, 1411.84469708332, 1453.883689304853, 5575.470330318613, 5695.829125126253, 5722.77108915647, 5735.311762588516, 5736.397678243808, 6736.966315168491, 6770.69531871067, 6785.16800463872, 6824.18109826824, 6832.624205668637, 5754.4533269339345, 5757.337906140848, 5775.133729940459, 5777.768889244468, 5819.0, 3437.570303712036, 3510.736694747904, 3526.9118272042892, 3558.5373901392654, 3564.3940530109944, 6534.738610455529, 6538.901916471256, 6550.7707230246715, 6563.540552161303, 6597.73609055642, 6905.0, 6920.4809639277255, 6943.6875340609795, 6945.09713737221, 6992.2658120897595, 6500.804975850732, 6540.771073012422, 6554.180727409074, 6554.9672251639395, 6581.288864895066, 6603.933960660332, 6621.404073633396, 6673.332666733482, 6690.765823196165, 6708.463322934251, 6460.675561509785, 6578.210614726072, 6635.701393437211, 6701.463882889455, 6703.29615390377, 6411.615303081643, 6471.288158302489, 6494.571194337238, 6496.317886621837, 6521.934780652133, 4966.751662416792, 4970.826021089245, 4973.825916092919, 4974.427940786856, 5038.269450929668, 6640.734370625121, 6704.463642908653, 6741.696623651849, 6744.258131605618, 6794.626295553792, 6442.0, 6491.091247225298, 6528.37980391862, 6539.444147247347, 6560.278369379269, 6350.68246587678, 6369.77705780314, 6465.64438955862, 6481.708323125565, 6526.67366631676, 6250.06249062626, 6334.714937827716, 6342.52431067681, 6358.554901156875, 6418.871622567616, 6594.703238354382, 6605.405513503808, 6622.768203113061, 6628.801135965929, 6638.933610663831, 5943.514121469632, 6056.788012419544, 6255.093011513396, 6338.116157148578, 6436.549441539235], "value": 5165.005394909967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.9268858491322, 921.3596550397474, 938.3384713776784, 940.7507010642181, 962.1917589225052, 19658.213671453126, 20233.0, 20242.0, 20258.89870550649, 20283.391498255038, 18401.447956561293, 18508.629827403445, 18567.257309707595, 19089.80910190901, 19225.807741922577, 947.4362754161281, 967.013646080997, 970.3789574672215, 970.9417434953925, 971.3103696375547, 964.3779762053472, 984.3700031979539, 986.9851952220722, 987.4026214140414, 999.2655398282257, 1053.2364036073861, 1055.5566662001977, 1059.1738444013681, 1059.830427131659, 1060.3849767135043, 979.6816034788651, 1009.6970908727352, 1045.1847558904028, 1046.2362475392968, 1049.3913530152493, 745.2584678245181, 746.220199891115, 746.8319628083692, 749.0187853911393, 749.3667850666178, 19728.60542789136, 19885.304014359426, 20007.1997120115, 20036.0, 20270.39188824323, 21381.67927481089, 21990.230341938117, 22341.55316893653, 22347.0, 22453.438664033365, 17829.375971840924, 17859.285628574842, 18229.908850455664, 18301.08494575266, 18420.815791842044, 3756.69946404287, 3789.1853251550774, 3797.4493698413853, 3799.525059367579, 3806.352920003606, 141814.0, 142175.0, 142186.28906855502, 142575.57424425727, 144810.0, 16841.747373789403, 16846.831531684773, 17209.65580688379, 17214.65570688579, 17235.31058757661, 30700.38599228003, 31413.528797068062, 31670.841645791625, 31703.0, 31744.841275793475, 8503.1921967413, 8642.611082501302, 8665.653373864974, 8704.564771761387, 8712.520811355436, 4209.24233637942, 4307.655387568987, 4316.676249281317, 4320.071184695243, 4323.546027667113, 5381.811636592701, 5398.460153984649, 5402.0, 5422.024035673617, 5470.64440811346, 1015.3653966271081, 1053.2679787547581, 1056.5773690523852, 1067.108964015056, 1069.1072954083427, 593.2139914613155, 599.27188466014, 611.5230120506012, 618.227215980025, 626.865223976838, 11080.445977701083, 11568.942155289169, 12124.969377603002, 13135.0, 13140.540081097115, 671.7313074770132, 697.3723648716094, 699.993000070003, 701.768396464202, 708.5961002228784, 5514.5864060195645, 5551.583631227674, 5569.749361278752, 5603.131514615241, 5658.434156584309, 117458.41270793592, 118591.40704296423, 119848.0, 119935.40032299783, 121881.39059304647, 100259.49870250748, 103999.4800025995, 105650.47174764077, 105800.47099764606, 109839.45080274547, 88675.0, 88880.0, 91085.54457227804, 93244.53377733068, 93838.53080734552, 10262.948685256824, 10274.897251027394, 10468.738281543023, 10477.057064863893, 10483.108935740547, 42572.0, 42746.358804618576, 43231.05460254359, 43308.35037474377, 45508.63474095782, 55261.0, 57207.42792572021, 57228.1415778772, 57336.56658583569, 59189.40810591839, 15107.773383399039, 15381.76927346113, 15744.92127539355, 15745.763813542577, 15933.521994340188, 17698.0, 17807.0, 17824.10879455996, 17837.197326120615, 17912.641747165246, 16196.109213993344, 16284.91857540752, 16351.100689461719, 16507.752383714014, 16598.0, 15881.8411815885, 16248.918755406148, 16369.427070052967, 16423.260953256893, 16451.177441127656, 16134.67730645357, 16293.26680299413, 16392.119345869814, 16554.337826486804, 16574.585635359213, 11340.09279257674, 11528.769424611293, 11918.284902905853, 11963.042956563628, 12006.579769708018, 12632.0, 12703.93648031754, 12841.229526228457, 12860.099793014399, 13007.934960325516], "value": 8984.034793863122, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1422.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 109.0, 110.0, 109.0, 98.0, 108.0, 107.0, 107.0, 109.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 120.0, 116.0, 117.0, 116.0, 120.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 163.0, 162.0, 163.0, 166.0, 165.0, 176.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 75.0, 75.0, 74.0, 74.0, 75.0, 76.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 79.0, 79.0, 78.0, 80.0, 80.0, 79.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 109.0, 113.0, 113.0, 117.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 146.0, 147.0, 147.0, 149.0, 149.0, 148.0, 149.0, 148.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 93.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 58.0, 51.0, 52.0, 51.0, 52.0, 52.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 37.0, 39.0, 38.0, 39.0, 38.0, 37.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 71.0, 80.0, 74.0, 73.0, 72.0, 73.0, 74.0, 74.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 117.0, 114.0, 119.0, 114.0, 114.0, 116.0, 119.0, 114.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 185.0, 175.0, 173.0, 179.0, 166.0, 170.0, 166.0, 167.0, 168.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 67.0, 63.0, 64.0, 65.0, 65.0, 66.0, 67.0], "value": 65.4, "unit": "score"}]}]} 11:48:09 INFO - Return code: 0 11:48:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:48:09 INFO - # TBPL SUCCESS # 11:48:09 INFO - Running post-action listener: _package_coverage_data 11:48:09 INFO - Running post-action listener: _resource_record_post_action 11:48:09 INFO - [mozharness: 2017-09-27 18:48:09.719821Z] Finished run-tests step (success) 11:48:09 INFO - Running post-run listener: _resource_record_post_run 11:48:09 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 342794240; Read time: 0; Write time: 178652 11:48:09 INFO - TinderboxPrint: CPU usage
13.1% 11:48:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:48:09 INFO - TinderboxPrint: I/O write bytes / time
342,794,240 / 178,652 11:48:09 INFO - TinderboxPrint: CPU idle
8,222.6 (86.9%) 11:48:09 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 11:48:09 INFO - TinderboxPrint: Swap in / out
0 / 0 11:48:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9998336; Read time: 0; Write time: 1008 11:48:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:48:09 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 332288000; Read time: 0; Write time: 177644 11:48:10 INFO - Running post-run listener: _upload_blobber_files 11:48:10 INFO - Blob upload gear active. 11:48:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:48:10 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 11:48:10 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'] 11:48:10 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 11:48:10 INFO - (blobuploader) - INFO - Open directory for files ... 11:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:11 INFO - (blobuploader) - INFO - Done attempting. 11:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:18 INFO - (blobuploader) - INFO - Done attempting. 11:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:19 INFO - (blobuploader) - INFO - Done attempting. 11:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:20 INFO - (blobuploader) - INFO - Done attempting. 11:48:20 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:20 INFO - Return code: 0 11:48:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:48:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca898569be7b811103b7772260196d0f322d9e0399b30fa3c975bea6f4ccdcc5bcbabcc0a899969e9dd9fdf1efe460482c59ba74084c24f9a4c2eaf68639f332", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f67cbb106716dd7ee3636a2844559e8822995dbc938bb2c898f23d260e07ee9e69988bd11ac17c30ed1419e5b67e943f9038b2c5265d15b7d0341b1c555187e4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53855c935ecf173c02cfbf951013c6611d2482b8a891f82f0df8598b5273ff576bb73b62ae49f42cfb07296ed24da67d7de3bb464680774aa5020125f64c783", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/750626dd7c4b29239347cf50c5a6b13efd037ba01eb77a7810c951c67b0f7ef5d36b58fa54954917e2611dbf2c04785663aece13d70a233fd8d52d0315d72dfc"} 11:48:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:48:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:48:20 INFO - Contents: 11:48:20 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca898569be7b811103b7772260196d0f322d9e0399b30fa3c975bea6f4ccdcc5bcbabcc0a899969e9dd9fdf1efe460482c59ba74084c24f9a4c2eaf68639f332", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f67cbb106716dd7ee3636a2844559e8822995dbc938bb2c898f23d260e07ee9e69988bd11ac17c30ed1419e5b67e943f9038b2c5265d15b7d0341b1c555187e4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53855c935ecf173c02cfbf951013c6611d2482b8a891f82f0df8598b5273ff576bb73b62ae49f42cfb07296ed24da67d7de3bb464680774aa5020125f64c783", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/750626dd7c4b29239347cf50c5a6b13efd037ba01eb77a7810c951c67b0f7ef5d36b58fa54954917e2611dbf2c04785663aece13d70a233fd8d52d0315d72dfc"} 11:48:20 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:20 INFO - Copying logs to upload dir... 11:48:20 INFO - mkdir: /builds/slave/test/build/upload/logs 11:48:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.298460 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-27 11:48:19.852758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:19.860349) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747 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/ca898569be7b811103b7772260196d0f322d9e0399b30fa3c975bea6f4ccdcc5bcbabcc0a899969e9dd9fdf1efe460482c59ba74084c24f9a4c2eaf68639f332", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f67cbb106716dd7ee3636a2844559e8822995dbc938bb2c898f23d260e07ee9e69988bd11ac17c30ed1419e5b67e943f9038b2c5265d15b7d0341b1c555187e4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53855c935ecf173c02cfbf951013c6611d2482b8a891f82f0df8598b5273ff576bb73b62ae49f42cfb07296ed24da67d7de3bb464680774aa5020125f64c783", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/750626dd7c4b29239347cf50c5a6b13efd037ba01eb77a7810c951c67b0f7ef5d36b58fa54954917e2611dbf2c04785663aece13d70a233fd8d52d0315d72dfc"} build_url:https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/d8mZXx0pQCyLHthBkHAPng/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca898569be7b811103b7772260196d0f322d9e0399b30fa3c975bea6f4ccdcc5bcbabcc0a899969e9dd9fdf1efe460482c59ba74084c24f9a4c2eaf68639f332", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f67cbb106716dd7ee3636a2844559e8822995dbc938bb2c898f23d260e07ee9e69988bd11ac17c30ed1419e5b67e943f9038b2c5265d15b7d0341b1c555187e4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d53855c935ecf173c02cfbf951013c6611d2482b8a891f82f0df8598b5273ff576bb73b62ae49f42cfb07296ed24da67d7de3bb464680774aa5020125f64c783", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/750626dd7c4b29239347cf50c5a6b13efd037ba01eb77a7810c951c67b0f7ef5d36b58fa54954917e2611dbf2c04785663aece13d70a233fd8d52d0315d72dfc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:19.893145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:19.893470) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506536770.611842-1023599747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:48:19.975849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:48:19.976164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:48:19.976489) ========= ========= Total master_lag: 0.15 =========