builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1505408514.66 results: success (0) revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:54.658915) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:54.659338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:54.659607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:54.939492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:54.939799) ========= 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=ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 10:01:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.5M=0s 2017-09-14 10:01:54 (80.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118638 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.105754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.106050) ========= 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=ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016102 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.259746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-14 10:01:55.260073) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b --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 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b --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=ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 10:01:54,763 truncating revision to first 12 chars 2017-09-14 10:01:54,763 Setting DEBUG logging. 2017-09-14 10:01:54,763 attempt 1/10 2017-09-14 10:01:54,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/943c2c2a1daf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 10:01:55,369 attempt 1/10 2017-09-14 10:01:55,951 current task status: no status available at this point. state: STARTED 2017-09-14 10:01:55,951 sleeping for 11.00s (attempt 1/10) 2017-09-14 10:02:06,963 attempt 2/10 2017-09-14 10:02:07,292 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-14 10:02:07,474 unpacking tar archive at: mozilla-central-943c2c2a1daf/testing/mozharness/ program finished with exit code 0 elapsedTime=12.997606 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-14 10:02:08.309714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.310015) ========= script_repo_revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.313442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.313719) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.327071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-14 10:02:08.327477) ========= /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=ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:02:07 INFO - MultiFileLogger online at 20170914 10:02:07 in /builds/slave/test 10:02:07 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 10:02:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:07 INFO - {'append_to_log': False, 10:02:07 INFO - 'base_work_dir': '/builds/slave/test', 10:02:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:02:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:07 INFO - 'branch': 'Firefox-Non-PGO', 10:02:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:07 INFO - 'code_coverage': False, 10:02:07 INFO - 'config_files': ('talos/linux_config.py',), 10:02:07 INFO - 'default_actions': ('clobber', 10:02:07 INFO - 'read-buildbot-config', 10:02:07 INFO - 'download-and-extract', 10:02:07 INFO - 'populate-webroot', 10:02:07 INFO - 'create-virtualenv', 10:02:07 INFO - 'install', 10:02:07 INFO - 'setup-mitmproxy', 10:02:07 INFO - 'run-tests'), 10:02:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:07 INFO - 'disable_ccov_upload': False, 10:02:07 INFO - 'disable_stylo': False, 10:02:07 INFO - 'download_minidump_stackwalk': True, 10:02:07 INFO - 'download_symbols': 'ondemand', 10:02:07 INFO - 'enable_stylo': False, 10:02:07 INFO - 'enable_webrender': False, 10:02:07 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:02:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:07 INFO - 'gecko_profile': False, 10:02:07 INFO - 'gecko_profile_interval': 0, 10:02:07 INFO - 'installer_path': 'installer.exe', 10:02:07 INFO - 'log_level': 'info', 10:02:07 INFO - 'log_name': 'talos', 10:02:07 INFO - 'log_to_console': True, 10:02:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:02:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:02:07 INFO - 'opt_config_files': (), 10:02:07 INFO - 'pip_index': False, 10:02:07 INFO - 'suite': 'dromaeojs-e10s', 10:02:07 INFO - 'system_bits': '32', 10:02:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:07 INFO - 'title': 'talos-linux64-ix-050', 10:02:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:07 INFO - 'use_talos_json': True, 10:02:07 INFO - 'verify': 'False', 10:02:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:07 INFO - 'work_dir': 'build'} 10:02:07 INFO - [mozharness: 2017-09-14 17:02:07.936122Z] Running clobber step. 10:02:07 INFO - Running pre-action listener: _resource_record_pre_action 10:02:07 INFO - Running main action method: clobber 10:02:07 INFO - rmtree: /builds/slave/test/build 10:02:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:08 INFO - Running post-action listener: _resource_record_post_action 10:02:08 INFO - [mozharness: 2017-09-14 17:02:08.941580Z] Finished clobber step (success) 10:02:08 INFO - [mozharness: 2017-09-14 17:02:08.941679Z] Running read-buildbot-config step. 10:02:08 INFO - Running pre-action listener: _resource_record_pre_action 10:02:08 INFO - Running main action method: read_buildbot_config 10:02:08 INFO - Using buildbot properties: 10:02:08 INFO - { 10:02:08 INFO - "project": "", 10:02:08 INFO - "product": "firefox", 10:02:08 INFO - "who": "ryanvm@gmail.com", 10:02:08 INFO - "installer_path": "public/build/target.tar.bz2", 10:02:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:02:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:02:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:02:08 INFO - "stage_platform": "linux64", 10:02:08 INFO - "basedir": "/builds/slave/test", 10:02:08 INFO - "buildnumber": 826, 10:02:08 INFO - "platform": "ubuntu64_hw", 10:02:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:02:08 INFO - "slavebuilddir": "test", 10:02:08 INFO - "taskId": "M6dIVVzyT5GfghTj_FjCAA", 10:02:08 INFO - "branch": "mozilla-central", 10:02:08 INFO - "script_repo_revision": "production", 10:02:08 INFO - "revision": "943c2c2a1daf5cd0d3287c1974eb510615d5ed5b", 10:02:08 INFO - "slavename": "talos-linux64-ix-050", 10:02:08 INFO - "repo_path": "mozilla-central" 10:02:08 INFO - } 10:02:08 INFO - Finding installer, test and symbols from parent task. 10:02:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6dIVVzyT5GfghTj_FjCAA'}, attempt #1 10:02:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6dIVVzyT5GfghTj_FjCAA'}, attempt #1 10:02:09 INFO - Task dependencies: BNjUtbdcSLq2BeuKb0u3jA 10:02:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA'}, attempt #1 10:02:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.test_packages.json 10:02:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip 10:02:10 INFO - Running post-action listener: _resource_record_post_action 10:02:10 INFO - [mozharness: 2017-09-14 17:02:10.446623Z] Finished read-buildbot-config step (success) 10:02:10 INFO - [mozharness: 2017-09-14 17:02:10.446841Z] Running download-and-extract step. 10:02:10 INFO - Running pre-action listener: _resource_record_pre_action 10:02:10 INFO - Running main action method: download_and_extract 10:02:10 INFO - mkdir: /builds/slave/test/build/tests 10:02: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')]} 10:02:10 INFO - trying https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.test_packages.json 10:02:10 INFO - Downloading https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:02:11 INFO - Downloaded 989 bytes. 10:02:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:02:11 INFO - Using the following test package requirements: 10:02:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:02:11 INFO - u'common': [u'target.common.tests.zip'], 10:02:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:02:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:02:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:02:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:02:11 INFO - u'mozbase': [u'target.common.tests.zip'], 10:02:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:02:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:02:11 INFO - u'web-platform': [u'target.common.tests.zip', 10:02:11 INFO - u'target.web-platform.tests.tar.gz'], 10:02:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:02:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 10:02:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.common.tests.zip 10:02:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:02:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.common.tests.zip into memory 10:02:12 INFO - Content-Length response header: 54593698 10:02:12 INFO - Bytes received: 54593698 10:02:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.talos.tests.zip 10:02:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:02:23 INFO - Fetch https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.talos.tests.zip into memory 10:02:24 INFO - Content-Length response header: 14500356 10:02:24 INFO - Bytes received: 14500356 10:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:24 INFO - trying https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:24 INFO - Downloading https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:02:26 INFO - Downloaded 61376754 bytes. 10:02:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:26 INFO - mkdir: /builds/slave/test/properties 10:02:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:26 INFO - Contents: 10:02:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:26 INFO - Running post-action listener: _resource_record_post_action 10:02:26 INFO - Running post-action listener: find_tests_for_verification 10:02:26 INFO - Running post-action listener: set_extra_try_arguments 10:02:26 INFO - [mozharness: 2017-09-14 17:02:26.818321Z] Finished download-and-extract step (success) 10:02:26 INFO - [mozharness: 2017-09-14 17:02:26.818554Z] Running populate-webroot step. 10:02:26 INFO - Running pre-action listener: _resource_record_pre_action 10:02:26 INFO - Running main action method: populate_webroot 10:02:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['tresize', 10:02:26 INFO - 'tcanvasmark']}, 10:02:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['dromaeo_css', 10:02:26 INFO - 'kraken']}, 10:02:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'tests': ['damp', 'tps']}, 10:02:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['damp', 'tps']}, 10:02:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['dromaeo_dom']}, 10:02:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:02:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['basic_compositor_video', 10:02:26 INFO - 'glvideo']}, 10:02:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:02:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['ts_paint_webext', 10:02:26 INFO - 'tp5o_webext']}, 10:02:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:26 INFO - 'ts_paint', 10:02:26 INFO - 'tpaint', 10:02:26 INFO - 'sessionrestore', 10:02:26 INFO - 'sessionrestore_many_windows', 10:02:26 INFO - 'sessionrestore_no_auto_restore', 10:02:26 INFO - 'tabpaint']}, 10:02:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['a11yr', 10:02:26 INFO - 'ts_paint', 10:02:26 INFO - 'tpaint', 10:02:26 INFO - 'sessionrestore', 10:02:26 INFO - 'sessionrestore_many_windows', 10:02:26 INFO - 'sessionrestore_no_auto_restore', 10:02:26 INFO - 'tabpaint']}, 10:02:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:02:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:02:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['bloom_basic_singleton']}, 10:02:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['bloom_basic']}, 10:02:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:26 INFO - 'tsvgr_opacity', 10:02:26 INFO - 'tart', 10:02:26 INFO - 'tscrollx', 10:02:26 INFO - 'tsvg_static']}, 10:02:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['tsvgx', 10:02:26 INFO - 'tsvgr_opacity', 10:02:26 INFO - 'tart', 10:02:26 INFO - 'tscrollx', 10:02:26 INFO - 'tsvg_static']}, 10:02:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'talos_options': ['--disable-stylo'], 10:02:26 INFO - 'tests': ['tp5o']}, 10:02:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:26 INFO - 'talos_options': ['--mitmproxy', 10:02:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:26 INFO - '--firstNonBlankPaint'], 10:02:26 INFO - 'tests': ['tp6_google', 10:02:26 INFO - 'tp6_youtube', 10:02:26 INFO - 'tp6_amazon', 10:02:26 INFO - 'tp6_facebook']}, 10:02:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:26 INFO - 'talos_options': ['--disable-stylo', 10:02:26 INFO - '--mitmproxy', 10:02:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:26 INFO - '--firstNonBlankPaint'], 10:02:26 INFO - 'tests': ['tp6_google', 10:02:26 INFO - 'tp6_youtube', 10:02:26 INFO - 'tp6_amazon', 10:02:26 INFO - 'tp6_facebook']}, 10:02:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:26 INFO - 'talos_options': ['--stylo-threads=1', 10:02:26 INFO - '--mitmproxy', 10:02:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:26 INFO - '--firstNonBlankPaint'], 10:02:26 INFO - 'tests': ['tp6_google', 10:02:26 INFO - 'tp6_youtube', 10:02:26 INFO - 'tp6_amazon', 10:02:26 INFO - 'tp6_facebook']}, 10:02:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'talos_options': ['--xperf_path', 10:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:26 INFO - 'tests': ['tp5n']}, 10:02:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:26 INFO - 'talos_options': ['--disable-stylo', 10:02:26 INFO - '--xperf_path', 10:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:26 INFO - 'tests': ['tp5n']}}} 10:02:26 INFO - Running post-action listener: _resource_record_post_action 10:02:26 INFO - [mozharness: 2017-09-14 17:02:26.838365Z] Finished populate-webroot step (success) 10:02:26 INFO - [mozharness: 2017-09-14 17:02:26.838455Z] Running create-virtualenv step. 10:02:26 INFO - Running pre-action listener: _resource_record_pre_action 10:02:26 INFO - Running main action method: create_virtualenv 10:02:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:02:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:02:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:02:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:27 INFO - Installing pip...............done. 10:02:27 INFO - Return code: 0 10:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:27 INFO - Reading from file tmpfile_stdout 10:02:27 INFO - Output received: 10:02:27 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:02:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02:27 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')]} 10:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:27 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')]} 10:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:27 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:27 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 10:02:27 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 10:02:27 INFO - Using env: {'DISPLAY': ':0', 10:02:27 INFO - 'HOME': '/home/cltbld', 10:02:27 INFO - 'LANG': 'en_US.UTF-8', 10:02:27 INFO - 'LANGUAGE': 'en_US:en', 10:02:27 INFO - 'LOGNAME': 'cltbld', 10:02:27 INFO - 'MAIL': '/var/mail/cltbld', 10:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:27 INFO - 'MOZ_NO_REMOTE': '1', 10:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:27 INFO - 'NO_EM_RESTART': '1', 10:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:27 INFO - 'PWD': '/builds/slave/test', 10:02:27 INFO - 'SHELL': '/bin/bash', 10:02:27 INFO - 'SHLVL': '1', 10:02:27 INFO - 'TERM': 'linux', 10:02:27 INFO - 'TMOUT': '86400', 10:02:27 INFO - 'USER': 'cltbld', 10:02:27 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:27 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:02:29 INFO - Downloading/unpacking pip>=1.5 10:02:29 INFO - Running setup.py egg_info for package pip 10:02:29 INFO - warning: no files found matching 'pip/cacert.pem' 10:02:29 INFO - warning: no files found matching '*.html' under directory 'docs' 10:02:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:02:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:02:29 INFO - Installing collected packages: pip 10:02:29 INFO - Found existing installation: pip 1.1 10:02:29 INFO - Uninstalling pip: 10:02:29 INFO - Successfully uninstalled pip 10:02:29 INFO - Running setup.py install for pip 10:02:29 INFO - warning: no files found matching 'pip/cacert.pem' 10:02:29 INFO - warning: no files found matching '*.html' under directory 'docs' 10:02:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:02:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:02:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:02:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:02:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:02:29 INFO - Successfully installed pip 10:02:29 INFO - Cleaning up... 10:02:29 INFO - Return code: 0 10:02:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:29 INFO - Downloading/unpacking psutil>=3.1.1 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:30 INFO - Installing collected packages: psutil 10:02:30 INFO - Running setup.py install for psutil 10:02:30 INFO - building 'psutil._psutil_linux' extension 10:02:30 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 10:02:30 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 10:02:30 INFO - building 'psutil._psutil_posix' extension 10:02:30 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 10:02:30 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 10:02:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:31 INFO - Successfully installed psutil 10:02:31 INFO - Cleaning up... 10:02:31 INFO - Return code: 0 10:02:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:02:31 INFO - Using env: {'DISPLAY': ':0', 10:02:31 INFO - 'HOME': '/home/cltbld', 10:02:31 INFO - 'LANG': 'en_US.UTF-8', 10:02:31 INFO - 'LANGUAGE': 'en_US:en', 10:02:31 INFO - 'LOGNAME': 'cltbld', 10:02:31 INFO - 'MAIL': '/var/mail/cltbld', 10:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:31 INFO - 'MOZ_NO_REMOTE': '1', 10:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:31 INFO - 'NO_EM_RESTART': '1', 10:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:31 INFO - 'PWD': '/builds/slave/test', 10:02:31 INFO - 'SHELL': '/bin/bash', 10:02:31 INFO - 'SHLVL': '1', 10:02:31 INFO - 'TERM': 'linux', 10:02:31 INFO - 'TMOUT': '86400', 10:02:31 INFO - 'USER': 'cltbld', 10:02:31 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:31 INFO - '_': '/tools/buildbot/bin/python'} 10:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:32 INFO - Installing collected packages: mozsystemmonitor 10:02:32 INFO - Running setup.py install for mozsystemmonitor 10:02:32 INFO - Successfully installed mozsystemmonitor 10:02:32 INFO - Cleaning up... 10:02:33 INFO - Return code: 0 10:02:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:33 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:33 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 10:02:33 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 10:02:33 INFO - Using env: {'DISPLAY': ':0', 10:02:33 INFO - 'HOME': '/home/cltbld', 10:02:33 INFO - 'LANG': 'en_US.UTF-8', 10:02:33 INFO - 'LANGUAGE': 'en_US:en', 10:02:33 INFO - 'LOGNAME': 'cltbld', 10:02:33 INFO - 'MAIL': '/var/mail/cltbld', 10:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:33 INFO - 'MOZ_NO_REMOTE': '1', 10:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:33 INFO - 'NO_EM_RESTART': '1', 10:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:33 INFO - 'PWD': '/builds/slave/test', 10:02:33 INFO - 'SHELL': '/bin/bash', 10:02:33 INFO - 'SHLVL': '1', 10:02:33 INFO - 'TERM': 'linux', 10:02:33 INFO - 'TMOUT': '86400', 10:02:33 INFO - 'USER': 'cltbld', 10:02:33 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:33 INFO - '_': '/tools/buildbot/bin/python'} 10:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:34 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 10:02:34 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 10:02:34 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 10:02:34 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 10:02:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:35 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 10:02:35 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 10:02:35 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 10:02:35 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 10:02:35 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:35 INFO - warning: no files found matching '*.txt' 10:02:35 INFO - no previously-included directories found matching 'build' 10:02:35 INFO - no previously-included directories found matching 'dist' 10:02:35 INFO - no previously-included directories found matching '.git*' 10:02:35 INFO - Installing collected packages: jsonschema, functools32 10:02:35 INFO - Running setup.py install for functools32 10:02:35 INFO - warning: no files found matching '*.txt' 10:02:35 INFO - no previously-included directories found matching 'build' 10:02:35 INFO - no previously-included directories found matching 'dist' 10:02:35 INFO - no previously-included directories found matching '.git*' 10:02:35 INFO - Successfully installed jsonschema functools32 10:02:35 INFO - Cleaning up... 10:02:36 INFO - Return code: 0 10:02:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02:36 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')]} 10:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:36 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')]} 10:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:36 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:36 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 10:02:36 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 10:02:36 INFO - Using env: {'DISPLAY': ':0', 10:02:36 INFO - 'HOME': '/home/cltbld', 10:02:36 INFO - 'LANG': 'en_US.UTF-8', 10:02:36 INFO - 'LANGUAGE': 'en_US:en', 10:02:36 INFO - 'LOGNAME': 'cltbld', 10:02:36 INFO - 'MAIL': '/var/mail/cltbld', 10:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:36 INFO - 'MOZ_NO_REMOTE': '1', 10:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:36 INFO - 'NO_EM_RESTART': '1', 10:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:36 INFO - 'PWD': '/builds/slave/test', 10:02:36 INFO - 'SHELL': '/bin/bash', 10:02:36 INFO - 'SHLVL': '1', 10:02:36 INFO - 'TERM': 'linux', 10:02:36 INFO - 'TMOUT': '86400', 10:02:36 INFO - 'USER': 'cltbld', 10:02:36 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:36 INFO - '_': '/tools/buildbot/bin/python'} 10:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:36 INFO - Cleaning up... 10:02:36 INFO - Return code: 0 10:02:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:36 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')]} 10:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:36 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')]} 10:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:36 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:36 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 10:02:36 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 10:02:36 INFO - Using env: {'DISPLAY': ':0', 10:02:36 INFO - 'HOME': '/home/cltbld', 10:02:36 INFO - 'LANG': 'en_US.UTF-8', 10:02:36 INFO - 'LANGUAGE': 'en_US:en', 10:02:36 INFO - 'LOGNAME': 'cltbld', 10:02:36 INFO - 'MAIL': '/var/mail/cltbld', 10:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:36 INFO - 'MOZ_NO_REMOTE': '1', 10:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:36 INFO - 'NO_EM_RESTART': '1', 10:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:36 INFO - 'PWD': '/builds/slave/test', 10:02:36 INFO - 'SHELL': '/bin/bash', 10:02:36 INFO - 'SHLVL': '1', 10:02:36 INFO - 'TERM': 'linux', 10:02:36 INFO - 'TMOUT': '86400', 10:02:36 INFO - 'USER': 'cltbld', 10:02:36 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:36 INFO - '_': '/tools/buildbot/bin/python'} 10:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:36 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 10:02:36 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 10:02:36 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 10:02:36 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 10:02:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:37 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 10:02:37 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 10:02:37 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 10:02:37 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 10:02:38 INFO - Downloading docopt-0.6.1.tar.gz 10:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:38 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:38 INFO - Running setup.py install for blobuploader 10:02:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:38 INFO - Running setup.py install for requests 10:02:38 INFO - Running setup.py install for docopt 10:02:38 INFO - Successfully installed blobuploader requests docopt 10:02:38 INFO - Cleaning up... 10:02:38 INFO - Return code: 0 10:02:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:38 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')]} 10:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:38 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')]} 10:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:38 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:38 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 10:02:38 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 10:02:38 INFO - Using env: {'DISPLAY': ':0', 10:02:38 INFO - 'HOME': '/home/cltbld', 10:02:38 INFO - 'LANG': 'en_US.UTF-8', 10:02:38 INFO - 'LANGUAGE': 'en_US:en', 10:02:38 INFO - 'LOGNAME': 'cltbld', 10:02:38 INFO - 'MAIL': '/var/mail/cltbld', 10:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:38 INFO - 'MOZ_NO_REMOTE': '1', 10:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:38 INFO - 'NO_EM_RESTART': '1', 10:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:38 INFO - 'PWD': '/builds/slave/test', 10:02:38 INFO - 'SHELL': '/bin/bash', 10:02:38 INFO - 'SHLVL': '1', 10:02:38 INFO - 'TERM': 'linux', 10:02:38 INFO - 'TMOUT': '86400', 10:02:38 INFO - 'USER': 'cltbld', 10:02:38 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:38 INFO - '_': '/tools/buildbot/bin/python'} 10:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:38 INFO - Running setup.py (path:/tmp/pip-AAa7lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:39 INFO - Running setup.py (path:/tmp/pip-uVrV_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:39 INFO - Running setup.py (path:/tmp/pip-N8vtlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:39 INFO - Running setup.py (path:/tmp/pip-WtbxbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:39 INFO - Running setup.py (path:/tmp/pip-2xAVzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:39 INFO - Running setup.py (path:/tmp/pip-hghTr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:39 INFO - Running setup.py (path:/tmp/pip-O4hf29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:39 INFO - Running setup.py (path:/tmp/pip-9xCVeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:39 INFO - Running setup.py (path:/tmp/pip-WuFLJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:39 INFO - Running setup.py (path:/tmp/pip-MhxSP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:39 INFO - Running setup.py (path:/tmp/pip-kxbDmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:39 INFO - Running setup.py (path:/tmp/pip-8V4UZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:39 INFO - Running setup.py (path:/tmp/pip-bUiuDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:39 INFO - Running setup.py (path:/tmp/pip-2jmCU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:39 INFO - Running setup.py (path:/tmp/pip-rruw8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:40 INFO - Running setup.py (path:/tmp/pip-QYNQl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:40 INFO - Running setup.py (path:/tmp/pip-Cobxuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:40 INFO - Running setup.py install for manifestparser 10:02:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Running setup.py install for mozcrash 10:02:40 INFO - Running setup.py install for mozdebug 10:02:40 INFO - Running setup.py install for mozdevice 10:02:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Running setup.py install for mozfile 10:02:40 INFO - Running setup.py install for mozhttpd 10:02:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Running setup.py install for mozinfo 10:02:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Running setup.py install for mozInstall 10:02:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:40 INFO - Running setup.py install for mozleak 10:02:41 INFO - Running setup.py install for mozlog 10:02:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Running setup.py install for moznetwork 10:02:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Running setup.py install for mozprocess 10:02:41 INFO - Running setup.py install for mozprofile 10:02:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Running setup.py install for mozrunner 10:02:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Running setup.py install for mozscreenshot 10:02:41 INFO - Running setup.py install for moztest 10:02:41 INFO - Running setup.py install for mozversion 10:02:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:41 INFO - Cleaning up... 10:02:41 INFO - Return code: 0 10:02:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:41 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')]} 10:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:41 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')]} 10:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:41 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:41 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 10:02:41 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 10:02:41 INFO - Using env: {'DISPLAY': ':0', 10:02:41 INFO - 'HOME': '/home/cltbld', 10:02:41 INFO - 'LANG': 'en_US.UTF-8', 10:02:41 INFO - 'LANGUAGE': 'en_US:en', 10:02:41 INFO - 'LOGNAME': 'cltbld', 10:02:41 INFO - 'MAIL': '/var/mail/cltbld', 10:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:41 INFO - 'MOZ_NO_REMOTE': '1', 10:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:41 INFO - 'NO_EM_RESTART': '1', 10:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:41 INFO - 'PWD': '/builds/slave/test', 10:02:41 INFO - 'SHELL': '/bin/bash', 10:02:41 INFO - 'SHLVL': '1', 10:02:41 INFO - 'TERM': 'linux', 10:02:41 INFO - 'TMOUT': '86400', 10:02:41 INFO - 'USER': 'cltbld', 10:02:41 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:41 INFO - '_': '/tools/buildbot/bin/python'} 10:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:42 INFO - Running setup.py (path:/tmp/pip-TCSCqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:42 INFO - Running setup.py (path:/tmp/pip-RC2sUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:42 INFO - Running setup.py (path:/tmp/pip-lAv7jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:42 INFO - Running setup.py (path:/tmp/pip-3VX7iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:42 INFO - Running setup.py (path:/tmp/pip-xfZztj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:42 INFO - Running setup.py (path:/tmp/pip-gtFZJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:42 INFO - Running setup.py (path:/tmp/pip-fDp7ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:42 INFO - Running setup.py (path:/tmp/pip-r5qe25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:42 INFO - Running setup.py (path:/tmp/pip-qESgBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:42 INFO - Running setup.py (path:/tmp/pip-Luzx2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:42 INFO - Running setup.py (path:/tmp/pip-fg6ysw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:42 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)) 10:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:42 INFO - Running setup.py (path:/tmp/pip-gGgw6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:43 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)) 10:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:43 INFO - Running setup.py (path:/tmp/pip-MzAsGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:43 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)) 10:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:43 INFO - Running setup.py (path:/tmp/pip-CaUGIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:43 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)) 10:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:43 INFO - Running setup.py (path:/tmp/pip-__xJPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:43 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)) 10:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:43 INFO - Running setup.py (path:/tmp/pip-7zs0xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:43 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)) 10:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:43 INFO - Running setup.py (path:/tmp/pip-JGfesr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:43 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)) 10:02:43 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)) 10:02:43 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)) 10:02:43 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)) 10:02:43 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)) 10:02:43 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)) 10:02:43 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)) 10:02:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:43 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 10:02:43 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 10:02:43 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 10:02:43 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 10:02:44 INFO - Downloading blessings-1.6.tar.gz 10:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:44 INFO - Installing collected packages: blessings 10:02:44 INFO - Running setup.py install for blessings 10:02:44 INFO - Successfully installed blessings 10:02:44 INFO - Cleaning up... 10:02:44 INFO - Return code: 0 10:02:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:44 INFO - Reading from file tmpfile_stdout 10:02:44 INFO - Current package versions: 10:02:44 INFO - argparse == 1.2.1 10:02:44 INFO - blessings == 1.6 10:02:44 INFO - blobuploader == 1.2.4 10:02:44 INFO - docopt == 0.6.1 10:02:44 INFO - functools32 == 3.2.3-2 10:02:44 INFO - jsonschema == 2.5.1 10:02:44 INFO - manifestparser == 1.1 10:02:44 INFO - mozInstall == 1.13 10:02:44 INFO - mozcrash == 1.0 10:02:44 INFO - mozdebug == 0.1 10:02:44 INFO - mozdevice == 0.51 10:02:44 INFO - mozfile == 1.2 10:02:44 INFO - mozhttpd == 0.7 10:02:44 INFO - mozinfo == 0.10 10:02:44 INFO - mozleak == 0.1 10:02:44 INFO - mozlog == 3.5 10:02:44 INFO - moznetwork == 0.27 10:02:44 INFO - mozprocess == 0.25 10:02:44 INFO - mozprofile == 0.28 10:02:44 INFO - mozrunner == 6.13 10:02:44 INFO - mozscreenshot == 0.1 10:02:44 INFO - mozsystemmonitor == 0.3 10:02:44 INFO - moztest == 0.8 10:02:44 INFO - mozversion == 1.4 10:02:44 INFO - psutil == 3.1.1 10:02:44 INFO - requests == 1.2.3 10:02:44 INFO - wsgiref == 0.1.2 10:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:44 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')]} 10:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:44 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')]} 10:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:44 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:44 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 10:02:44 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 10:02:44 INFO - Using env: {'DISPLAY': ':0', 10:02:44 INFO - 'HOME': '/home/cltbld', 10:02:44 INFO - 'LANG': 'en_US.UTF-8', 10:02:44 INFO - 'LANGUAGE': 'en_US:en', 10:02:44 INFO - 'LOGNAME': 'cltbld', 10:02:44 INFO - 'MAIL': '/var/mail/cltbld', 10:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:44 INFO - 'MOZ_NO_REMOTE': '1', 10:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:44 INFO - 'NO_EM_RESTART': '1', 10:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:44 INFO - 'PWD': '/builds/slave/test', 10:02:44 INFO - 'SHELL': '/bin/bash', 10:02:44 INFO - 'SHLVL': '1', 10:02:44 INFO - 'TERM': 'linux', 10:02:44 INFO - 'TMOUT': '86400', 10:02:44 INFO - 'USER': 'cltbld', 10:02:44 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:44 INFO - '_': '/tools/buildbot/bin/python'} 10:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 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)) 10:02:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:45 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 10:02:45 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 10:02:45 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 10:02:45 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 10:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:02:46 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)) 10:02:46 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)) 10:02:46 INFO - Installing collected packages: simplejson 10:02:46 INFO - Running setup.py install for simplejson 10:02:46 INFO - building 'simplejson._speedups' extension 10:02:46 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 10:02:47 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 10:02:47 INFO - Successfully installed simplejson 10:02:47 INFO - Cleaning up... 10:02:47 INFO - Return code: 0 10:02:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:47 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')]} 10:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:47 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')]} 10:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:47 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 0x16181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, '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': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', '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 10:02:47 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 10:02:47 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 10:02:47 INFO - Using env: {'DISPLAY': ':0', 10:02:47 INFO - 'HOME': '/home/cltbld', 10:02:47 INFO - 'LANG': 'en_US.UTF-8', 10:02:47 INFO - 'LANGUAGE': 'en_US:en', 10:02:47 INFO - 'LOGNAME': 'cltbld', 10:02:47 INFO - 'MAIL': '/var/mail/cltbld', 10:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:47 INFO - 'MOZ_NO_REMOTE': '1', 10:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:47 INFO - 'NO_EM_RESTART': '1', 10:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:47 INFO - 'PWD': '/builds/slave/test', 10:02:47 INFO - 'SHELL': '/bin/bash', 10:02:47 INFO - 'SHLVL': '1', 10:02:47 INFO - 'TERM': 'linux', 10:02:47 INFO - 'TMOUT': '86400', 10:02:47 INFO - 'USER': 'cltbld', 10:02:47 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:47 INFO - '_': '/tools/buildbot/bin/python'} 10:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:47 INFO - Cleaning up... 10:02:47 INFO - Return code: 0 10:02:47 INFO - Running post-action listener: _resource_record_post_action 10:02:47 INFO - Running post-action listener: _start_resource_monitoring 10:02:47 INFO - Starting resource monitoring. 10:02:47 INFO - [mozharness: 2017-09-14 17:02:47.650954Z] Finished create-virtualenv step (success) 10:02:47 INFO - [mozharness: 2017-09-14 17:02:47.651467Z] Running install step. 10:02:47 INFO - Running pre-action listener: _resource_record_pre_action 10:02:47 INFO - Running main action method: install 10:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:47 INFO - Reading from file tmpfile_stdout 10:02:47 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:48 INFO - Reading from file tmpfile_stdout 10:02:48 INFO - Output received: 10:02:48 INFO - Usage: mozinstall [options] installer 10:02:48 INFO - Options: 10:02:48 INFO - -h, --help show this help message and exit 10:02:48 INFO - -d DEST, --destination=DEST 10:02:48 INFO - Directory to install application into. [default: 10:02:48 INFO - "/builds/slave/test"] 10:02:48 INFO - --app=APP Application being installed. [default: firefox] 10:02:48 INFO - mkdir: /builds/slave/test/build/application 10:02:48 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'] 10:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:03:05 INFO - Reading from file tmpfile_stdout 10:03:05 INFO - Output received: 10:03:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:03:05 INFO - Running post-action listener: _resource_record_post_action 10:03:05 INFO - [mozharness: 2017-09-14 17:03:05.802915Z] Finished install step (success) 10:03:05 INFO - [mozharness: 2017-09-14 17:03:05.803165Z] Running setup-mitmproxy step. 10:03:05 INFO - Running pre-action listener: _resource_record_pre_action 10:03:05 INFO - Running main action method: setup_mitmproxy 10:03:05 INFO - Skipping: mitmproxy is not required 10:03:05 INFO - Running post-action listener: _resource_record_post_action 10:03:05 INFO - [mozharness: 2017-09-14 17:03:05.804288Z] Finished setup-mitmproxy step (success) 10:03:05 INFO - [mozharness: 2017-09-14 17:03:05.804507Z] Running run-tests step. 10:03:05 INFO - Running pre-action listener: _resource_record_pre_action 10:03:05 INFO - Running pre-action listener: _set_gcov_prefix 10:03:05 INFO - Running main action method: run_tests 10:03:05 WARNING - Try message not found. 10:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:05 INFO - Python 2.7.3 10:03:05 INFO - Return code: 0 10:03:05 INFO - grabbing minidump binary from tooltool 10:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:05 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 0x1988090>, '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 0x1988d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1982f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:05 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 10:03:05 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 10:03:05 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 10:03:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:05 INFO - Return code: 0 10:03:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:03:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:05 INFO - ENV: RUST_BACKTRACE is now full 10:03:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:03:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:05 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/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:03:05 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/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 10:03:05 INFO - Using env: {'DISPLAY': ':0', 10:03:05 INFO - 'HOME': '/home/cltbld', 10:03:05 INFO - 'LANG': 'en_US.UTF-8', 10:03:05 INFO - 'LANGUAGE': 'en_US:en', 10:03:05 INFO - 'LOGNAME': 'cltbld', 10:03:05 INFO - 'MAIL': '/var/mail/cltbld', 10:03:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:05 INFO - 'MOZ_NO_REMOTE': '1', 10:03:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:05 INFO - 'NO_EM_RESTART': '1', 10:03:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:05 INFO - 'PWD': '/builds/slave/test', 10:03:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:05 INFO - 'RUST_BACKTRACE': 'full', 10:03:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:03:05 INFO - 'SHELL': '/bin/bash', 10:03:05 INFO - 'SHLVL': '1', 10:03:05 INFO - 'TERM': 'linux', 10:03:05 INFO - 'TMOUT': '86400', 10:03:05 INFO - 'USER': 'cltbld', 10:03:05 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:05 INFO - '_': '/tools/buildbot/bin/python'} 10:03:05 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/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:03:06 INFO - mozversion application_buildid: 20170914161400 10:03:06 INFO - mozversion application_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:03:06 INFO - mozversion application_display_name: Nightly 10:03:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:06 INFO - mozversion application_name: Firefox 10:03:06 INFO - mozversion application_remotingname: firefox 10:03:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:03:06 INFO - mozversion application_vendor: Mozilla 10:03:06 INFO - mozversion application_version: 57.0a1 10:03:06 INFO - mozversion platform_buildid: 20170914161400 10:03:06 INFO - mozversion platform_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:03:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:03:06 INFO - mozversion platform_version: 57.0a1 10:03:06 INFO - using testdate: 1505408586 10:03:06 INFO - actual date: 1505408586 10:03:06 INFO - starting webserver on 'localhost:41113' 10:03:06 INFO - SUITE-START | Running 2 tests 10:03:06 INFO - TEST-START | dromaeo_css 10:03:06 INFO - Initialising browser for dromaeo_css test... 10:03:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41113/getInfo.html -profile /tmp/tmpAGy1Ve/profile 10:03:06 INFO - TEST-INFO | started process 13645 (/builds/slave/test/build/application/firefox/firefox http://localhost:41113/getInfo.html) 10:03:11 INFO - TEST-INFO | 13645: exit 0 10:03:12 INFO - Browser initialized. 10:03:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:12 INFO - Using env: {'DISPLAY': ':0', 10:03:12 INFO - 'HOME': '/home/cltbld', 10:03:12 INFO - 'JSGC_DISABLE_POISONING': '1', 10:03:12 INFO - 'LANG': 'en_US.UTF-8', 10:03:12 INFO - 'LANGUAGE': 'en_US:en', 10:03:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:03:12 INFO - 'LOGNAME': 'cltbld', 10:03:12 INFO - 'MAIL': '/var/mail/cltbld', 10:03:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:12 INFO - 'MOZ_CRASHREPORTER': '1', 10:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:03:12 INFO - 'MOZ_NO_REMOTE': '1', 10:03:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:12 INFO - 'NO_EM_RESTART': '1', 10:03:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:12 INFO - 'PWD': '/builds/slave/test', 10:03:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:12 INFO - 'RUST_BACKTRACE': 'full', 10:03:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:03:12 INFO - 'SHELL': '/bin/bash', 10:03:12 INFO - 'SHLVL': '1', 10:03:12 INFO - 'TERM': 'linux', 10:03:12 INFO - 'TMOUT': '86400', 10:03:12 INFO - 'USER': 'cltbld', 10:03:12 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:12 INFO - '_': '/tools/buildbot/bin/python'} 10:03:12 INFO - TEST-INFO | started process 13879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAGy1Ve/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:12 INFO - PID 13879 | 10:03:12 INFO - PID 13879 | (/builds/slave/test/build/application/firefox/firefox:13928): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:03:12 INFO - PID 13879 | 10:03:23 INFO - PID 13879 | RSS: Main: 170401792 10:03:23 INFO - PID 13879 | 10:06:20 INFO - PID 13879 | Cycle 1(1): loaded http://localhost:41113/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41113/tests/dromaeo/cssquery-ext.html) 10:06:22 INFO - PID 13879 | RSS: Main: 173170688 10:06:22 INFO - PID 13879 | 10:09:23 INFO - PID 13879 | Cycle 1(1): loaded http://localhost:41113/tests/dromaeo/cssquery-ext.html (next: http://localhost:41113/tests/dromaeo/cssquery-jquery.html) 10:09:24 INFO - PID 13879 | RSS: Main: 168886272 10:09:24 INFO - PID 13879 | 10:12:26 INFO - PID 13879 | Cycle 1(1): loaded http://localhost:41113/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41113/tests/dromaeo/cssquery-mootools.html) 10:12:26 INFO - PID 13879 | RSS: Main: 173203456 10:12:26 INFO - PID 13879 | 10:15:28 INFO - PID 13879 | Cycle 1(1): loaded http://localhost:41113/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41113/tests/dromaeo/cssquery-prototype.html) 10:15:29 INFO - PID 13879 | RSS: Main: 171814912 10:15:29 INFO - PID 13879 | 10:18:32 INFO - PID 13879 | Cycle 1(1): loaded http://localhost:41113/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41113/tests/dromaeo/cssquery-yui.html) 10:18:33 INFO - PID 13879 | RSS: Main: 172974080 10:18:33 INFO - PID 13879 | 10:21:34 INFO - PID 13879 | Cycle 1(1): loaded http://localhost:41113/tests/dromaeo/cssquery-yui.html (next: http://localhost:41113/tests/dromaeo/cssquery-dojo.html) 10:21:35 INFO - PID 13879 | RSS: Main: 175955968 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | __start_tp_report 10:21:35 INFO - PID 13879 | _x_x_mozilla_page_load 10:21:35 INFO - PID 13879 | _x_x_mozilla_page_load_details 10:21:35 INFO - PID 13879 | |i|pagename|runs| 10:21:35 INFO - PID 13879 | |0;dojo.html;3161.8260995645246;3180;3193.9520907186397;3202.9519557206645;3229.354129174166;6173.876522469548;6264.154339164223;6309.968450157754;6349.682515874205;6424.967875160618;6203.751849925998;6248.187735594366;6255.4370106690385;6291.653959032252;6295.905561416571;5841.853953651172;5866.677332746697;5887.646741195521;5916.585838991272;5937.22816033915;1260.0782327576837;5757.395473475267;5879.794207202749;5918.2898052233795;5939.70301484924;5741.45456181662;5827.504662103726;5829.504492118175;5888.735006924699;5891.734871930752;5780.537556995472;5791.768329266824;5797.536197104221;5864.179014937912;5876.97061514694;5693.971530142323;5760.107183386582;5800.941990580082;5832.650040997553;5864.70676466175;6220.1913751212505;6251.12484252205;6337.87324253517;6362.872742545123;6393.9680301598655;6541.542092053558;6633.071370008202;6722;6759.121314229168;6842.110525631686;6702.262751097375;6741.258461569223;6751.864962700768;6754.527183097185;6758.797236082925;6273.1531243282025;6359.682015899187;6371.872562548723;6378.330275321071;6379.649119298483;6944.479164062715;6974.163100427981;6993.230744618088;7063.964680176567;7065.43476521877;6589.275179730226;6589.4069533742195;6604.801855944329;6628.204615446178;6737.393634572912;6670.566413183127;6694.129763130762;6716.731330746813;6757.290484499155;6780.593164410151;6644.069830223772;6673.299303573055;6727.226368967534;6761.121054263012;6788.083608712859;6738.427233685094;6742;6828.419584335387;6832.282610325944;6836.38472537474;5116.667416617908;5186.170212765939;5188.610854185876;5189.844304670866;5190.584753219733;4631.9536804631525;4654.092451971833;4668.183067963093;4686.671932964728;4710.976445117821;5733.455321744427;5882.088276317178;5886.117082437583;5886.61736987103;5892.322382925932;6752.426043786235;6792.66036698173;6854.383105520427;6866.34769696878;6879.5184337096925;5700.885982280414;5774.335951365562;5792.9420705793245;5815.040518314515;5878.29460464747;5831.241938547962;5854.648721076749;5855.3266374367495;5857.912131318034;5863.5309175265875;6454.128692626529;6472.935270647327;6530.118434011442;6547.377999090078;6701.29636388182;6787.728490860508;6845.349691779273;6873.4157596602845;6879.6560171990195;6885.208201056943;6589.571677841117;6605.900911486236;6609.933900660932;6696.263411024881;6699.497537684596;6388.712507937247;6549.4760419165395;6613.768518101843;6683.398494135551;6685.966570167313;6804.523683342317;6804.795856124324;6816.2842901496615;6821;6838.418734407432;6570.737170513126;6576.210854697467;6616.933830661825;6653.101831252912;6657.234418041987;6534.248561415498;6560.40956313934;6607.537472376887;6618.0403841443685;6636.734530618721;6307.96846015767;6421.486281097595;6439.195100612424;6448.5163612730175;6554.279029306677;6483.4164925156965;6602.867942641216;6622.271550129578;6642.103316052271;6649.301823308483;6230.096635987847;6357.4278314950025;6375.107484952203;6376.808695739135;6448.742050317935 10:21:35 INFO - PID 13879 | |1;ext.html;810.2586133687676;818.4925346285303;830.5681045856152;850.5109562001849;859.0335872143838;40163.39754903675;40657.59342406575;40865.795671021675;40936.18127637445;41201.79399103004;37143.25713485729;41664.58335416645;42096;42359;42499.150016999716;7601.84796304075;7670.7698769037015;7727.536347819148;7740.380769538451;7743.2256774322395;7568.167501574822;7679.884801727979;7685.385169186452;7719;7720.7683769487;7646;7733.497322674037;7743.535387876717;7757.883631745528;7759.689612415496;7684.731034413797;7724.111727151393;7730.922690773076;7741.690332386698;7744.690212391498;7552.962235188789;7631.809204769869;7641.503302285334;7645.15903250642;7654.234576542357;37167.51329946799;37255.441168382225;37496.62503374986;37577;37602;3515.226650136966;3542.787432754043;3547.166415892263;3548.1661809474754;3548.4677298405186;30115.69884301151;30229;30231.546526802114;30245.395092098253;30281.242968925733;5009;5195.038917800219;5205.193195054772;5249.370075590915;5252.474752524755;180773;186231;187461;188878;196176;47538.28692569614;47970;48053.279200812016;48276.5172348279;48317.275240871415;49033.264501032514;49351.753241234284;49422.25866612004;49492.25761613579;49623;16028.519144425685;16066.116363600115;16095;16135.112568808594;16162.43431479916;13230.272335021666;13290.734185316433;13325.866741332462;13342.666433339244;13359;12543;12676.619701408788;12706;12835.229886206858;12872;5028.622853286018;5077.111505486525;5090.872728181751;5092.541671249605;5173.611979101583;975.5268694683073;995.9502024898726;1000.5647543318535;1010.5755582655303;1017.4658304390255;21312.680309795367;21468;21493.67759483609;21599;21738;1094.5074716377662;1105.6240878101485;1106.2145876427664;1108.944552772358;1110.2894147745449;11497.252678575866;11537.134714896416;11634.53461861533;11697.649070527897;11750.823737643943;231771;231998;232384;233191;233228;50707.23939140916;50778.74610626923;50840.49159508431;50883;50899.491005089476;1420.88632909367;1433.5700986827228;1436.3536408616164;1454.3600815641084;1458.7374272630816;21511.354659360244;21629.13483460644;22184.889075554518;22393.66409503826;22401.775982239968;35766.46350304696;35894.8205258972;35900.10249743777;35916.82041589775;36014.639853601126;194101;194125;209115;212408;214122;28756.712432875403;29883;30426;33502.497462538566;33835.83082084672;39280.62517811863;43765;44295.77852110719;44706.77646611746;45079;32144.19639509031;32303.676963230067;32358;32576;33231.667683322856;31727.36545269128;32269.193270168435;32278.83860580682;32336.514952276204;32691.182720432178;36141.61302536964;36262.63737362698;36350.63649363472;36372.45441318435;36423.27153456863;31709.780315377702;31752.04743857688;31842.52236216505;32108.518372224902;32900.67099328976;22785.316440506813;23034;23036.078556857537;23087.023159913082;23176.3047108587 10:21:35 INFO - PID 13879 | |2;jquery.html;555.8332500249927;555.8749281411681;557.8410153106363;575.3814649252054;593.2376895689038;21245.57508849822;22242.99906504209;22253.888730556366;22272.88863555684;22280;23714.644280335808;24136.034558617634;24319;24325.270241892726;24990.625140622906;6498.902516462245;6761.560498567602;6762.763303284386;6773.966130169342;6782.084418603475;6633.668316584151;6686.765963191289;6734.19189697237;6736.157980252468;6744.93255067448;6216.875662486747;6463.289038205794;6482.902756458633;6486.4162225399705;6489.935100649004;6337.176167098248;6484.578502397353;6498.252700939358;6528.281888992207;6546.574472659262;6111.541634377395;6125.173101631267;6132.7546898124465;6137.815865524041;6144.907826382608;28867.133985980243;29219.707802921912;29398.971036013852;29427.705722942712;29497.115086547437;2011.3463124484601;2014.5870096630156;2029.5129168999333;2033.8983050847546;2034.1558253324852;19296.842189468538;19458.124384402738;19817.405477835688;20050;20228.292009779736;2370.2889133259955;2385.7256415512265;2433.561958847407;2441.865697386643;2443.8900249488815;117598;124919;131722;131831.34084329612;138944.305278475;14623.976321657594;14861.798370570214;14914.482779272226;14935.402583896739;15237;23105.653415198787;23220.3033908983;23226.3032109037;23279;23284.3014709559;9602.90397096034;9609.279304052085;9618.903810961941;9769.364991275545;9796.755081122887;8959.62422546467;9000.459972401677;9063.818723625622;9092.454452732725;9189.448633082036;9033.567244447067;9111.362204645611;9165.31260155491;9376.437413755197;9456.196223320958;2621.082621082606;2676.772474339664;2685.2610337455685;2706.553418685934;2796.6084748135277;952.7094236257869;962.0571839597234;979.0698836105586;979.5102448775613;986.1124987511154;18912.43262702121;18960;19005.714914276297;19460.513487162934;19465.318713844947;1015.786684796201;1020.9234307426973;1025.5487585462522;1034.2036631793628;1041.1306559023149;10536;10638.255322127377;10711.625093121704;10749.89250107489;10801.891981080245;427058;431189;441608;443095;443814;108145.45927270471;109576.4521177405;109719.45140274247;112950.43524782323;114387;1045.2265323660588;1092.7432053467428;1143.508291434691;1157.0454375140544;1180.893719565226;20216.494587635425;20329.390118296476;20364.79635203629;20451.69322460194;20866.895665521577;54527;55324.72337638447;55391;55685.721571391885;55918.720406399334;68685;68711.65644171747;69245.96131058139;69540.30459695541;69990;14125.717485650024;14318.785218221943;14487.275636217935;14545.709085818013;14571.854281457474;22921.65617515705;23168.652470212623;23228.535429290983;23236.18673346425;23460.76539234654;18050.819491804912;18226.544336391697;18231;18258.543536411697;18321.541961451072;16246.67506649884;16341.182940852672;16759.497215083567;17014.57463563371;17163.485095447155;17757.378491752726;18366.632667346847;18462.169202385656;18624.44126676202;18735.437936861916;14090.506832260822;14092.929535352669;14232.644183895485;14249.643758905695;14438.350274237895;18165.455036348932;18286;18544.814551854848;18589.721154182967;18750.156242968827 10:21:35 INFO - PID 13879 | |3;mootools.html;1309.0836414509843;1342.8187194728714;1365.3105181883147;1366.4261010375642;1379.3517046987913;15043.924780376097;15752.921235393807;15814.683706325866;15840.603984900383;15858.762118568231;15448.922755386207;15503.53489395317;15538.300776465057;15551;15553.688926221468;2649.5760678291476;2783.248522898816;2783.986080069597;2785.5960885671566;2791.9809269616544;2755.2698534888273;2767.501849667059;2770.7921905857042;2773.8058335916494;2776.9583456248174;2673.3984853408024;2697.096472681654;2712.606672032564;2724.3189202699327;2726.1412655013705;2602.6226197201395;2619.253512748867;2631.8420894746378;2631.9078832240875;2643.4977354302814;2616.515944550264;2633.789296856247;2640.4323070539926;2645.4444566640836;2645.9206223813317;15379.769303460456;15759.684806303925;15760.133192674399;15793.763093553605;15916.840831591651;7889.96055019727;8175.100738918714;8178.100408955011;8187.877181842277;8190.262876341158;5339.866503337409;5488.4785945335525;5527.585431092684;5535.612507124503;5576.609637325389;1870.710039943811;1903.457514608344;1911.130435651789;1947.1529884500146;1948.8440924725987;26103.216903492925;26431;26452.603210952042;26488.60267095995;26514.072007479837;6624.8012559623285;6797.966010169917;6996.6851491683;7013.263607321158;7032.839581469;17439.128043597768;17538.736918946226;17564.912175439298;17582.472525824247;17596.384126555764;7749.4575379724;7902.0912595052305;7902.130765615778;7907.762767116996;7908.130105688369;7228.891566626505;7266.055412796409;7290.890636640454;7335.88996165058;7342.265773422615;5326.733663316896;5434.049041417736;5444.91832622511;5547.805826796042;5643.689597072118;1552.7981362423038;1559.126888942196;1560.586444592184;1560.7580824972147;1586.111777404657;896.2919293757858;903.6204793986542;909.1908201700492;909.60432211988;917.1791246834047;7500.324970752549;7592.544447333178;7643.694252229849;7683.654235559413;7711.614419279013;680.4012469027224;697.476892330752;700.7057036044873;717.7236763845852;727.7198278662753;5026;5315.574754019669;5575.52608028314;5618.494335509824;5656.321241451053;21193.894030530057;21430.142794288055;21904.89047554784;22234.444138896655;22300.553988920456;21356.893215533823;22119.778802212095;22160.55678886413;22188.778112218995;22450.101995920308;10532.684019479428;10956.397398143179;10994.175436842268;11009.174311926798;11088.390138542296;8575.742727718178;8627.35294852876;8661.263792577449;8677.826443471222;8692.565371731514;18730;18832.435026949213;18979.620407592047;19211.90394048021;19274.22903083917;19238.23047078101;19369.159929806647;19627.60744785125;19934.401967940987;20203.494912627302;10753.838692419777;10855.565777368816;10936.617218397318;10981.83527247076;10982.945085274523;13910.165390076629;14044.648883777987;14101.365438555085;14194.645133871736;14211.360488778237;11305.943470282597;11464.541418343506;11568.421578921188;11610.419479025846;11684.357360345262;10414.166866650801;10448.68653940383;10582.788344233226;10770.73073173177;10890.128789696964;9623;9905.207583393456;9918.305718599917;9918.504074796376;9923.255755818487;7004.4046256068805;7141.928580714126;7167.928320716935;7180.748673796392;7184.533005354635;7019.403350715246;7160.248173941869;7230.74692385764;7266.96366518164;7330.303621155982 10:21:35 INFO - PID 13879 | |4;prototype.html;494.7010478938029;494.94255131100846;517.15961562461;527.8759491519493;531.6198917773792;6160.5687601867885;6212.534059945505;6232.563720539564;6233.968830155854;6290.21372328459;6135.386461353863;6182.350853160421;6188.721507532172;6190.75236990521;6246.562740608148;5121.257417674445;5139.306193663845;5147.253648221005;5148.124818780816;5158.329417175762;4768.880777980544;4873.025394921012;5029.622778291625;5105.2086926526445;5124.871878203037;4869.780859861297;4884.438289596688;4912.950870491303;4916;4941.77762000709;4874.46380898101;4876.097921884428;4891.828785992491;4904.166291730397;4955.727434991074;4314.913701725948;4404.647628189737;4412.117576484716;4412.977935110304;4418.359337895987;5957;5991.490723288525;5999.580029397944;6016.518678505753;6026.9095963560585;5574.665520068768;5584.520102172927;5626.465485778845;5640.182173584848;5642.4075472075665;6504.902426463606;6506.642134682591;6522.7390904363765;6530.400051987293;6559;4622.214223581966;4838.927416088762;4850.417949846041;4859.829905953275;4871.318015477836;6597.736090556372;6662.800115996528;6716;6795.38841504267;6817.727290908408;4930;4941.555260026615;4944.60443164546;4971.428285747185;4981.302617633534;4998.375203099613;5021.974890125599;5032.597392208614;5049.626675462527;5062.417821950449;5549.250851135126;5579.13523403873;5580.19087232349;5641.717914104361;5642.435756424325;6505.121808555879;6540.710751237124;6544.70548825304;6547.9017814732815;6550.672466376662;1724.6378260565423;1745.1187150488922;1747.2836137183695;1748.1608827762745;1760.1639221369746;1140.7319279969201;1200.3698058519346;1218.5491368193648;1219.3354621731178;1223.9510419583296;5619.662820230799;5630.85922851932;5683.8010669626365;5685.488306052475;5690.174924635988;6536.444402225769;6621.4040736333;6671.13275274221;6702.229243636946;6706.798796036127;5493.533049690821;5604.719764011865;5656.943430565724;5666.206731057573;5670.858228544319;3471.323091997087;3485.5643044619424;3519.1554027033326;3534.169470174507;3538.327717733622;6445.903311450332;6473.805785826433;6477.287498375175;6482.967585162044;6506.3818937200895;6703.4972377070935;6718.289453964091;6761.898571521431;6827.590344579341;6834.726610935606;6382.744690212432;6388.744450221939;6429.485641148697;6509.153810004669;6545.280019197884;6168.242051015439;6468.838279043061;6489.1888513935755;6579.506537009839;6612;6364.809055728336;6458.191706322237;6532.085508028785;6543.1821022372205;6568.635291295034;6336.809895703136;6350.650714210763;6361.268454127835;6404.751073540615;6420.518461115528;4864.902701945871;4870.90258194827;4919.286703428054;4933.679310844784;4950.628702847229;6265.467435268053;6407.647579382992;6487.091807147098;6677.465802735866;6678.866422671422;6388.872222555616;6393.584417012879;6428.4214420702365;6429.164208652845;6447.903281450688;6219.564630475823;6336;6362.840928976628;6383.32975037633;6443.355664433519;6311.589746666452;6316.368363163647;6340.207474065742;6391.296957334596;6403.615783053032;6447;6457.741690332522;6554.901676474952;6564.179477565304;6590.7693230736695;6289.96855015722;6291.307956124914;6332.746690132343;6353.491720662243;6370.617762934239 10:21:35 INFO - PID 13879 | |5;yui.html;879.1208791208791;883.8497455432575;910.8861392325957;911.767499287682;914.6570036236411;19522.609547809036;20354.084066217038;20443.693344599844;20445;20468.69296960547;18101;18412.07939603021;18718.251269949185;19127.139278732455;19163.137658805354;949.9382540134886;970.9563069661882;971.6404930175845;972.863799068131;975.7560609847538;975.7219192530131;977.5698692575244;979.7060881735487;993.8310487217191;999.1357475783432;1021.1014307409506;1021.7547788530736;1022.2435397805607;1024.5645600619744;1026.384169498299;985.960561577536;1012.3015119567549;1014.2595904989325;1017.954192061359;1019.1795604538344;729.956202627844;737.8561180569791;739.4380270994084;739.6782399656166;740.4927624577128;20107.39677809668;20206.696899546518;20316.69524957127;20338.5932281355;20360.083796229057;21738.673919891215;22529.32412027642;22531.774682253297;22561.435964100863;22567.77432225673;17132;17199.65600687992;17457.38899138524;17463.21415536304;17475.737863932052;3751.8874433767032;3752.155764952891;3752.887413377603;3756.0422092366543;3778.527684039495;143426;144589;144778.27610861984;145199;147731;16463.176841157896;16892.239849206817;16993.32026718942;16993.745093823603;17009.744853827204;31839;32364.83817580897;32467.67532324694;32589.511157332658;32691.346173076407;8713.259372953244;8901.287896968357;8987.46075235488;9011.324150688724;9052.773680658036;4014.458048163519;4048.6153815387493;4090.836366545305;4097.467329247179;4098.692598055158;5331.253624492574;5341.893162136736;5376.1935709643085;5412.458754124556;5429.809956651498;996.0637001218831;1005.3766664667806;1022.8158931392272;1023.4115383654429;1026.7484466305802;670.8222321084917;683.9418649414756;693.7918624412656;703.0192880931072;703.1246098607267;11634;11840.881591183977;12040;12995.025373097056;13345.065845390729;681.1519658025691;683.723092147681;685.1264637587017;690.7893092606803;701.684242091061;5525.143602741581;5622.943770562242;5678.829635110953;5703.914441283384;5815.79644712433;126904.36547817386;128324;128343.35828320985;129621.35189324182;131749;108331;109781.45109274563;110703;113501.432492837;115664.42167789275;91856;95503;97406;99546;102604.53835443642;12586;12978.221306721627;13024.153430027018;13127.803082953573;13344.599662010156;42537;43584;45111;45312.54687453083;46327.07345853131;56329.436705634056;56439;56761.43238567562;58151.127733083194;58964.410355897606;18743.812561874205;19120.33078842234;19149;19261.422157335302;19347.516312091746;19956.3015294464;20223.19107235694;20406.183752650322;20454.181832726525;20792.37622871316;17278.740818887476;17388.304467821144;17414;17479.47561573155;17570.297188112334;19506;20077.799222007594;20128.79871201328;20175.69736453925;20465.18139274412;18781.812181878006;18828.24687012559;18907.338243161423;19015.809841901402;19051.90474047621;14392.28038598045;14694.11835289886;14735.484258050918;14869.553913382615;14878.628034298796;13917.652058698613;14139.222342771247;14190.219537925514;14220.644483887985;14226.715465690835 10:21:35 INFO - PID 13879 | __end_tp_report 10:21:35 INFO - PID 13879 | __start_cc_report 10:21:35 INFO - PID 13879 | _x_x_mozilla_cycle_collect,384 10:21:35 INFO - PID 13879 | __end_cc_report 10:21:35 INFO - PID 13879 | __startTimestamp1505409695053__endTimestamp 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | ------- Summary: start ------- 10:21:35 INFO - PID 13879 | Number of tests: 6 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | [#0] dojo.html Cycles:165 Average:6189.08 Median:6439.20 stddev:837.33 (13.0%) stddev-sans-first:805.51 10:21:35 INFO - PID 13879 | Values: 3161.8 3180.0 3194.0 3203.0 3229.4 6173.9 6264.2 6310.0 6349.7 6425.0 6203.8 6248.2 6255.4 6291.7 6295.9 5841.9 5866.7 5887.6 5916.6 5937.2 1260.1 5757.4 5879.8 5918.3 5939.7 5741.5 5827.5 5829.5 5888.7 5891.7 5780.5 5791.8 5797.5 5864.2 5877.0 5694.0 5760.1 5800.9 5832.7 5864.7 6220.2 6251.1 6337.9 6362.9 6394.0 6541.5 6633.1 6722.0 6759.1 6842.1 6702.3 6741.3 6751.9 6754.5 6758.8 6273.2 6359.7 6371.9 6378.3 6379.6 6944.5 6974.2 6993.2 7064.0 7065.4 6589.3 6589.4 6604.8 6628.2 6737.4 6670.6 6694.1 6716.7 6757.3 6780.6 6644.1 6673.3 6727.2 6761.1 6788.1 6738.4 6742.0 6828.4 6832.3 6836.4 5116.7 5186.2 5188.6 5189.8 5190.6 4632.0 4654.1 4668.2 4686.7 4711.0 5733.5 5882.1 5886.1 5886.6 5892.3 6752.4 6792.7 6854.4 6866.3 6879.5 5700.9 5774.3 5792.9 5815.0 5878.3 5831.2 5854.6 5855.3 5857.9 5863.5 6454.1 6472.9 6530.1 6547.4 6701.3 6787.7 6845.3 6873.4 6879.7 6885.2 6589.6 6605.9 6609.9 6696.3 6699.5 6388.7 6549.5 6613.8 6683.4 6686.0 6804.5 6804.8 6816.3 6821.0 6838.4 6570.7 6576.2 6616.9 6653.1 6657.2 6534.2 6560.4 6607.5 6618.0 6636.7 6308.0 6421.5 6439.2 6448.5 6554.3 6483.4 6602.9 6622.3 6642.1 6649.3 6230.1 6357.4 6375.1 6376.8 6448.7 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | [#1] ext.html Cycles:180 Average:37325.57 Median:3547.67 stddev:54269.71 (1529.7%) stddev-sans-first:54352.69 10:21:35 INFO - PID 13879 | Values: 810.3 818.5 830.6 850.5 859.0 40163.4 40657.6 40865.8 40936.2 41201.8 37143.3 41664.6 42096.0 42359.0 42499.2 7601.8 7670.8 7727.5 7740.4 7743.2 7568.2 7679.9 7685.4 7719.0 7720.8 7646.0 7733.5 7743.5 7757.9 7759.7 7684.7 7724.1 7730.9 7741.7 7744.7 7553.0 7631.8 7641.5 7645.2 7654.2 37167.5 37255.4 37496.6 37577.0 37602.0 3515.2 3542.8 3547.2 3548.2 3548.5 30115.7 30229.0 30231.5 30245.4 30281.2 5009.0 5195.0 5205.2 5249.4 5252.5 180773.0 186231.0 187461.0 188878.0 196176.0 47538.3 47970.0 48053.3 48276.5 48317.3 49033.3 49351.8 49422.3 49492.3 49623.0 16028.5 16066.1 16095.0 16135.1 16162.4 13230.3 13290.7 13325.9 13342.7 13359.0 12543.0 12676.6 12706.0 12835.2 12872.0 5028.6 5077.1 5090.9 5092.5 5173.6 975.5 996.0 1000.6 1010.6 1017.5 21312.7 21468.0 21493.7 21599.0 21738.0 1094.5 1105.6 1106.2 1108.9 1110.3 11497.3 11537.1 11634.5 11697.6 11750.8 231771.0 231998.0 232384.0 233191.0 233228.0 50707.2 50778.7 50840.5 50883.0 50899.5 1420.9 1433.6 1436.4 1454.4 1458.7 21511.4 21629.1 22184.9 22393.7 22401.8 35766.5 35894.8 35900.1 35916.8 36014.6 194101.0 194125.0 209115.0 212408.0 214122.0 28756.7 29883.0 30426.0 33502.5 33835.8 39280.6 43765.0 44295.8 44706.8 45079.0 32144.2 32303.7 32358.0 32576.0 33231.7 31727.4 32269.2 32278.8 32336.5 32691.2 36141.6 36262.6 36350.6 36372.5 36423.3 31709.8 31752.0 31842.5 32108.5 32900.7 22785.3 23034.0 23036.1 23087.0 23176.3 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | [#2] jquery.html Cycles:180 Average:32795.17 Median:23232.36 stddev:74029.07 (318.6%) stddev-sans-first:74197.17 10:21:35 INFO - PID 13879 | Values: 555.8 555.9 557.8 575.4 593.2 21245.6 22243.0 22253.9 22272.9 22280.0 23714.6 24136.0 24319.0 24325.3 24990.6 6498.9 6761.6 6762.8 6774.0 6782.1 6633.7 6686.8 6734.2 6736.2 6744.9 6216.9 6463.3 6482.9 6486.4 6489.9 6337.2 6484.6 6498.3 6528.3 6546.6 6111.5 6125.2 6132.8 6137.8 6144.9 28867.1 29219.7 29399.0 29427.7 29497.1 2011.3 2014.6 2029.5 2033.9 2034.2 19296.8 19458.1 19817.4 20050.0 20228.3 2370.3 2385.7 2433.6 2441.9 2443.9 117598.0 124919.0 131722.0 131831.3 138944.3 14624.0 14861.8 14914.5 14935.4 15237.0 23105.7 23220.3 23226.3 23279.0 23284.3 9602.9 9609.3 9618.9 9769.4 9796.8 8959.6 9000.5 9063.8 9092.5 9189.4 9033.6 9111.4 9165.3 9376.4 9456.2 2621.1 2676.8 2685.3 2706.6 2796.6 952.7 962.1 979.1 979.5 986.1 18912.4 18960.0 19005.7 19460.5 19465.3 1015.8 1020.9 1025.5 1034.2 1041.1 10536.0 10638.3 10711.6 10749.9 10801.9 427058.0 431189.0 441608.0 443095.0 443814.0 108145.5 109576.5 109719.5 112950.4 114387.0 1045.2 1092.7 1143.5 1157.0 1180.9 20216.5 20329.4 20364.8 20451.7 20866.9 54527.0 55324.7 55391.0 55685.7 55918.7 68685.0 68711.7 69246.0 69540.3 69990.0 14125.7 14318.8 14487.3 14545.7 14571.9 22921.7 23168.7 23228.5 23236.2 23460.8 18050.8 18226.5 18231.0 18258.5 18321.5 16246.7 16341.2 16759.5 17014.6 17163.5 17757.4 18366.6 18462.2 18624.4 18735.4 14090.5 14092.9 14232.6 14249.6 14438.4 18165.5 18286.0 18544.8 18589.7 18750.2 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | [#3] mootools.html Cycles:180 Average:9401.61 Median:2645.68 stddev:6782.27 (256.4%) stddev-sans-first:6774.04 10:21:35 INFO - PID 13879 | Values: 1309.1 1342.8 1365.3 1366.4 1379.4 15043.9 15752.9 15814.7 15840.6 15858.8 15448.9 15503.5 15538.3 15551.0 15553.7 2649.6 2783.2 2784.0 2785.6 2792.0 2755.3 2767.5 2770.8 2773.8 2777.0 2673.4 2697.1 2712.6 2724.3 2726.1 2602.6 2619.3 2631.8 2631.9 2643.5 2616.5 2633.8 2640.4 2645.4 2645.9 15379.8 15759.7 15760.1 15793.8 15916.8 7890.0 8175.1 8178.1 8187.9 8190.3 5339.9 5488.5 5527.6 5535.6 5576.6 1870.7 1903.5 1911.1 1947.2 1948.8 26103.2 26431.0 26452.6 26488.6 26514.1 6624.8 6798.0 6996.7 7013.3 7032.8 17439.1 17538.7 17564.9 17582.5 17596.4 7749.5 7902.1 7902.1 7907.8 7908.1 7228.9 7266.1 7290.9 7335.9 7342.3 5326.7 5434.0 5444.9 5547.8 5643.7 1552.8 1559.1 1560.6 1560.8 1586.1 896.3 903.6 909.2 909.6 917.2 7500.3 7592.5 7643.7 7683.7 7711.6 680.4 697.5 700.7 717.7 727.7 5026.0 5315.6 5575.5 5618.5 5656.3 21193.9 21430.1 21904.9 22234.4 22300.6 21356.9 22119.8 22160.6 22188.8 22450.1 10532.7 10956.4 10994.2 11009.2 11088.4 8575.7 8627.4 8661.3 8677.8 8692.6 18730.0 18832.4 18979.6 19211.9 19274.2 19238.2 19369.2 19627.6 19934.4 20203.5 10753.8 10855.6 10936.6 10981.8 10982.9 13910.2 14044.6 14101.4 14194.6 14211.4 11305.9 11464.5 11568.4 11610.4 11684.4 10414.2 10448.7 10582.8 10770.7 10890.1 9623.0 9905.2 9918.3 9918.5 9923.3 7004.4 7141.9 7167.9 7180.7 7184.5 7019.4 7160.2 7230.7 7267.0 7330.3 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | [#4] prototype.html Cycles:180 Average:5439.70 Median:6147.98 stddev:1518.21 (24.7%) stddev-sans-first:1476.40 10:21:35 INFO - PID 13879 | Values: 494.7 494.9 517.2 527.9 531.6 6160.6 6212.5 6232.6 6234.0 6290.2 6135.4 6182.4 6188.7 6190.8 6246.6 5121.3 5139.3 5147.3 5148.1 5158.3 4768.9 4873.0 5029.6 5105.2 5124.9 4869.8 4884.4 4913.0 4916.0 4941.8 4874.5 4876.1 4891.8 4904.2 4955.7 4314.9 4404.6 4412.1 4413.0 4418.4 5957.0 5991.5 5999.6 6016.5 6026.9 5574.7 5584.5 5626.5 5640.2 5642.4 6504.9 6506.6 6522.7 6530.4 6559.0 4622.2 4838.9 4850.4 4859.8 4871.3 6597.7 6662.8 6716.0 6795.4 6817.7 4930.0 4941.6 4944.6 4971.4 4981.3 4998.4 5022.0 5032.6 5049.6 5062.4 5549.3 5579.1 5580.2 5641.7 5642.4 6505.1 6540.7 6544.7 6547.9 6550.7 1724.6 1745.1 1747.3 1748.2 1760.2 1140.7 1200.4 1218.5 1219.3 1224.0 5619.7 5630.9 5683.8 5685.5 5690.2 6536.4 6621.4 6671.1 6702.2 6706.8 5493.5 5604.7 5656.9 5666.2 5670.9 3471.3 3485.6 3519.2 3534.2 3538.3 6445.9 6473.8 6477.3 6483.0 6506.4 6703.5 6718.3 6761.9 6827.6 6834.7 6382.7 6388.7 6429.5 6509.2 6545.3 6168.2 6468.8 6489.2 6579.5 6612.0 6364.8 6458.2 6532.1 6543.2 6568.6 6336.8 6350.7 6361.3 6404.8 6420.5 4864.9 4870.9 4919.3 4933.7 4950.6 6265.5 6407.6 6487.1 6677.5 6678.9 6388.9 6393.6 6428.4 6429.2 6447.9 6219.6 6336.0 6362.8 6383.3 6443.4 6311.6 6316.4 6340.2 6391.3 6403.6 6447.0 6457.7 6554.9 6564.2 6590.8 6290.0 6291.3 6332.7 6353.5 6370.6 10:21:35 INFO - PID 13879 | 10:21:35 INFO - PID 13879 | [#5] yui.html Cycles:180 Average:25533.16 Median:20357.08 stddev:36442.22 (179.0%) stddev-sans-first:36497.43 10:21:35 INFO - PID 13879 | Values: 879.1 883.8 910.9 911.8 914.7 19522.6 20354.1 20443.7 20445.0 20468.7 18101.0 18412.1 18718.3 19127.1 19163.1 949.9 971.0 971.6 972.9 975.8 975.7 977.6 979.7 993.8 999.1 1021.1 1021.8 1022.2 1024.6 1026.4 986.0 1012.3 1014.3 1018.0 1019.2 730.0 737.9 739.4 739.7 740.5 20107.4 20206.7 20316.7 20338.6 20360.1 21738.7 22529.3 22531.8 22561.4 22567.8 17132.0 17199.7 17457.4 17463.2 17475.7 3751.9 3752.2 3752.9 3756.0 3778.5 143426.0 144589.0 144778.3 145199.0 147731.0 16463.2 16892.2 16993.3 16993.7 17009.7 31839.0 32364.8 32467.7 32589.5 32691.3 8713.3 8901.3 8987.5 9011.3 9052.8 4014.5 4048.6 4090.8 4097.5 4098.7 5331.3 5341.9 5376.2 5412.5 5429.8 996.1 1005.4 1022.8 1023.4 1026.7 670.8 683.9 693.8 703.0 703.1 11634.0 11840.9 12040.0 12995.0 13345.1 681.2 683.7 685.1 690.8 701.7 5525.1 5622.9 5678.8 5703.9 5815.8 126904.4 128324.0 128343.4 129621.4 131749.0 108331.0 109781.5 110703.0 113501.4 115664.4 91856.0 95503.0 97406.0 99546.0 102604.5 12586.0 12978.2 13024.2 13127.8 13344.6 42537.0 43584.0 45111.0 45312.5 46327.1 56329.4 56439.0 56761.4 58151.1 58964.4 18743.8 19120.3 19149.0 19261.4 19347.5 19956.3 20223.2 20406.2 20454.2 20792.4 17278.7 17388.3 17414.0 17479.5 17570.3 19506.0 20077.8 20128.8 20175.7 20465.2 18781.8 18828.2 18907.3 19015.8 19051.9 14392.3 14694.1 14735.5 14869.6 14878.6 13917.7 14139.2 14190.2 14220.6 14226.7 10:21:35 INFO - PID 13879 | -------- Summary: end -------- 10:21:35 INFO - PID 13879 | 10:21:35 INFO - TEST-INFO | 13879: exit 0 10:21:35 INFO - TEST-OK | dromaeo_css | took 1109565ms 10:21:35 INFO - TEST-START | kraken 10:21:35 INFO - Initialising browser for kraken test... 10:21:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41113/getInfo.html -profile /tmp/tmpP3fmpt/profile 10:21:35 INFO - TEST-INFO | started process 14259 (/builds/slave/test/build/application/firefox/firefox http://localhost:41113/getInfo.html) 10:21:40 INFO - TEST-INFO | 14259: exit 0 10:21:40 INFO - Browser initialized. 10:21:40 INFO - Running cycle 1/1 for kraken test... 10:21:40 INFO - Using env: {'DISPLAY': ':0', 10:21:40 INFO - 'HOME': '/home/cltbld', 10:21:40 INFO - 'JSGC_DISABLE_POISONING': '1', 10:21:40 INFO - 'LANG': 'en_US.UTF-8', 10:21:40 INFO - 'LANGUAGE': 'en_US:en', 10:21:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:21:40 INFO - 'LOGNAME': 'cltbld', 10:21:40 INFO - 'MAIL': '/var/mail/cltbld', 10:21:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:40 INFO - 'MOZ_CRASHREPORTER': '1', 10:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:21:40 INFO - 'MOZ_NO_REMOTE': '1', 10:21:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:40 INFO - 'NO_EM_RESTART': '1', 10:21:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:40 INFO - 'PWD': '/builds/slave/test', 10:21:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:40 INFO - 'RUST_BACKTRACE': 'full', 10:21:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:21:40 INFO - 'SHELL': '/bin/bash', 10:21:40 INFO - 'SHLVL': '1', 10:21:40 INFO - 'TERM': 'linux', 10:21:40 INFO - 'TMOUT': '86400', 10:21:40 INFO - 'USER': 'cltbld', 10:21:40 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475', 10:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:40 INFO - '_': '/tools/buildbot/bin/python'} 10:21:40 INFO - TEST-INFO | started process 14492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP3fmpt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:41 INFO - PID 14492 | 10:21:41 INFO - PID 14492 | (/builds/slave/test/build/application/firefox/firefox:14542): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:21:41 INFO - PID 14492 | 10:21:52 INFO - PID 14492 | RSS: Main: 172851200 10:21:52 INFO - PID 14492 | 10:21:54 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41113/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:55 INFO - PID 14492 | RSS: Main: 177594368 10:21:55 INFO - PID 14492 | 10:21:58 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41113/tests/kraken/driver.html?testName=audio-dft) 10:21:59 INFO - PID 14492 | RSS: Main: 178253824 10:21:59 INFO - PID 14492 | 10:22:02 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41113/tests/kraken/driver.html?testName=audio-fft) 10:22:02 INFO - PID 14492 | RSS: Main: 173477888 10:22:02 INFO - PID 14492 | 10:22:04 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41113/tests/kraken/driver.html?testName=audio-oscillator) 10:22:05 INFO - PID 14492 | RSS: Main: 174362624 10:22:05 INFO - PID 14492 | 10:22:07 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41113/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:08 INFO - PID 14492 | RSS: Main: 174825472 10:22:08 INFO - PID 14492 | 10:22:11 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41113/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:12 INFO - PID 14492 | RSS: Main: 177139712 10:22:12 INFO - PID 14492 | 10:22:15 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41113/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:16 INFO - PID 14492 | RSS: Main: 177131520 10:22:16 INFO - PID 14492 | 10:22:19 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41113/tests/kraken/driver.html?testName=json-parse-financial) 10:22:20 INFO - PID 14492 | RSS: Main: 177115136 10:22:20 INFO - PID 14492 | 10:22:21 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41113/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:22 INFO - PID 14492 | RSS: Main: 177049600 10:22:22 INFO - PID 14492 | 10:22:23 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:24 INFO - PID 14492 | RSS: Main: 177135616 10:22:24 INFO - PID 14492 | 10:22:26 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:27 INFO - PID 14492 | RSS: Main: 174276608 10:22:27 INFO - PID 14492 | 10:22:29 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:30 INFO - PID 14492 | RSS: Main: 175226880 10:22:30 INFO - PID 14492 | 10:22:33 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:34 INFO - PID 14492 | RSS: Main: 175009792 10:22:34 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | Cycle 1(1): loaded http://localhost:41113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41113/tests/kraken/driver.html?testName=ai-astar) 10:22:36 INFO - PID 14492 | RSS: Main: 176345088 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | __start_tp_report 10:22:36 INFO - PID 14492 | _x_x_mozilla_page_load 10:22:36 INFO - PID 14492 | _x_x_mozilla_page_load_details 10:22:36 INFO - PID 14492 | |i|pagename|runs| 10:22:36 INFO - PID 14492 | |0;ai-astar;107;107;108;108;107;109;109;108;108;107 10:22:36 INFO - PID 14492 | |1;audio-beat-detection;121;119;115;116;119;118;117;116;117;118 10:22:36 INFO - PID 14492 | |2;audio-dft;164;160;164;163;165;162;170;166;164;162 10:22:36 INFO - PID 14492 | |3;audio-fft;74;74;74;74;76;75;75;75;76;76 10:22:36 INFO - PID 14492 | |4;audio-oscillator;79;80;80;79;78;79;79;79;81;82 10:22:36 INFO - PID 14492 | |5;imaging-gaussian-blur;110;114;114;113;113;113;114;115;116;122 10:22:36 INFO - PID 14492 | |6;imaging-darkroom;147;148;147;147;148;148;147;148;148;148 10:22:36 INFO - PID 14492 | |7;imaging-desaturate;94;94;99;98;99;94;94;99;94;94 10:22:36 INFO - PID 14492 | |8;json-parse-financial;55;54;53;51;52;53;53;55;53;53 10:22:36 INFO - PID 14492 | |9;json-stringify-tinderbox;38;39;38;38;38;39;39;39;39;38 10:22:36 INFO - PID 14492 | |10;stanford-crypto-aes;74;74;76;77;76;74;74;76;74;75 10:22:36 INFO - PID 14492 | |11;stanford-crypto-ccm;117;114;113;118;120;110;110;117;122;117 10:22:36 INFO - PID 14492 | |12;stanford-crypto-pbkdf2;169;171;171;170;167;168;167;168;172;165 10:22:36 INFO - PID 14492 | |13;stanford-crypto-sha256-iterative;68;73;66;72;65;65;72;66;65;65 10:22:36 INFO - PID 14492 | __end_tp_report 10:22:36 INFO - PID 14492 | __start_cc_report 10:22:36 INFO - PID 14492 | _x_x_mozilla_cycle_collect,959 10:22:36 INFO - PID 14492 | __end_cc_report 10:22:36 INFO - PID 14492 | __startTimestamp1505409756254__endTimestamp 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | ------- Summary: start ------- 10:22:36 INFO - PID 14492 | Number of tests: 14 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#0] ai-astar Cycles:10 Average:107.80 Median:108.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:22:36 INFO - PID 14492 | Values: 107.0 107.0 108.0 108.0 107.0 109.0 109.0 108.0 108.0 107.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:118.00 stddev:1.78 (1.5%) stddev-sans-first:1.39 10:22:36 INFO - PID 14492 | Values: 121.0 119.0 115.0 116.0 119.0 118.0 117.0 116.0 117.0 118.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.71 (1.7%) stddev-sans-first:2.87 10:22:36 INFO - PID 14492 | Values: 164.0 160.0 164.0 163.0 165.0 162.0 170.0 166.0 164.0 162.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#3] audio-fft Cycles:10 Average:74.90 Median:75.00 stddev:0.88 (1.2%) stddev-sans-first:0.87 10:22:36 INFO - PID 14492 | Values: 74.0 74.0 74.0 74.0 76.0 75.0 75.0 75.0 76.0 76.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:79.50 stddev:1.17 (1.5%) stddev-sans-first:1.22 10:22:36 INFO - PID 14492 | Values: 79.0 80.0 80.0 79.0 78.0 79.0 79.0 79.0 81.0 82.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:3.10 (2.7%) stddev-sans-first:2.85 10:22:36 INFO - PID 14492 | Values: 110.0 114.0 114.0 113.0 113.0 113.0 114.0 115.0 116.0 122.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 10:22:36 INFO - PID 14492 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 147.0 148.0 148.0 148.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:2.47 (2.6%) stddev-sans-first:2.52 10:22:36 INFO - PID 14492 | Values: 94.0 94.0 99.0 98.0 99.0 94.0 94.0 99.0 94.0 94.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.12 10:22:36 INFO - PID 14492 | Values: 55.0 54.0 53.0 51.0 52.0 53.0 53.0 55.0 53.0 53.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 10:22:36 INFO - PID 14492 | Values: 38.0 39.0 38.0 38.0 38.0 39.0 39.0 39.0 39.0 38.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.50 stddev:1.15 (1.5%) stddev-sans-first:1.17 10:22:36 INFO - PID 14492 | Values: 74.0 74.0 76.0 77.0 76.0 74.0 74.0 76.0 74.0 75.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.00 stddev:3.99 (3.4%) stddev-sans-first:4.21 10:22:36 INFO - PID 14492 | Values: 117.0 114.0 113.0 118.0 120.0 110.0 110.0 117.0 122.0 117.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:2.20 (1.3%) stddev-sans-first:2.33 10:22:36 INFO - PID 14492 | Values: 169.0 171.0 171.0 170.0 167.0 168.0 167.0 168.0 172.0 165.0 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:3.33 (5.0%) stddev-sans-first:3.54 10:22:36 INFO - PID 14492 | Values: 68.0 73.0 66.0 72.0 65.0 65.0 72.0 66.0 65.0 65.0 10:22:36 INFO - PID 14492 | -------- Summary: end -------- 10:22:36 INFO - PID 14492 | 10:22:36 INFO - PID 14492 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:22:36 INFO - TEST-INFO | 14492: exit 0 10:22:37 INFO - TEST-OK | kraken | took 61278ms 10:22:37 INFO - SUITE-END | took 1170s 10:22:37 INFO - Completed test suite (00:19:31) 10:22:37 INFO - javascript benchmark 10:22:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8511.242674251262, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.8260995645246, 3180.0, 3193.9520907186397, 3202.9519557206645, 3229.354129174166, 6173.876522469548, 6264.154339164223, 6309.968450157754, 6349.682515874205, 6424.967875160618, 6203.751849925998, 6248.187735594366, 6255.4370106690385, 6291.653959032252, 6295.905561416571, 5841.853953651172, 5866.677332746697, 5887.646741195521, 5916.585838991272, 5937.22816033915, 1260.0782327576837, 5757.395473475267, 5879.794207202749, 5918.2898052233795, 5939.70301484924, 5741.45456181662, 5827.504662103726, 5829.504492118175, 5888.735006924699, 5891.734871930752, 5780.537556995472, 5791.768329266824, 5797.536197104221, 5864.179014937912, 5876.97061514694, 5693.971530142323, 5760.107183386582, 5800.941990580082, 5832.650040997553, 5864.70676466175, 6220.1913751212505, 6251.12484252205, 6337.87324253517, 6362.872742545123, 6393.9680301598655, 6541.542092053558, 6633.071370008202, 6722.0, 6759.121314229168, 6842.110525631686, 6702.262751097375, 6741.258461569223, 6751.864962700768, 6754.527183097185, 6758.797236082925, 6273.1531243282025, 6359.682015899187, 6371.872562548723, 6378.330275321071, 6379.649119298483, 6944.479164062715, 6974.163100427981, 6993.230744618088, 7063.964680176567, 7065.43476521877, 6589.275179730226, 6589.4069533742195, 6604.801855944329, 6628.204615446178, 6737.393634572912, 6670.566413183127, 6694.129763130762, 6716.731330746813, 6757.290484499155, 6780.593164410151, 6644.069830223772, 6673.299303573055, 6727.226368967534, 6761.121054263012, 6788.083608712859, 6738.427233685094, 6742.0, 6828.419584335387, 6832.282610325944, 6836.38472537474, 5116.667416617908, 5186.170212765939, 5188.610854185876, 5189.844304670866, 5190.584753219733, 4631.9536804631525, 4654.092451971833, 4668.183067963093, 4686.671932964728, 4710.976445117821, 5733.455321744427, 5882.088276317178, 5886.117082437583, 5886.61736987103, 5892.322382925932, 6752.426043786235, 6792.66036698173, 6854.383105520427, 6866.34769696878, 6879.5184337096925, 5700.885982280414, 5774.335951365562, 5792.9420705793245, 5815.040518314515, 5878.29460464747, 5831.241938547962, 5854.648721076749, 5855.3266374367495, 5857.912131318034, 5863.5309175265875, 6454.128692626529, 6472.935270647327, 6530.118434011442, 6547.377999090078, 6701.29636388182, 6787.728490860508, 6845.349691779273, 6873.4157596602845, 6879.6560171990195, 6885.208201056943, 6589.571677841117, 6605.900911486236, 6609.933900660932, 6696.263411024881, 6699.497537684596, 6388.712507937247, 6549.4760419165395, 6613.768518101843, 6683.398494135551, 6685.966570167313, 6804.523683342317, 6804.795856124324, 6816.2842901496615, 6821.0, 6838.418734407432, 6570.737170513126, 6576.210854697467, 6616.933830661825, 6653.101831252912, 6657.234418041987, 6534.248561415498, 6560.40956313934, 6607.537472376887, 6618.0403841443685, 6636.734530618721, 6307.96846015767, 6421.486281097595, 6439.195100612424, 6448.5163612730175, 6554.279029306677, 6483.4164925156965, 6602.867942641216, 6622.271550129578, 6642.103316052271, 6649.301823308483, 6230.096635987847, 6357.4278314950025, 6375.107484952203, 6376.808695739135, 6448.742050317935], "value": 6128.870076100711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.2586133687676, 818.4925346285303, 830.5681045856152, 850.5109562001849, 859.0335872143838, 40163.39754903675, 40657.59342406575, 40865.795671021675, 40936.18127637445, 41201.79399103004, 37143.25713485729, 41664.58335416645, 42096.0, 42359.0, 42499.150016999716, 7601.84796304075, 7670.7698769037015, 7727.536347819148, 7740.380769538451, 7743.2256774322395, 7568.167501574822, 7679.884801727979, 7685.385169186452, 7719.0, 7720.7683769487, 7646.0, 7733.497322674037, 7743.535387876717, 7757.883631745528, 7759.689612415496, 7684.731034413797, 7724.111727151393, 7730.922690773076, 7741.690332386698, 7744.690212391498, 7552.962235188789, 7631.809204769869, 7641.503302285334, 7645.15903250642, 7654.234576542357, 37167.51329946799, 37255.441168382225, 37496.62503374986, 37577.0, 37602.0, 3515.226650136966, 3542.787432754043, 3547.166415892263, 3548.1661809474754, 3548.4677298405186, 30115.69884301151, 30229.0, 30231.546526802114, 30245.395092098253, 30281.242968925733, 5009.0, 5195.038917800219, 5205.193195054772, 5249.370075590915, 5252.474752524755, 180773.0, 186231.0, 187461.0, 188878.0, 196176.0, 47538.28692569614, 47970.0, 48053.279200812016, 48276.5172348279, 48317.275240871415, 49033.264501032514, 49351.753241234284, 49422.25866612004, 49492.25761613579, 49623.0, 16028.519144425685, 16066.116363600115, 16095.0, 16135.112568808594, 16162.43431479916, 13230.272335021666, 13290.734185316433, 13325.866741332462, 13342.666433339244, 13359.0, 12543.0, 12676.619701408788, 12706.0, 12835.229886206858, 12872.0, 5028.622853286018, 5077.111505486525, 5090.872728181751, 5092.541671249605, 5173.611979101583, 975.5268694683073, 995.9502024898726, 1000.5647543318535, 1010.5755582655303, 1017.4658304390255, 21312.680309795367, 21468.0, 21493.67759483609, 21599.0, 21738.0, 1094.5074716377662, 1105.6240878101485, 1106.2145876427664, 1108.944552772358, 1110.2894147745449, 11497.252678575866, 11537.134714896416, 11634.53461861533, 11697.649070527897, 11750.823737643943, 231771.0, 231998.0, 232384.0, 233191.0, 233228.0, 50707.23939140916, 50778.74610626923, 50840.49159508431, 50883.0, 50899.491005089476, 1420.88632909367, 1433.5700986827228, 1436.3536408616164, 1454.3600815641084, 1458.7374272630816, 21511.354659360244, 21629.13483460644, 22184.889075554518, 22393.66409503826, 22401.775982239968, 35766.46350304696, 35894.8205258972, 35900.10249743777, 35916.82041589775, 36014.639853601126, 194101.0, 194125.0, 209115.0, 212408.0, 214122.0, 28756.712432875403, 29883.0, 30426.0, 33502.497462538566, 33835.83082084672, 39280.62517811863, 43765.0, 44295.77852110719, 44706.77646611746, 45079.0, 32144.19639509031, 32303.676963230067, 32358.0, 32576.0, 33231.667683322856, 31727.36545269128, 32269.193270168435, 32278.83860580682, 32336.514952276204, 32691.182720432178, 36141.61302536964, 36262.63737362698, 36350.63649363472, 36372.45441318435, 36423.27153456863, 31709.780315377702, 31752.04743857688, 31842.52236216505, 32108.518372224902, 32900.67099328976, 22785.316440506813, 23034.0, 23036.078556857537, 23087.023159913082, 23176.3047108587], "value": 16841.429614630128, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8332500249927, 555.8749281411681, 557.8410153106363, 575.3814649252054, 593.2376895689038, 21245.57508849822, 22242.99906504209, 22253.888730556366, 22272.88863555684, 22280.0, 23714.644280335808, 24136.034558617634, 24319.0, 24325.270241892726, 24990.625140622906, 6498.902516462245, 6761.560498567602, 6762.763303284386, 6773.966130169342, 6782.084418603475, 6633.668316584151, 6686.765963191289, 6734.19189697237, 6736.157980252468, 6744.93255067448, 6216.875662486747, 6463.289038205794, 6482.902756458633, 6486.4162225399705, 6489.935100649004, 6337.176167098248, 6484.578502397353, 6498.252700939358, 6528.281888992207, 6546.574472659262, 6111.541634377395, 6125.173101631267, 6132.7546898124465, 6137.815865524041, 6144.907826382608, 28867.133985980243, 29219.707802921912, 29398.971036013852, 29427.705722942712, 29497.115086547437, 2011.3463124484601, 2014.5870096630156, 2029.5129168999333, 2033.8983050847546, 2034.1558253324852, 19296.842189468538, 19458.124384402738, 19817.405477835688, 20050.0, 20228.292009779736, 2370.2889133259955, 2385.7256415512265, 2433.561958847407, 2441.865697386643, 2443.8900249488815, 117598.0, 124919.0, 131722.0, 131831.34084329612, 138944.305278475, 14623.976321657594, 14861.798370570214, 14914.482779272226, 14935.402583896739, 15237.0, 23105.653415198787, 23220.3033908983, 23226.3032109037, 23279.0, 23284.3014709559, 9602.90397096034, 9609.279304052085, 9618.903810961941, 9769.364991275545, 9796.755081122887, 8959.62422546467, 9000.459972401677, 9063.818723625622, 9092.454452732725, 9189.448633082036, 9033.567244447067, 9111.362204645611, 9165.31260155491, 9376.437413755197, 9456.196223320958, 2621.082621082606, 2676.772474339664, 2685.2610337455685, 2706.553418685934, 2796.6084748135277, 952.7094236257869, 962.0571839597234, 979.0698836105586, 979.5102448775613, 986.1124987511154, 18912.43262702121, 18960.0, 19005.714914276297, 19460.513487162934, 19465.318713844947, 1015.786684796201, 1020.9234307426973, 1025.5487585462522, 1034.2036631793628, 1041.1306559023149, 10536.0, 10638.255322127377, 10711.625093121704, 10749.89250107489, 10801.891981080245, 427058.0, 431189.0, 441608.0, 443095.0, 443814.0, 108145.45927270471, 109576.4521177405, 109719.45140274247, 112950.43524782323, 114387.0, 1045.2265323660588, 1092.7432053467428, 1143.508291434691, 1157.0454375140544, 1180.893719565226, 20216.494587635425, 20329.390118296476, 20364.79635203629, 20451.69322460194, 20866.895665521577, 54527.0, 55324.72337638447, 55391.0, 55685.721571391885, 55918.720406399334, 68685.0, 68711.65644171747, 69245.96131058139, 69540.30459695541, 69990.0, 14125.717485650024, 14318.785218221943, 14487.275636217935, 14545.709085818013, 14571.854281457474, 22921.65617515705, 23168.652470212623, 23228.535429290983, 23236.18673346425, 23460.76539234654, 18050.819491804912, 18226.544336391697, 18231.0, 18258.543536411697, 18321.541961451072, 16246.67506649884, 16341.182940852672, 16759.497215083567, 17014.57463563371, 17163.485095447155, 17757.378491752726, 18366.632667346847, 18462.169202385656, 18624.44126676202, 18735.437936861916, 14090.506832260822, 14092.929535352669, 14232.644183895485, 14249.643758905695, 14438.350274237895, 18165.455036348932, 18286.0, 18544.814551854848, 18589.721154182967, 18750.156242968827], "value": 11824.521504642838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.0836414509843, 1342.8187194728714, 1365.3105181883147, 1366.4261010375642, 1379.3517046987913, 15043.924780376097, 15752.921235393807, 15814.683706325866, 15840.603984900383, 15858.762118568231, 15448.922755386207, 15503.53489395317, 15538.300776465057, 15551.0, 15553.688926221468, 2649.5760678291476, 2783.248522898816, 2783.986080069597, 2785.5960885671566, 2791.9809269616544, 2755.2698534888273, 2767.501849667059, 2770.7921905857042, 2773.8058335916494, 2776.9583456248174, 2673.3984853408024, 2697.096472681654, 2712.606672032564, 2724.3189202699327, 2726.1412655013705, 2602.6226197201395, 2619.253512748867, 2631.8420894746378, 2631.9078832240875, 2643.4977354302814, 2616.515944550264, 2633.789296856247, 2640.4323070539926, 2645.4444566640836, 2645.9206223813317, 15379.769303460456, 15759.684806303925, 15760.133192674399, 15793.763093553605, 15916.840831591651, 7889.96055019727, 8175.100738918714, 8178.100408955011, 8187.877181842277, 8190.262876341158, 5339.866503337409, 5488.4785945335525, 5527.585431092684, 5535.612507124503, 5576.609637325389, 1870.710039943811, 1903.457514608344, 1911.130435651789, 1947.1529884500146, 1948.8440924725987, 26103.216903492925, 26431.0, 26452.603210952042, 26488.60267095995, 26514.072007479837, 6624.8012559623285, 6797.966010169917, 6996.6851491683, 7013.263607321158, 7032.839581469, 17439.128043597768, 17538.736918946226, 17564.912175439298, 17582.472525824247, 17596.384126555764, 7749.4575379724, 7902.0912595052305, 7902.130765615778, 7907.762767116996, 7908.130105688369, 7228.891566626505, 7266.055412796409, 7290.890636640454, 7335.88996165058, 7342.265773422615, 5326.733663316896, 5434.049041417736, 5444.91832622511, 5547.805826796042, 5643.689597072118, 1552.7981362423038, 1559.126888942196, 1560.586444592184, 1560.7580824972147, 1586.111777404657, 896.2919293757858, 903.6204793986542, 909.1908201700492, 909.60432211988, 917.1791246834047, 7500.324970752549, 7592.544447333178, 7643.694252229849, 7683.654235559413, 7711.614419279013, 680.4012469027224, 697.476892330752, 700.7057036044873, 717.7236763845852, 727.7198278662753, 5026.0, 5315.574754019669, 5575.52608028314, 5618.494335509824, 5656.321241451053, 21193.894030530057, 21430.142794288055, 21904.89047554784, 22234.444138896655, 22300.553988920456, 21356.893215533823, 22119.778802212095, 22160.55678886413, 22188.778112218995, 22450.101995920308, 10532.684019479428, 10956.397398143179, 10994.175436842268, 11009.174311926798, 11088.390138542296, 8575.742727718178, 8627.35294852876, 8661.263792577449, 8677.826443471222, 8692.565371731514, 18730.0, 18832.435026949213, 18979.620407592047, 19211.90394048021, 19274.22903083917, 19238.23047078101, 19369.159929806647, 19627.60744785125, 19934.401967940987, 20203.494912627302, 10753.838692419777, 10855.565777368816, 10936.617218397318, 10981.83527247076, 10982.945085274523, 13910.165390076629, 14044.648883777987, 14101.365438555085, 14194.645133871736, 14211.360488778237, 11305.943470282597, 11464.541418343506, 11568.421578921188, 11610.419479025846, 11684.357360345262, 10414.166866650801, 10448.68653940383, 10582.788344233226, 10770.73073173177, 10890.128789696964, 9623.0, 9905.207583393456, 9918.305718599917, 9918.504074796376, 9923.255755818487, 7004.4046256068805, 7141.928580714126, 7167.928320716935, 7180.748673796392, 7184.533005354635, 7019.403350715246, 7160.248173941869, 7230.74692385764, 7266.96366518164, 7330.303621155982], "value": 6654.1923093817295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.7010478938029, 494.94255131100846, 517.15961562461, 527.8759491519493, 531.6198917773792, 6160.5687601867885, 6212.534059945505, 6232.563720539564, 6233.968830155854, 6290.21372328459, 6135.386461353863, 6182.350853160421, 6188.721507532172, 6190.75236990521, 6246.562740608148, 5121.257417674445, 5139.306193663845, 5147.253648221005, 5148.124818780816, 5158.329417175762, 4768.880777980544, 4873.025394921012, 5029.622778291625, 5105.2086926526445, 5124.871878203037, 4869.780859861297, 4884.438289596688, 4912.950870491303, 4916.0, 4941.77762000709, 4874.46380898101, 4876.097921884428, 4891.828785992491, 4904.166291730397, 4955.727434991074, 4314.913701725948, 4404.647628189737, 4412.117576484716, 4412.977935110304, 4418.359337895987, 5957.0, 5991.490723288525, 5999.580029397944, 6016.518678505753, 6026.9095963560585, 5574.665520068768, 5584.520102172927, 5626.465485778845, 5640.182173584848, 5642.4075472075665, 6504.902426463606, 6506.642134682591, 6522.7390904363765, 6530.400051987293, 6559.0, 4622.214223581966, 4838.927416088762, 4850.417949846041, 4859.829905953275, 4871.318015477836, 6597.736090556372, 6662.800115996528, 6716.0, 6795.38841504267, 6817.727290908408, 4930.0, 4941.555260026615, 4944.60443164546, 4971.428285747185, 4981.302617633534, 4998.375203099613, 5021.974890125599, 5032.597392208614, 5049.626675462527, 5062.417821950449, 5549.250851135126, 5579.13523403873, 5580.19087232349, 5641.717914104361, 5642.435756424325, 6505.121808555879, 6540.710751237124, 6544.70548825304, 6547.9017814732815, 6550.672466376662, 1724.6378260565423, 1745.1187150488922, 1747.2836137183695, 1748.1608827762745, 1760.1639221369746, 1140.7319279969201, 1200.3698058519346, 1218.5491368193648, 1219.3354621731178, 1223.9510419583296, 5619.662820230799, 5630.85922851932, 5683.8010669626365, 5685.488306052475, 5690.174924635988, 6536.444402225769, 6621.4040736333, 6671.13275274221, 6702.229243636946, 6706.798796036127, 5493.533049690821, 5604.719764011865, 5656.943430565724, 5666.206731057573, 5670.858228544319, 3471.323091997087, 3485.5643044619424, 3519.1554027033326, 3534.169470174507, 3538.327717733622, 6445.903311450332, 6473.805785826433, 6477.287498375175, 6482.967585162044, 6506.3818937200895, 6703.4972377070935, 6718.289453964091, 6761.898571521431, 6827.590344579341, 6834.726610935606, 6382.744690212432, 6388.744450221939, 6429.485641148697, 6509.153810004669, 6545.280019197884, 6168.242051015439, 6468.838279043061, 6489.1888513935755, 6579.506537009839, 6612.0, 6364.809055728336, 6458.191706322237, 6532.085508028785, 6543.1821022372205, 6568.635291295034, 6336.809895703136, 6350.650714210763, 6361.268454127835, 6404.751073540615, 6420.518461115528, 4864.902701945871, 4870.90258194827, 4919.286703428054, 4933.679310844784, 4950.628702847229, 6265.467435268053, 6407.647579382992, 6487.091807147098, 6677.465802735866, 6678.866422671422, 6388.872222555616, 6393.584417012879, 6428.4214420702365, 6429.164208652845, 6447.903281450688, 6219.564630475823, 6336.0, 6362.840928976628, 6383.32975037633, 6443.355664433519, 6311.589746666452, 6316.368363163647, 6340.207474065742, 6391.296957334596, 6403.615783053032, 6447.0, 6457.741690332522, 6554.901676474952, 6564.179477565304, 6590.7693230736695, 6289.96855015722, 6291.307956124914, 6332.746690132343, 6353.491720662243, 6370.617762934239], "value": 4993.90373029387, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.1208791208791, 883.8497455432575, 910.8861392325957, 911.767499287682, 914.6570036236411, 19522.609547809036, 20354.084066217038, 20443.693344599844, 20445.0, 20468.69296960547, 18101.0, 18412.07939603021, 18718.251269949185, 19127.139278732455, 19163.137658805354, 949.9382540134886, 970.9563069661882, 971.6404930175845, 972.863799068131, 975.7560609847538, 975.7219192530131, 977.5698692575244, 979.7060881735487, 993.8310487217191, 999.1357475783432, 1021.1014307409506, 1021.7547788530736, 1022.2435397805607, 1024.5645600619744, 1026.384169498299, 985.960561577536, 1012.3015119567549, 1014.2595904989325, 1017.954192061359, 1019.1795604538344, 729.956202627844, 737.8561180569791, 739.4380270994084, 739.6782399656166, 740.4927624577128, 20107.39677809668, 20206.696899546518, 20316.69524957127, 20338.5932281355, 20360.083796229057, 21738.673919891215, 22529.32412027642, 22531.774682253297, 22561.435964100863, 22567.77432225673, 17132.0, 17199.65600687992, 17457.38899138524, 17463.21415536304, 17475.737863932052, 3751.8874433767032, 3752.155764952891, 3752.887413377603, 3756.0422092366543, 3778.527684039495, 143426.0, 144589.0, 144778.27610861984, 145199.0, 147731.0, 16463.176841157896, 16892.239849206817, 16993.32026718942, 16993.745093823603, 17009.744853827204, 31839.0, 32364.83817580897, 32467.67532324694, 32589.511157332658, 32691.346173076407, 8713.259372953244, 8901.287896968357, 8987.46075235488, 9011.324150688724, 9052.773680658036, 4014.458048163519, 4048.6153815387493, 4090.836366545305, 4097.467329247179, 4098.692598055158, 5331.253624492574, 5341.893162136736, 5376.1935709643085, 5412.458754124556, 5429.809956651498, 996.0637001218831, 1005.3766664667806, 1022.8158931392272, 1023.4115383654429, 1026.7484466305802, 670.8222321084917, 683.9418649414756, 693.7918624412656, 703.0192880931072, 703.1246098607267, 11634.0, 11840.881591183977, 12040.0, 12995.025373097056, 13345.065845390729, 681.1519658025691, 683.723092147681, 685.1264637587017, 690.7893092606803, 701.684242091061, 5525.143602741581, 5622.943770562242, 5678.829635110953, 5703.914441283384, 5815.79644712433, 126904.36547817386, 128324.0, 128343.35828320985, 129621.35189324182, 131749.0, 108331.0, 109781.45109274563, 110703.0, 113501.432492837, 115664.42167789275, 91856.0, 95503.0, 97406.0, 99546.0, 102604.53835443642, 12586.0, 12978.221306721627, 13024.153430027018, 13127.803082953573, 13344.599662010156, 42537.0, 43584.0, 45111.0, 45312.54687453083, 46327.07345853131, 56329.436705634056, 56439.0, 56761.43238567562, 58151.127733083194, 58964.410355897606, 18743.812561874205, 19120.33078842234, 19149.0, 19261.422157335302, 19347.516312091746, 19956.3015294464, 20223.19107235694, 20406.183752650322, 20454.181832726525, 20792.37622871316, 17278.740818887476, 17388.304467821144, 17414.0, 17479.47561573155, 17570.297188112334, 19506.0, 20077.799222007594, 20128.79871201328, 20175.69736453925, 20465.18139274412, 18781.812181878006, 18828.24687012559, 18907.338243161423, 19015.809841901402, 19051.90474047621, 14392.28038598045, 14694.11835289886, 14735.484258050918, 14869.553913382615, 14878.628034298796, 13917.652058698613, 14139.222342771247, 14190.219537925514, 14220.644483887985, 14226.715465690835], "value": 9372.46006826688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1420.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 108.0, 108.0, 107.0, 109.0, 109.0, 108.0, 108.0, 107.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 115.0, 116.0, 119.0, 118.0, 117.0, 116.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 164.0, 163.0, 165.0, 162.0, 170.0, 166.0, 164.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 76.0, 75.0, 75.0, 75.0, 76.0, 76.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 79.0, 78.0, 79.0, 79.0, 79.0, 81.0, 82.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 115.0, 116.0, 122.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 98.0, 99.0, 94.0, 94.0, 99.0, 94.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 51.0, 52.0, 53.0, 53.0, 55.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 39.0, 39.0, 39.0, 39.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 77.0, 76.0, 74.0, 74.0, 76.0, 74.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 118.0, 120.0, 110.0, 110.0, 117.0, 122.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 171.0, 170.0, 167.0, 168.0, 167.0, 168.0, 172.0, 165.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 66.0, 72.0, 65.0, 65.0, 72.0, 66.0, 65.0, 65.0], "value": 67.7, "unit": "score"}]}]} 10:22:37 INFO - Return code: 0 10:22:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:37 INFO - # TBPL SUCCESS # 10:22:37 INFO - Running post-action listener: _package_coverage_data 10:22:37 INFO - Running post-action listener: _resource_record_post_action 10:22:37 INFO - [mozharness: 2017-09-14 17:22:37.549246Z] Finished run-tests step (success) 10:22:37 INFO - Running post-run listener: _resource_record_post_run 10:22:37 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 333676544; Read time: 168; Write time: 190140 10:22:37 INFO - TinderboxPrint: CPU usage
13.1% 10:22:37 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 10:22:37 INFO - TinderboxPrint: I/O write bytes / time
333,676,544 / 190,140 10:22:37 INFO - TinderboxPrint: CPU idle
8,235.2 (86.9%) 10:22:37 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 10:22:37 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9859072; Read time: 0; Write time: 884 10:22:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:22:37 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323424256; Read time: 152; Write time: 189232 10:22:38 INFO - Running post-run listener: _upload_blobber_files 10:22:38 INFO - Blob upload gear active. 10:22:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:38 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 10:22:38 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'] 10:22:38 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 10:22:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:39 INFO - (blobuploader) - INFO - Done attempting. 10:22:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:46 INFO - (blobuploader) - INFO - Done attempting. 10:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:47 INFO - (blobuploader) - INFO - Done attempting. 10:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:48 INFO - (blobuploader) - INFO - Done attempting. 10:22:48 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:48 INFO - Return code: 0 10:22:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fbf0dc02dafc6a3013ac81f380bb43eefdf7ce99c857efaa543a7a6a20ce63411b1a979d8daec8d4d89a315a5eb6ae6126608d90259a1455bbc99f87a13d2502", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193b0786d611c00adeb746bcbc3fdd3e6b70b9d32e481724bad5ac5bb856fe5094b02116ec4aa42773e08aead83710cb86877c327f6de27aad5707a6c98efc44", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/955f9c3270f31c8f9e553978f6a375616c62bb99f16f1a959300c5dd6c1baae912e258447cb63d8d39bb3513cf5d554b28c531d731faa02099db398d56611c9f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aff331d25e8eb6046a09bac68a3c58d54fa500ef293a82e1d714408188a430dbc03d0a1c06026bd06ef494f749d80373995c5f42c302ab6b1adf1b09e36d0ce"} 10:22:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:48 INFO - Contents: 10:22:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fbf0dc02dafc6a3013ac81f380bb43eefdf7ce99c857efaa543a7a6a20ce63411b1a979d8daec8d4d89a315a5eb6ae6126608d90259a1455bbc99f87a13d2502", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193b0786d611c00adeb746bcbc3fdd3e6b70b9d32e481724bad5ac5bb856fe5094b02116ec4aa42773e08aead83710cb86877c327f6de27aad5707a6c98efc44", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/955f9c3270f31c8f9e553978f6a375616c62bb99f16f1a959300c5dd6c1baae912e258447cb63d8d39bb3513cf5d554b28c531d731faa02099db398d56611c9f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aff331d25e8eb6046a09bac68a3c58d54fa500ef293a82e1d714408188a430dbc03d0a1c06026bd06ef494f749d80373995c5f42c302ab6b1adf1b09e36d0ce"} 10:22:48 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:48 INFO - Copying logs to upload dir... 10:22:48 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.128776 ========= master_lag: -0.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-14 10:22:48.653564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:22:48.658724) ========= 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=ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fbf0dc02dafc6a3013ac81f380bb43eefdf7ce99c857efaa543a7a6a20ce63411b1a979d8daec8d4d89a315a5eb6ae6126608d90259a1455bbc99f87a13d2502", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193b0786d611c00adeb746bcbc3fdd3e6b70b9d32e481724bad5ac5bb856fe5094b02116ec4aa42773e08aead83710cb86877c327f6de27aad5707a6c98efc44", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/955f9c3270f31c8f9e553978f6a375616c62bb99f16f1a959300c5dd6c1baae912e258447cb63d8d39bb3513cf5d554b28c531d731faa02099db398d56611c9f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aff331d25e8eb6046a09bac68a3c58d54fa500ef293a82e1d714408188a430dbc03d0a1c06026bd06ef494f749d80373995c5f42c302ab6b1adf1b09e36d0ce"} build_url:https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fbf0dc02dafc6a3013ac81f380bb43eefdf7ce99c857efaa543a7a6a20ce63411b1a979d8daec8d4d89a315a5eb6ae6126608d90259a1455bbc99f87a13d2502", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/193b0786d611c00adeb746bcbc3fdd3e6b70b9d32e481724bad5ac5bb856fe5094b02116ec4aa42773e08aead83710cb86877c327f6de27aad5707a6c98efc44", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/955f9c3270f31c8f9e553978f6a375616c62bb99f16f1a959300c5dd6c1baae912e258447cb63d8d39bb3513cf5d554b28c531d731faa02099db398d56611c9f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aff331d25e8eb6046a09bac68a3c58d54fa500ef293a82e1d714408188a430dbc03d0a1c06026bd06ef494f749d80373995c5f42c302ab6b1adf1b09e36d0ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:22:48.689848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:22:48.690166) ========= 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=ca6c2627acea03e666270f68000001e0-1505408178.989936-910064475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:22:48.772773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:22:48.776118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:22:48.776457) ========= ========= Total master_lag: -0.47 =========